builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1452516985.39 results: success (0) buildid: 20160111023633 builduid: 61657f867a3b4a51938341a225cfa247 revision: 4791761ef641 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.388236) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.388671) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.388969) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004338 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.405581) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.405896) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.425504) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.425841) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.030848 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.474301) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.474622) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.474998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.475269) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 04:56:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 199M=0s 2016-01-11 04:56:25 (199 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.316442 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.804015) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.804325) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.040796 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:25.859046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-11 04:56:25.859590) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4791761ef641 --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 4791761ef641 --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=20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 04:56:25,968 Setting DEBUG logging. 2016-01-11 04:56:25,969 attempt 1/10 2016-01-11 04:56:25,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4791761ef641?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 04:56:26,315 unpacking tar archive at: mozilla-beta-4791761ef641/testing/mozharness/ program finished with exit code 0 elapsedTime=1.180539 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-11 04:56:27.055094) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:27.055629) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:27.066106) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:27.066514) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 04:56:27.067135) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-11 04:56:27.067621) ========= /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=20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:56:27 INFO - MultiFileLogger online at 20160111 04:56:27 in /builds/slave/test-pgo 04:56:27 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 04:56:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:56:27 INFO - {'append_to_log': False, 04:56:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:56:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:56:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:56:27 INFO - 'branch': 'Mozilla-Beta', 04:56:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:56:27 INFO - 'config_files': ('talos/linux_config.py',), 04:56:27 INFO - 'default_actions': ('clobber', 04:56:27 INFO - 'read-buildbot-config', 04:56:27 INFO - 'download-and-extract', 04:56:27 INFO - 'populate-webroot', 04:56:27 INFO - 'create-virtualenv', 04:56:27 INFO - 'install', 04:56:27 INFO - 'run-tests'), 04:56:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:56:27 INFO - 'download_minidump_stackwalk': True, 04:56:27 INFO - 'download_symbols': 'ondemand', 04:56:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:56:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:56:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:56:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:56:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:56:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:56:27 INFO - 'installer_path': 'installer.exe', 04:56:27 INFO - 'log_level': 'info', 04:56:27 INFO - 'log_name': 'talos', 04:56:27 INFO - 'log_to_console': True, 04:56:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:56:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:56:27 INFO - 'opt_config_files': (), 04:56:27 INFO - 'pip_index': False, 04:56:27 INFO - 'sps_profile': False, 04:56:27 INFO - 'sps_profile_interval': 0, 04:56:27 INFO - 'suite': 'dromaeojs', 04:56:27 INFO - 'system_bits': '32', 04:56:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:56:27 INFO - 'title': 'talos-linux64-ix-015', 04:56:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:56:27 INFO - 'use_talos_json': True, 04:56:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:56:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:56:27 INFO - 'work_dir': 'build'} 04:56:27 INFO - ##### 04:56:27 INFO - ##### Running clobber step. 04:56:27 INFO - ##### 04:56:27 INFO - Running pre-action listener: _resource_record_pre_action 04:56:27 INFO - Running main action method: clobber 04:56:27 INFO - rmtree: /builds/slave/test-pgo/build 04:56:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:56:32 INFO - Running post-action listener: _resource_record_post_action 04:56:32 INFO - ##### 04:56:32 INFO - ##### Running read-buildbot-config step. 04:56:32 INFO - ##### 04:56:32 INFO - Running pre-action listener: _resource_record_pre_action 04:56:32 INFO - Running main action method: read_buildbot_config 04:56:32 INFO - Using buildbot properties: 04:56:32 INFO - { 04:56:32 INFO - "properties": { 04:56:32 INFO - "buildnumber": 50, 04:56:32 INFO - "product": "firefox", 04:56:32 INFO - "script_repo_revision": "production", 04:56:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:56:32 INFO - "repository": "", 04:56:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:56:32 INFO - "buildid": "20160111023633", 04:56:32 INFO - "slavename": "talos-linux64-ix-015", 04:56:32 INFO - "pgo_build": "True", 04:56:32 INFO - "basedir": "/builds/slave/test-pgo", 04:56:32 INFO - "project": "", 04:56:32 INFO - "platform": "ubuntu64_hw", 04:56:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:56:32 INFO - "slavebuilddir": "test", 04:56:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:56:32 INFO - "branch": "mozilla-beta", 04:56:32 INFO - "repo_path": "releases/mozilla-beta", 04:56:32 INFO - "stage_platform": "linux64-pgo", 04:56:32 INFO - "builduid": "61657f867a3b4a51938341a225cfa247", 04:56:32 INFO - "revision": "4791761ef641" 04:56:32 INFO - }, 04:56:32 INFO - "sourcestamp": { 04:56:32 INFO - "repository": "", 04:56:32 INFO - "hasPatch": false, 04:56:32 INFO - "project": "", 04:56:32 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:56:32 INFO - "changes": [ 04:56:32 INFO - { 04:56:32 INFO - "category": null, 04:56:32 INFO - "files": [ 04:56:32 INFO - { 04:56:32 INFO - "url": null, 04:56:32 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/firefox-44.0.en-US.linux-x86_64.tar.bz2" 04:56:32 INFO - } 04:56:32 INFO - ], 04:56:32 INFO - "repository": "", 04:56:32 INFO - "rev": "4791761ef641", 04:56:32 INFO - "who": "sendchange", 04:56:32 INFO - "when": 1452516949, 04:56:32 INFO - "number": 7442563, 04:56:32 INFO - "comments": "Bug 1207424 - Remove Apps toolbar button. r=gijs a=ritu", 04:56:32 INFO - "project": "", 04:56:32 INFO - "at": "Mon 11 Jan 2016 04:55:49", 04:56:32 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:56:32 INFO - "revlink": "", 04:56:32 INFO - "properties": [ 04:56:32 INFO - [ 04:56:32 INFO - "buildid", 04:56:32 INFO - "20160111023633", 04:56:32 INFO - "Change" 04:56:32 INFO - ], 04:56:32 INFO - [ 04:56:32 INFO - "builduid", 04:56:32 INFO - "61657f867a3b4a51938341a225cfa247", 04:56:32 INFO - "Change" 04:56:32 INFO - ], 04:56:32 INFO - [ 04:56:32 INFO - "pgo_build", 04:56:32 INFO - "True", 04:56:32 INFO - "Change" 04:56:32 INFO - ] 04:56:32 INFO - ], 04:56:32 INFO - "revision": "4791761ef641" 04:56:32 INFO - } 04:56:32 INFO - ], 04:56:32 INFO - "revision": "4791761ef641" 04:56:32 INFO - } 04:56:32 INFO - } 04:56:32 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/firefox-44.0.en-US.linux-x86_64.tar.bz2. 04:56:32 INFO - Running post-action listener: _resource_record_post_action 04:56:32 INFO - ##### 04:56:32 INFO - ##### Running download-and-extract step. 04:56:32 INFO - ##### 04:56:32 INFO - Running pre-action listener: _resource_record_pre_action 04:56:32 INFO - Running main action method: download_and_extract 04:56:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:56: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')]} 04:56:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/test_packages.json 04:56:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:56:32 INFO - Downloaded 1270 bytes. 04:56:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:56:32 INFO - Using the following test package requirements: 04:56:32 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:56:32 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:56:32 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:56:32 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:56:32 INFO - u'jsshell-linux-x86_64.zip'], 04:56:32 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:56:32 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:56:32 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:56:32 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:56:32 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 04:56:32 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:56:32 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 04:56:32 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:56:32 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:56:32 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:56:32 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:56:32 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:56:32 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:56: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')]} 04:56:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:56:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/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 04:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/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 04:56:37 INFO - Downloaded 22572517 bytes. 04:56:37 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 04:56:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:56:37 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 04:56:38 INFO - Return code: 0 04:56:38 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 04:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:56:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/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 04:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/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 04:56:39 INFO - Downloaded 22572517 bytes. 04:56: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 04:56:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:56: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 04:56:41 INFO - Return code: 0 04:56: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')]} 04:56:41 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 04:56:41 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/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 04:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/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 04:56:47 INFO - Downloaded 11131970 bytes. 04:56:47 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 04:56:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 04:56:47 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 04:56:47 INFO - Return code: 0 04:56:47 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')]} 04:56:47 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:56:47 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/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 04:56:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/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 04:56:52 INFO - Downloaded 56619514 bytes. 04:56:52 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:56:52 INFO - mkdir: /builds/slave/test-pgo/properties 04:56:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:56:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:56:52 INFO - Contents: 04:56:52 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:56:52 INFO - Running post-action listener: _resource_record_post_action 04:56:52 INFO - Running post-action listener: set_extra_try_arguments 04:56:52 INFO - ##### 04:56:52 INFO - ##### Running populate-webroot step. 04:56:52 INFO - ##### 04:56:52 INFO - Running pre-action listener: _resource_record_pre_action 04:56:52 INFO - Running main action method: populate_webroot 04:56:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:56:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:56:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:56:52 INFO - '../fennec_ids.txt'], 04:56:52 INFO - 'tests': ['tcheck2']}, 04:56:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:56:52 INFO - '--tppagecycles', 04:56:52 INFO - '7'], 04:56:52 INFO - 'tests': ['tsvgm']}}, 04:56:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:56:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:56:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:56:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:56:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:56:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:56:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:52 INFO - 'talos_options': ['--e10s'], 04:56:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:52 INFO - 'tests': ['damp', 'tps']}, 04:56:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:52 INFO - 'talos_options': ['--e10s'], 04:56:52 INFO - 'tests': ['damp', 'tps']}, 04:56:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:56:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:56:52 INFO - 'other': {'tests': ['a11yr', 04:56:52 INFO - 'ts_paint', 04:56:52 INFO - 'tpaint', 04:56:52 INFO - 'sessionrestore', 04:56:52 INFO - 'sessionrestore_no_auto_restore']}, 04:56:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:56:52 INFO - 'tests': ['a11yr', 04:56:52 INFO - 'ts_paint', 04:56:52 INFO - 'tpaint', 04:56:52 INFO - 'sessionrestore', 04:56:52 INFO - 'sessionrestore_no_auto_restore']}, 04:56:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:56:52 INFO - 'tests': ['a11yr', 04:56:52 INFO - 'ts_paint', 04:56:52 INFO - 'tpaint', 04:56:52 INFO - 'sessionrestore', 04:56:52 INFO - 'sessionrestore_no_auto_restore']}, 04:56:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:56:52 INFO - 'tests': ['a11yr', 04:56:52 INFO - 'ts_paint', 04:56:52 INFO - 'tpaint', 04:56:52 INFO - 'sessionrestore', 04:56:52 INFO - 'sessionrestore_no_auto_restore']}, 04:56:52 INFO - 'other_l64': {'tests': ['a11yr', 04:56:52 INFO - 'ts_paint', 04:56:52 INFO - 'tpaint', 04:56:52 INFO - 'sessionrestore', 04:56:52 INFO - 'sessionrestore_no_auto_restore']}, 04:56:52 INFO - 'other_nol64': {'tests': ['a11yr', 04:56:52 INFO - 'ts_paint', 04:56:52 INFO - 'tpaint', 04:56:52 INFO - 'sessionrestore', 04:56:52 INFO - 'sessionrestore_no_auto_restore']}, 04:56:52 INFO - 'svgr': {'tests': ['tsvgx', 04:56:52 INFO - 'tsvgr_opacity', 04:56:52 INFO - 'tart', 04:56:52 INFO - 'tscrollx', 04:56:52 INFO - 'cart']}, 04:56:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:56:52 INFO - 'tests': ['tsvgx', 04:56:52 INFO - 'tsvgr_opacity', 04:56:52 INFO - 'tart', 04:56:52 INFO - 'tscrollx', 04:56:52 INFO - 'cart']}, 04:56:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:52 INFO - 'tests': ['tp5o']}, 04:56:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:52 INFO - 'talos_options': ['--e10s'], 04:56:52 INFO - 'tests': ['tp5o']}, 04:56:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:52 INFO - 'talos_options': ['--xperf_path', 04:56:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:52 INFO - 'tests': ['tp5n']}, 04:56:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:52 INFO - 'talos_options': ['--e10s', 04:56:52 INFO - '--xperf_path', 04:56:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:52 INFO - 'tests': ['tp5n']}}, 04:56:52 INFO - 'talos.zip': {'path': '', 04:56:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:56:52 INFO - Running post-action listener: _resource_record_post_action 04:56:52 INFO - ##### 04:56:52 INFO - ##### Running create-virtualenv step. 04:56:52 INFO - ##### 04:56:52 INFO - Running pre-action listener: _resource_record_pre_action 04:56:52 INFO - Running main action method: create_virtualenv 04:56:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:56:52 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 04:56:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:56:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:56:52 INFO - Using real prefix '/usr' 04:56:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:56:52 INFO - Installing distribute.............................................................................................................................................................................................done. 04:56:54 INFO - Installing pip.................done. 04:56:54 INFO - Return code: 0 04:56:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:56:54 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')]} 04:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:54 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')]} 04:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:54 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 0x7f61a0b62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2234350>, '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 0x2235250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22356e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', '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 04:56:54 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 04:56:54 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 04:56:54 INFO - Using env: {'DISPLAY': ':0', 04:56:54 INFO - 'HOME': '/home/cltbld', 04:56:54 INFO - 'LANG': 'en_US.UTF-8', 04:56:54 INFO - 'LANGUAGE': 'en_US:en', 04:56:54 INFO - 'LOGNAME': 'cltbld', 04:56:54 INFO - 'MAIL': '/var/mail/cltbld', 04:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:54 INFO - 'MOZ_NO_REMOTE': '1', 04:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:54 INFO - 'NO_EM_RESTART': '1', 04:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:56:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:56:54 INFO - 'SHELL': '/bin/bash', 04:56:54 INFO - 'SHLVL': '1', 04:56:54 INFO - 'TERM': 'linux', 04:56:54 INFO - 'TMOUT': '86400', 04:56:54 INFO - 'USER': 'cltbld', 04:56:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', 04:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:54 INFO - '_': '/tools/buildbot/bin/python'} 04:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:54 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 04:56:54 INFO - Cleaning up... 04:56:54 INFO - Return code: 0 04:56:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:56:54 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')]} 04:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:54 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')]} 04:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:54 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 0x7f61a0b62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2234350>, '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 0x2235250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22356e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', '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 04:56:54 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 04:56:54 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 04:56:54 INFO - Using env: {'DISPLAY': ':0', 04:56:54 INFO - 'HOME': '/home/cltbld', 04:56:54 INFO - 'LANG': 'en_US.UTF-8', 04:56:54 INFO - 'LANGUAGE': 'en_US:en', 04:56:54 INFO - 'LOGNAME': 'cltbld', 04:56:54 INFO - 'MAIL': '/var/mail/cltbld', 04:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:54 INFO - 'MOZ_NO_REMOTE': '1', 04:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:54 INFO - 'NO_EM_RESTART': '1', 04:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:56:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:56:54 INFO - 'SHELL': '/bin/bash', 04:56:54 INFO - 'SHLVL': '1', 04:56:54 INFO - 'TERM': 'linux', 04:56:54 INFO - 'TMOUT': '86400', 04:56:54 INFO - 'USER': 'cltbld', 04:56:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', 04:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:54 INFO - '_': '/tools/buildbot/bin/python'} 04:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:55 INFO - Downloading/unpacking psutil>=0.7.1 04:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:56:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:56:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:56:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:56 INFO - Installing collected packages: psutil 04:56:56 INFO - Running setup.py install for psutil 04:56:57 INFO - building 'psutil._psutil_linux' extension 04:56:57 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 04:56:57 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 04:56:57 INFO - building 'psutil._psutil_posix' extension 04:56:57 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 04:56:57 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 04:56:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:57 INFO - Successfully installed psutil 04:56:57 INFO - Cleaning up... 04:56:57 INFO - Return code: 0 04:56:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f61a0b62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2234350>, '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 0x2235250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22356e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', '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 04:56:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:56:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:56:57 INFO - Using env: {'DISPLAY': ':0', 04:56:57 INFO - 'HOME': '/home/cltbld', 04:56:57 INFO - 'LANG': 'en_US.UTF-8', 04:56:57 INFO - 'LANGUAGE': 'en_US:en', 04:56:57 INFO - 'LOGNAME': 'cltbld', 04:56:57 INFO - 'MAIL': '/var/mail/cltbld', 04:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:57 INFO - 'MOZ_NO_REMOTE': '1', 04:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:57 INFO - 'NO_EM_RESTART': '1', 04:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:56:57 INFO - 'PWD': '/builds/slave/test-pgo', 04:56:57 INFO - 'SHELL': '/bin/bash', 04:56:57 INFO - 'SHLVL': '1', 04:56:57 INFO - 'TERM': 'linux', 04:56:57 INFO - 'TMOUT': '86400', 04:56:57 INFO - 'USER': 'cltbld', 04:56:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', 04:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:57 INFO - '_': '/tools/buildbot/bin/python'} 04:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:56:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:56:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:56:59 INFO - Installing collected packages: mozsystemmonitor 04:56:59 INFO - Running setup.py install for mozsystemmonitor 04:56:59 INFO - Successfully installed mozsystemmonitor 04:56:59 INFO - Cleaning up... 04:56:59 INFO - Return code: 0 04:56:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:59 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 0x7f61a0b62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2234350>, '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 0x2235250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22356e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', '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 04:56:59 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 04:56:59 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 04:56:59 INFO - Using env: {'DISPLAY': ':0', 04:56:59 INFO - 'HOME': '/home/cltbld', 04:56:59 INFO - 'LANG': 'en_US.UTF-8', 04:56:59 INFO - 'LANGUAGE': 'en_US:en', 04:56:59 INFO - 'LOGNAME': 'cltbld', 04:56:59 INFO - 'MAIL': '/var/mail/cltbld', 04:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:59 INFO - 'MOZ_NO_REMOTE': '1', 04:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:59 INFO - 'NO_EM_RESTART': '1', 04:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:56:59 INFO - 'PWD': '/builds/slave/test-pgo', 04:56:59 INFO - 'SHELL': '/bin/bash', 04:56:59 INFO - 'SHLVL': '1', 04:56:59 INFO - 'TERM': 'linux', 04:56:59 INFO - 'TMOUT': '86400', 04:56:59 INFO - 'USER': 'cltbld', 04:56:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', 04:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:59 INFO - '_': '/tools/buildbot/bin/python'} 04:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:57:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:57:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:57:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:02 INFO - Downloading docopt-0.6.1.tar.gz 04:57:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:57:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:57:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:57:02 INFO - Running setup.py install for blobuploader 04:57:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:57:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:57:02 INFO - Running setup.py install for requests 04:57:02 INFO - Running setup.py install for docopt 04:57:02 INFO - Successfully installed blobuploader requests docopt 04:57:02 INFO - Cleaning up... 04:57:02 INFO - Return code: 0 04:57:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:02 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 0x7f61a0b62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2234350>, '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 0x2235250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22356e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', '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 04:57:02 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 04:57:02 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 04:57:02 INFO - Using env: {'DISPLAY': ':0', 04:57:02 INFO - 'HOME': '/home/cltbld', 04:57:02 INFO - 'LANG': 'en_US.UTF-8', 04:57:02 INFO - 'LANGUAGE': 'en_US:en', 04:57:02 INFO - 'LOGNAME': 'cltbld', 04:57:02 INFO - 'MAIL': '/var/mail/cltbld', 04:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:02 INFO - 'MOZ_NO_REMOTE': '1', 04:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:02 INFO - 'NO_EM_RESTART': '1', 04:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:02 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:02 INFO - 'SHELL': '/bin/bash', 04:57:02 INFO - 'SHLVL': '1', 04:57:02 INFO - 'TERM': 'linux', 04:57:02 INFO - 'TMOUT': '86400', 04:57:02 INFO - 'USER': 'cltbld', 04:57:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', 04:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:02 INFO - '_': '/tools/buildbot/bin/python'} 04:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:03 INFO - Running setup.py (path:/tmp/pip-LfrYTn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:03 INFO - Running setup.py (path:/tmp/pip-BVHuMz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:03 INFO - Running setup.py (path:/tmp/pip-jUx8N_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:03 INFO - Running setup.py (path:/tmp/pip-muDG7S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:03 INFO - Running setup.py (path:/tmp/pip-0SpjHh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:03 INFO - Running setup.py (path:/tmp/pip-edNhNZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:03 INFO - Running setup.py (path:/tmp/pip-lTpzSk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:03 INFO - Running setup.py (path:/tmp/pip-UqQyxE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:03 INFO - Running setup.py (path:/tmp/pip-xZLRdT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:03 INFO - Running setup.py (path:/tmp/pip-ZBgrs3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:03 INFO - Running setup.py (path:/tmp/pip-9PpWfW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:03 INFO - Running setup.py (path:/tmp/pip-EtoeUu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:03 INFO - Running setup.py (path:/tmp/pip-skc5NC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:03 INFO - Running setup.py (path:/tmp/pip-hrAwHI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:04 INFO - Running setup.py (path:/tmp/pip-QixCsD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:04 INFO - Running setup.py (path:/tmp/pip-4waC5k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:04 INFO - Running setup.py (path:/tmp/pip-wMBpBf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:57:04 INFO - Running setup.py install for manifestparser 04:57:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:57:04 INFO - Running setup.py install for mozcrash 04:57:04 INFO - Running setup.py install for mozdebug 04:57:04 INFO - Running setup.py install for mozdevice 04:57:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:57:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:57:04 INFO - Running setup.py install for mozfile 04:57:04 INFO - Running setup.py install for mozhttpd 04:57:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:57:04 INFO - Running setup.py install for mozinfo 04:57:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:57:04 INFO - Running setup.py install for mozInstall 04:57:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:57:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:57:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:57:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:57:05 INFO - Running setup.py install for mozleak 04:57:05 INFO - Running setup.py install for mozlog 04:57:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:57:05 INFO - Running setup.py install for moznetwork 04:57:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:57:05 INFO - Running setup.py install for mozprocess 04:57:05 INFO - Running setup.py install for mozprofile 04:57:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:57:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:57:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:57:05 INFO - Running setup.py install for mozrunner 04:57:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:57:05 INFO - Running setup.py install for mozscreenshot 04:57:05 INFO - Running setup.py install for moztest 04:57:05 INFO - Running setup.py install for mozversion 04:57:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:57:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:57:05 INFO - Cleaning up... 04:57:06 INFO - Return code: 0 04:57:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:06 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 0x7f61a0b62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2234350>, '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 0x2235250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22356e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', '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 04:57:06 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 04:57:06 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 04:57:06 INFO - Using env: {'DISPLAY': ':0', 04:57:06 INFO - 'HOME': '/home/cltbld', 04:57:06 INFO - 'LANG': 'en_US.UTF-8', 04:57:06 INFO - 'LANGUAGE': 'en_US:en', 04:57:06 INFO - 'LOGNAME': 'cltbld', 04:57:06 INFO - 'MAIL': '/var/mail/cltbld', 04:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:06 INFO - 'MOZ_NO_REMOTE': '1', 04:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:06 INFO - 'NO_EM_RESTART': '1', 04:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:06 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:06 INFO - 'SHELL': '/bin/bash', 04:57:06 INFO - 'SHLVL': '1', 04:57:06 INFO - 'TERM': 'linux', 04:57:06 INFO - 'TMOUT': '86400', 04:57:06 INFO - 'USER': 'cltbld', 04:57:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', 04:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:06 INFO - '_': '/tools/buildbot/bin/python'} 04:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:06 INFO - Running setup.py (path:/tmp/pip-yNBZ8V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:06 INFO - Running setup.py (path:/tmp/pip-AaRwYC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:06 INFO - Running setup.py (path:/tmp/pip-aR7EvU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:06 INFO - Running setup.py (path:/tmp/pip-__mpMM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:06 INFO - Running setup.py (path:/tmp/pip-Tj2Fni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:06 INFO - Running setup.py (path:/tmp/pip-NMiLbi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:06 INFO - Running setup.py (path:/tmp/pip-geSwr4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:06 INFO - Running setup.py (path:/tmp/pip-S4VdbJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:06 INFO - Running setup.py (path:/tmp/pip-fxlXJC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:06 INFO - Running setup.py (path:/tmp/pip-9QkLsI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:06 INFO - Running setup.py (path:/tmp/pip-hpmXnu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:07 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)) 04:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:07 INFO - Running setup.py (path:/tmp/pip-SI6WW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:07 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)) 04:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:07 INFO - Running setup.py (path:/tmp/pip-700Cja-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:07 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)) 04:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:07 INFO - Running setup.py (path:/tmp/pip-1ne2Mr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:07 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)) 04:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:07 INFO - Running setup.py (path:/tmp/pip-vksbwv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:07 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)) 04:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:07 INFO - Running setup.py (path:/tmp/pip-RIZ21a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:07 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)) 04:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:07 INFO - Running setup.py (path:/tmp/pip-w45PO5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:07 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)) 04:57:07 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)) 04:57:07 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)) 04:57:07 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)) 04:57:07 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)) 04:57:07 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)) 04:57:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:09 INFO - Downloading blessings-1.5.1.tar.gz 04:57:09 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 04:57:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:57:09 INFO - Installing collected packages: blessings 04:57:09 INFO - Running setup.py install for blessings 04:57:09 INFO - Successfully installed blessings 04:57:09 INFO - Cleaning up... 04:57:09 INFO - Return code: 0 04:57:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:57:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:57:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:57:09 INFO - Reading from file tmpfile_stdout 04:57:09 INFO - Current package versions: 04:57:09 INFO - argparse == 1.2.1 04:57:09 INFO - blessings == 1.5.1 04:57:09 INFO - blobuploader == 1.2.4 04:57:09 INFO - docopt == 0.6.1 04:57:09 INFO - manifestparser == 1.1 04:57:09 INFO - mozInstall == 1.12 04:57:09 INFO - mozcrash == 0.16 04:57:09 INFO - mozdebug == 0.1 04:57:09 INFO - mozdevice == 0.46 04:57:09 INFO - mozfile == 1.2 04:57:09 INFO - mozhttpd == 0.7 04:57:09 INFO - mozinfo == 0.8 04:57:09 INFO - mozleak == 0.1 04:57:09 INFO - mozlog == 3.0 04:57:09 INFO - moznetwork == 0.27 04:57:09 INFO - mozprocess == 0.22 04:57:09 INFO - mozprofile == 0.27 04:57:09 INFO - mozrunner == 6.11 04:57:09 INFO - mozscreenshot == 0.1 04:57:09 INFO - mozsystemmonitor == 0.0 04:57:09 INFO - moztest == 0.7 04:57:09 INFO - mozversion == 1.4 04:57:09 INFO - psutil == 3.1.1 04:57:09 INFO - requests == 1.2.3 04:57:09 INFO - wsgiref == 0.1.2 04:57:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:57: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')]} 04:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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')]} 04:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f61a0b62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2234350>, '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 0x2235250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22356e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', '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 04:57:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 04:57:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 04:57:09 INFO - Using env: {'DISPLAY': ':0', 04:57:09 INFO - 'HOME': '/home/cltbld', 04:57:09 INFO - 'LANG': 'en_US.UTF-8', 04:57:09 INFO - 'LANGUAGE': 'en_US:en', 04:57:09 INFO - 'LOGNAME': 'cltbld', 04:57:09 INFO - 'MAIL': '/var/mail/cltbld', 04:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:09 INFO - 'MOZ_NO_REMOTE': '1', 04:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:09 INFO - 'NO_EM_RESTART': '1', 04:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:09 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:09 INFO - 'SHELL': '/bin/bash', 04:57:09 INFO - 'SHLVL': '1', 04:57:09 INFO - 'TERM': 'linux', 04:57:09 INFO - 'TMOUT': '86400', 04:57:09 INFO - 'USER': 'cltbld', 04:57:09 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', 04:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:09 INFO - '_': '/tools/buildbot/bin/python'} 04:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:09 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)) 04:57:09 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)) 04:57:09 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)) 04:57:09 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)) 04:57:09 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)) 04:57:09 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)) 04:57:09 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)) 04:57:09 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)) 04:57:09 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)) 04:57:09 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)) 04:57:09 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)) 04:57:09 INFO - Cleaning up... 04:57:09 INFO - Return code: 0 04:57:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:57: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')]} 04:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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')]} 04:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f61a0b62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2234350>, '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 0x2235250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22356e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', '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 04:57:09 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 04:57:09 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 04:57:09 INFO - Using env: {'DISPLAY': ':0', 04:57:09 INFO - 'HOME': '/home/cltbld', 04:57:09 INFO - 'LANG': 'en_US.UTF-8', 04:57:09 INFO - 'LANGUAGE': 'en_US:en', 04:57:09 INFO - 'LOGNAME': 'cltbld', 04:57:09 INFO - 'MAIL': '/var/mail/cltbld', 04:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:09 INFO - 'MOZ_NO_REMOTE': '1', 04:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:09 INFO - 'NO_EM_RESTART': '1', 04:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:09 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:09 INFO - 'SHELL': '/bin/bash', 04:57:09 INFO - 'SHLVL': '1', 04:57:09 INFO - 'TERM': 'linux', 04:57:09 INFO - 'TMOUT': '86400', 04:57:09 INFO - 'USER': 'cltbld', 04:57:09 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', 04:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:09 INFO - '_': '/tools/buildbot/bin/python'} 04:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:10 INFO - Downloading/unpacking jsonschema 04:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:57:11 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 04:57:11 INFO - Downloading/unpacking functools32 (from jsonschema) 04:57:11 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 04:57:11 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 04:57:11 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 04:57:11 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 04:57:11 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 04:57:11 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 04:57:11 INFO - Downloading functools32-3.2.3-2.tar.gz 04:57:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:57:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:57:11 INFO - warning: no files found matching '*.txt' 04:57:11 INFO - no previously-included directories found matching 'build' 04:57:11 INFO - no previously-included directories found matching 'dist' 04:57:11 INFO - no previously-included directories found matching '.git*' 04:57:12 INFO - Installing collected packages: jsonschema, functools32 04:57:12 INFO - Running setup.py install for functools32 04:57:12 INFO - warning: no files found matching '*.txt' 04:57:12 INFO - no previously-included directories found matching 'build' 04:57:12 INFO - no previously-included directories found matching 'dist' 04:57:12 INFO - no previously-included directories found matching '.git*' 04:57:12 INFO - Successfully installed jsonschema functools32 04:57:12 INFO - Cleaning up... 04:57:12 INFO - Return code: 0 04:57:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:57: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')]} 04:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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')]} 04:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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', '--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 0x7f61a0b62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2234350>, '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 0x2235250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22356e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', '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 04:57:12 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 04:57:12 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 04:57:12 INFO - Using env: {'DISPLAY': ':0', 04:57:12 INFO - 'HOME': '/home/cltbld', 04:57:12 INFO - 'LANG': 'en_US.UTF-8', 04:57:12 INFO - 'LANGUAGE': 'en_US:en', 04:57:12 INFO - 'LOGNAME': 'cltbld', 04:57:12 INFO - 'MAIL': '/var/mail/cltbld', 04:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:12 INFO - 'MOZ_NO_REMOTE': '1', 04:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:12 INFO - 'NO_EM_RESTART': '1', 04:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:12 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:12 INFO - 'SHELL': '/bin/bash', 04:57:12 INFO - 'SHLVL': '1', 04:57:12 INFO - 'TERM': 'linux', 04:57:12 INFO - 'TMOUT': '86400', 04:57:12 INFO - 'USER': 'cltbld', 04:57:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', 04:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:12 INFO - '_': '/tools/buildbot/bin/python'} 04:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:12 INFO - Downloading/unpacking flake8 04:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:57:14 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 04:57:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:57:14 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 04:57:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:14 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 04:57:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:57:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:57:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:57:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:57:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:57:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:57:14 INFO - no previously-included directories found matching 'docs/_build' 04:57:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:57:14 INFO - Running setup.py install for pep8 04:57:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:57:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:57:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:57:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:57:15 INFO - no previously-included directories found matching 'docs/_build' 04:57:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:57:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:57:15 INFO - Cleaning up... 04:57:15 INFO - Return code: 0 04:57:15 INFO - Running post-action listener: _resource_record_post_action 04:57:15 INFO - Running post-action listener: _start_resource_monitoring 04:57:15 INFO - Starting resource monitoring. 04:57:15 INFO - ##### 04:57:15 INFO - ##### Running install step. 04:57:15 INFO - ##### 04:57:15 INFO - Running pre-action listener: _resource_record_pre_action 04:57:15 INFO - Running main action method: install 04:57:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:57:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:57:15 INFO - Reading from file tmpfile_stdout 04:57:15 INFO - Detecting whether we're running mozinstall >=1.0... 04:57:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:57:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:57:15 INFO - Reading from file tmpfile_stdout 04:57:15 INFO - Output received: 04:57:15 INFO - Usage: mozinstall [options] installer 04:57:15 INFO - Options: 04:57:15 INFO - -h, --help show this help message and exit 04:57:15 INFO - -d DEST, --destination=DEST 04:57:15 INFO - Directory to install application into. [default: 04:57:15 INFO - "/builds/slave/test-pgo"] 04:57:15 INFO - --app=APP Application being installed. [default: firefox] 04:57:15 INFO - mkdir: /builds/slave/test-pgo/build/application 04:57:15 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'] 04:57:15 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 04:57:29 INFO - Reading from file tmpfile_stdout 04:57:29 INFO - Output received: 04:57:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:57:29 INFO - Running post-action listener: _resource_record_post_action 04:57:29 INFO - ##### 04:57:29 INFO - ##### Running run-tests step. 04:57:29 INFO - ##### 04:57:29 INFO - Running pre-action listener: _resource_record_pre_action 04:57:29 INFO - Running main action method: run_tests 04:57:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:57:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:57:29 INFO - Python 2.7.3 04:57:29 INFO - Return code: 0 04:57:29 INFO - grabbing minidump binary from tooltool 04:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:29 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 0x2234350>, '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 0x2235250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22356e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:57:29 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 04:57:29 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 04:57:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:57:29 INFO - Return code: 0 04:57:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:57:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:57:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:57:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:57:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:57:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:57:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:57:30 INFO - Return code: 0 04:57:30 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/1452508593/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:57:30 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/1452508593/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost 04:57:30 INFO - Using env: {'DISPLAY': ':0', 04:57:30 INFO - 'HOME': '/home/cltbld', 04:57:30 INFO - 'LANG': 'en_US.UTF-8', 04:57:30 INFO - 'LANGUAGE': 'en_US:en', 04:57:30 INFO - 'LOGNAME': 'cltbld', 04:57:30 INFO - 'MAIL': '/var/mail/cltbld', 04:57:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:57:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:30 INFO - 'MOZ_NO_REMOTE': '1', 04:57:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:30 INFO - 'NO_EM_RESTART': '1', 04:57:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:57:30 INFO - 'SHELL': '/bin/bash', 04:57:30 INFO - 'SHLVL': '1', 04:57:30 INFO - 'TERM': 'linux', 04:57:30 INFO - 'TMOUT': '86400', 04:57:30 INFO - 'USER': 'cltbld', 04:57:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353', 04:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:30 INFO - '_': '/tools/buildbot/bin/python'} 04:57:30 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/1452508593/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] with output_timeout 3600 04:57:30 INFO - mozversion INFO | application_buildid: 20160111023633 04:57:30 INFO - mozversion INFO | application_changeset: 4791761ef641fb9b94f11b5c658226db4220e946 04:57:30 INFO - mozversion INFO | application_display_name: Nightly 04:57:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:57:30 INFO - mozversion INFO | application_name: Firefox 04:57:30 INFO - mozversion INFO | application_remotingname: firefox 04:57:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:57:30 INFO - mozversion INFO | application_vendor: Mozilla 04:57:30 INFO - mozversion INFO | application_version: 44.0 04:57:30 INFO - mozversion INFO | platform_buildid: 20160111023633 04:57:30 INFO - mozversion INFO | platform_changeset: 4791761ef641fb9b94f11b5c658226db4220e946 04:57:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:57:30 INFO - mozversion INFO | platform_version: 44.0 04:57:30 INFO - 2016-01-11 04:57:30,829 DEBUG : using testdate: 1452517050 04:57:30 INFO - 2016-01-11 04:57:30,829 DEBUG : actual date: 1452517050 04:57:30 INFO - 2016-01-11 04:57:30,839 INFO : starting webserver on 'localhost:36506' 04:57:30 INFO - 2016-01-11 04:57:30,840 INFO : Starting test suite talos-linux64-ix-015 04:57:30 INFO - 2016-01-11 04:57:30,840 INFO : Starting test dromaeo_css 04:57:30 INFO - 2016-01-11 04:57:30,840 DEBUG : operating with platform_type : linux_ 04:57:30 INFO - 2016-01-11 04:57:30,841 INFO : Initialising browser for dromaeo_css test... 04:57:30 INFO - 2016-01-11 04:57:30,857 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM7whuM/profile http://localhost:36506/getInfo.html 04:57:34 INFO - 2016-01-11 04:57:34,579 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:57:34 INFO - 2016-01-11 04:57:34,579 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:57:34 INFO - 2016-01-11 04:57:34,579 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:57:34 INFO - 2016-01-11 04:57:34,579 DEBUG : BROWSER_OUTPUT: __metrics 04:57:34 INFO - 2016-01-11 04:57:34,741 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] 04:57:35 INFO - 2016-01-11 04:57:35,825 INFO : Browser initialized. 04:57:35 INFO - 2016-01-11 04:57:35,826 INFO : Running cycle 1/1 for dromaeo_css test... 04:57:35 INFO - 2016-01-11 04:57:35,826 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM7whuM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:57:47 INFO - 2016-01-11 04:57:47,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 129269760 04:57:47 INFO - 2016-01-11 04:57:47,401 DEBUG : BROWSER_OUTPUT: 04:58:38 INFO - 2016-01-11 04:58:38,399 DEBUG : BROWSER_OUTPUT: 1452517118395 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] 05:00:46 INFO - 2016-01-11 05:00:46,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36506/tests/dromaeo/cssquery-ext.html) 05:00:47 INFO - 2016-01-11 05:00:47,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 238256128 05:00:47 INFO - 2016-01-11 05:00:47,239 DEBUG : BROWSER_OUTPUT: 05:03:49 INFO - 2016-01-11 05:03:49,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/dromaeo/cssquery-ext.html (next: http://localhost:36506/tests/dromaeo/cssquery-jquery.html) 05:03:49 INFO - 2016-01-11 05:03:49,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 205475840 05:03:49 INFO - 2016-01-11 05:03:49,874 DEBUG : BROWSER_OUTPUT: 05:06:51 INFO - 2016-01-11 05:06:51,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36506/tests/dromaeo/cssquery-mootools.html) 05:06:52 INFO - 2016-01-11 05:06:52,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 203579392 05:06:52 INFO - 2016-01-11 05:06:52,094 DEBUG : BROWSER_OUTPUT: 05:09:53 INFO - 2016-01-11 05:09:53,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36506/tests/dromaeo/cssquery-prototype.html) 05:09:54 INFO - 2016-01-11 05:09:54,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 191291392 05:09:54 INFO - 2016-01-11 05:09:54,313 DEBUG : BROWSER_OUTPUT: 05:12:56 INFO - 2016-01-11 05:12:56,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36506/tests/dromaeo/cssquery-yui.html) 05:12:57 INFO - 2016-01-11 05:12:57,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 194568192 05:12:57 INFO - 2016-01-11 05:12:57,137 DEBUG : BROWSER_OUTPUT: 05:15:59 INFO - 2016-01-11 05:15:59,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/dromaeo/cssquery-yui.html (next: http://localhost:36506/tests/dromaeo/cssquery-dojo.html) 05:15:59 INFO - 2016-01-11 05:15:59,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 238493696 05:15:59 INFO - 2016-01-11 05:15:59,569 DEBUG : BROWSER_OUTPUT: 05:15:59 INFO - 2016-01-11 05:15:59,569 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:15:59 INFO - 2016-01-11 05:15:59,569 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:15:59 INFO - 2016-01-11 05:15:59,569 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:15:59 INFO - 2016-01-11 05:15:59,569 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:15:59 INFO - 2016-01-11 05:15:59,569 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3209.8074115553063;3281.34373125375;3305.3885031269215;3313.1551454379146;3323.700866921977;5468.7539060742265;5472.808451704186;5533.280673512443;5551.583631227654;5559.916601250974;5566.192902029204;5619.943800561993;5625.9029489249615;5630.09918413054;5641.943580564203;5001.8249361272365;5040.546350828425;5092.032513822381;5118.718470484122;5204.505571970657;4953.950460495403;5005.724685142316;5068.4171320298265;5083.949160508403;5134.717590532519;5137.691738495702;5203.947960520403;5208.609354298424;5215.869603259911;5231.372235331765;4886.584640305578;4994.975025124888;5126.154184559543;5146.768395422215;5202.08963431398;4881.438634557;4991.900161996776;5005.899882002376;5008.348914641109;5014.821516943515;5393.7303134843105;5486.451354864522;5494;5522.585806064521;5549.805756798533;5882.088276317135;5900.881982360329;6035.637861728311;6049.909251361233;6065.090236464565;6023.036314189709;6036.305824830113;6052.243469566304;6054.969725151346;6087.939120608781;5626.071698169797;5627.324721033461;5628.774849005994;5632;5635.464630860103;5949.672767997802;6024.849378765478;6046.565041766711;6108.297545782292;6136.202293701879;5902.822915312548;5951.940480595225;5953.940460595425;5961.5230781537375;5977.163197152402;6052.455279024909;6065.332813390523;6066.696665166724;6069.696515174223;6071.666058366833;5848.707564621752;5909.143174239711;5985.880282394328;6006.459418652343;6013.729382177812;5990.430909063632;6053.092036194518;6059.121427393004;6059.787907423307;6061.818145455643;4544.091181763594;4654.790534425959;4656.883577910579;4667.859964201011;4676.766161691902;4045.3122969095325;4095.2219078375015;4112.444819949328;4127.112670775738;4132.648724858421;5715.8571035724435;5759.452851979056;5771.797987070432;5774.595778295563;5780.479756821906;5874.353821079678;5998.100284957204;6063.575549711478;6082.695865206722;6085.604435711664;5639.605227634026;5730.169125476783;5735.397783232784;5736.13957906309;5743;5267.894642107136;5289.418164001957;5293.708846013506;5296.682199068068;5303.337082864642;6051.243594550681;6147.354527774609;6243.937560624427;6258.43674069336;6274.874502510015;5938.138969849434;6010.7295171716505;6023.969880150571;6027.57806953509;6050.364711705383;6132.172156758959;6226.862838158447;6236.126942228001;6250.874982500233;6259.906101408574;5702.230198923258;5795.710214489343;5798.33319168301;5977.954983538397;5985.102234664835;6069;6097.878042439038;6107.389261073857;6120.632762034292;6129.08063790435;5911.349751527243;5947.405259474191;5949.3753155918;5949.851253718692;5955.464008239279;5676.318841739017;5797.391273916178;5802.82591522255;5936.554758393051;5937.020391635332;5803.912941305968;5811.186433899173;5817.563682723728;5822.534197264124;5827.5337972961215;5926.407359264039;5942.465178133989;5947.6431414115295;5968.582199246185;5971.462568368867;5546.861328466659;5676.063449530781;5726.455986681259;5808.82573522795;5837.824865254049 05:15:59 INFO - 2016-01-11 05:15:59,569 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.6628356128105;609.3206075226122;624.6720471752329;641.224118816232;642.5502148496054;36710.816445917764;42882.57117428825;42933;42950;43042.35436468456;47734.76132619341;47906.281405778944;47970.28044579334;48014.519854801445;48823;8314.625841837102;8454;9362.578683959238;9560.04399560042;10707.518161682705;11067.557297708083;11096.722581935475;11172.944135279313;11193.66419007427;11210.551577936872;11158;11222.551097956071;11261.774764504706;11264.267822591546;11278.097752179807;11123.72190695231;11155;11222.66332010041;11224.326540407601;11226.270292431007;10994.780104397947;11116.888831111666;11118.833217501744;11121.110311175167;11127.72180695481;46423.5357646426;46640;46693.29960050602;46986.29520557194;47043.76478117587;3667.7982710950887;4226.387173859804;4284.121755040209;4319.805608747614;4398.834308908142;34310.485342719876;34621.13447163841;34844;34948.82525587381;34972.47541286883;3678.886347976315;3762.6049264827348;3763.49192858966;3843.13529455873;3849.0377405648587;313250;313952;314064;314280;315723.99999999773;59601;60646.393536064956;68109.65945170341;69276;69586.65206673935;72643;72801.71982801783;73014.26985730181;73232;73636;17933;18151.81848181501;18168.909155454403;18202.271909123752;18260.452186434428;13582.59252222435;13737.450501979809;13768.036237463282;13772.173669579857;13778.517751878637;22274.109035638718;22287.331380058626;22433.887830560743;22573.4356641082;22609.4347641307;8472.491650500866;8741.737747867573;8859.734207973772;8886.73339799807;8947.865782013276;1038.3977293169944;1071.5445935477392;1087.3149915553151;1091.8307662312354;1215.562397536886;30274.394512110073;30724.53913191304;30785.538216926765;30828.87059387769;31647.683523164935;1081.6863109698256;1089.7057794395628;1092.126298960828;1155.058627218814;1157.4097210422576;13784.517541885985;14333.426662933365;14426.783598246035;14801.111933284037;15308.234588270765;386145;392153;392733;392741;393251;60709.30633498362;60939.39060609337;60984.085238721455;61007;61054.38945610576;1258.5091814192472;1435.9641008974859;1525.1306755149458;1533.2487081330069;1546.0646308983128;27942.720572794824;27985.860070699517;28499.572506412005;28760.280992974505;30736;56066.43933560612;57552.13671794843;57626.4237357621;57703.1344529824;57808.4219157803;256430;257376;258421;259259;259504;37427.625723742414;38160.80919595384;38271.6172838268;38272.42591361188;38725;50567.74716126396;51038.489615103375;51216;51728.48271517387;52113.7394313026;41917.161656767305;41931.580684193985;42092;42247.366289505066;43444.782776085915;42433;42521.36217956671;42777;43231.78384108059;43265.35101973536;40129.1974160521;40463.797681011405;41560;41583.37624935689;41649.1670166601;37594.24811503809;38491.535761781575;38710;38722.80638596789;38831.2233755329;27691.44617107687;27692.307692307855;27733;28159;28180 05:15:59 INFO - 2016-01-11 05:15:59,571 DEBUG : BROWSER_OUTPUT: |2;jquery.html;386.175515274888;388.9202713443744;389.8128898128898;393.4806056006073;394.11914371379976;14619;18236.635267294663;20780.272690455837;20794.89602551987;21733.565328693418;19482.4155275342;19803.50491237716;20540.69188962163;20769.169233230652;20789.896050519765;5711.171880077386;5846.678432686201;5863.853403664921;5865.560082993771;5867.3252575953675;5963.582549221556;6025.0661147522205;6984.720611175547;7186.748463803768;7246.782596522113;4583.793729282191;6823.112995310603;7236.891446628305;7239.89140162898;7243.456740744439;7092.822679433056;7306.415486761046;7317.0487836580905;7318.304761047719;7319.048523691913;6937.306269373073;6938.202106757737;6949.5135340526185;6956.20003699576;6956.826079348057;22994.540109197722;25292.87353563239;25424.49151016988;26181.476370472676;26810.865945670343;2414.6860908082012;2464.827462077655;2473.0355161487037;2509.109266210487;2533.4553071089804;15491.302891369915;15801.288941997638;15915.522534323989;16245.593860153473;16282.83717162825;2137.8931053447263;2156.9352919412445;2167;2168.826493880486;2232.084845213471;74771.62614186894;76394.23605763927;78184.60907695425;78390.60804695997;78524;17710.291588336324;17849.553761156076;17999.910000450174;18054.458366249033;18075.276988920297;28345;28386.574201386997;28626.713732862405;28691.56962645562;28726.569101463494;10072.345297555636;10263.332883362558;10384.636537721144;10388.844167337496;10445.791084178274;8736.301095912311;8742.737717868475;8799.032106468283;8828.646854125891;8894.911050889537;8880.467171969702;8985.775355616162;9053.637854485878;9080.682176123804;9083.863742043875;2204.239537359608;3333.300006998509;3336.6663333666925;3365.5120007599253;3380.543626610376;515.6596646213482;518.4892880512692;527.614841165951;531.3835950297636;562.9690367029852;12403.511049420275;13253.722468597516;13409.597712068653;13500.93249533746;13724.107932984323;533.9652922560099;536.369765525506;544.281548356166;546.7239044282612;549.2667289169004;6772.322767723188;7004.754833580801;7145.39264162552;7313.744018959311;7459.589722565311;574989;575573;615054;647475;648071;69851;77551.22448775553;83830.5808470966;86300;87250;614.4531367083299;620.5532016947791;622.0762168180248;623.4482483002485;624.372505631837;11727.824082638937;11916.702082448008;11935.52257909674;12015.219010764273;12072.698182545506;35521;35973.46039809353;38960;39956.600433995285;40260.59739402569;52517;53043.20435193552;53765.46234537604;54467.72766136144;54854.45145548653;7572.242775722384;7710.421718371257;7717.151113377637;7727.690892364468;7737.535747855147;13329;13796.103253288504;13891.166530008231;13953.790693139408;14183.787243191568;12181.208221465577;12232.571859984857;12360.505579777067;12441.688957776129;12595.055370847407;11813.291202527877;11962.940185299018;12293.56972505958;12328.321942292901;12487.625371238877;11906.880931190577;12434.564790232298;12539.87460125387;12556.497740090294;12679.93660031694;7804.375649948104;7837.333826624801;7924.48490848093;7937.166597507178;7941.285284324438;11947.402629868646;12002.879971200176;12222.938885305517;12460.190087644636;12464.314462704639 05:15:59 INFO - 2016-01-11 05:15:59,572 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1595.9361625534973;1602.6714523522678;1864.878782879112;1890.5084677983725;1892.2336453736236;6775.08536347593;6863.897041544368;6869.416099631525;6880.518363714542;6891.724331026766;8165.91834081659;8214.507129572215;8220.671173153067;8227.712030078934;8240.95879520603;2378.5005148918704;2380.5238952209543;2396.676448679423;2400.31590996566;2424.078850036992;2378.2984019714227;2394.5330660521204;2399.6760437341;2414.710234771821;2421.5278020785954;2086.09254974086;2141.496748264157;2301.735300440446;2331.5919714049974;2335.708036495438;2251.3808702606916;2266.784655457729;2268.6710426988075;2271.250487339182;2274.1585613323177;2309.7690230976937;2388.36708272308;2388.5700573896693;2388.581998150334;2389.7371289158177;7157.642117894085;7301;7882.211778822129;8004.199580042007;8028.799280017988;5122.948770512285;5210.088234558975;5211.062008838408;5213.478652134794;5215.3741551013745;3431.7083047940955;3462.6191118976894;3475.4613034979366;3497.265574229415;3498.3353162898966;1114.3425379026332;1185.6443067079929;1205.9879401206051;1230.9569165079179;1252.3237451776122;11099.556017759362;11131.554737810478;11142.164337674707;11156.497957591846;11165.609203677832;4592.127495775859;4596.839110631112;4640.466346370143;4719.032598317337;4719.480857105716;9696.563654635558;9704.757381065388;9705.9029409705;9715.0770676787;9716.854247186298;5148.124818780816;5166.483351664879;5172.922406163911;5176.637635365489;5179.48205179479;4685.601723853442;4698.694584851974;4718.197906355927;4718.363020992191;4720.575148236675;3881.2819628368843;3893.922121557553;3923.705722070856;3951.980240098781;3954.5847685992558;1295.6307452376216;1300.1873828856965;1305.2560040776857;1309.2798960571647;1314.1589382795019;1178.5462596900254;1187.1867770577182;1204.277433539869;1434.96412589684;1452.0053763172261;7731.806704832424;7771.766846994599;7798.142204357516;7855.921440785633;7864.056313242333;563.3099453169834;566.4052744618134;566.6090397625625;567.3503838105429;567.8722287485283;5896.410358964155;5981.581289309794;6282.340354262737;6330.430261276507;6339.11252424661;9620.278479114095;9847.655332063343;9850.113489785954;9881.160101391319;9884.654037108667;9500.857487137699;9713.70858874235;9799.657012004545;9865.309428339948;9874.901250987541;7536.321731044232;7544.8491030180185;7588.051493563305;7603.847923041508;7612.923870761332;7585.127710313384;7643.503172293783;7683.500572462772;7695.268949449794;7705.730299439493;8568.271696905833;8660.047394786443;8701.260392866678;8743.431676940978;8752.47485150893;8613.65545378178;8796.47221166732;8797;8842.602082906413;8884.067172946747;7177.3899218567;7184.1738200105565;7254.782356529313;7262.636868156676;7272;8065.314448271963;8114.229148230908;8116.634751436081;8120.553369564731;8124;7435.665395057344;7467.551946883204;7535.886961695689;7558.659860306409;7640.923590764021;7410.5183163094225;7423.294786995227;7452.664630091551;7539.0576177977755;7599.658015389431;7642.5032372895585;7681.116671582616;7688.46180767341;7692.19231980634;7698.345640620386;6918.654067296716;6942.201646810681;6945.756898508528;6946.930530694831;6957.512974091765;7008.929910700827;7139;7142.857142857218;7144.071270734771;7145.428365730625 05:15:59 INFO - 2016-01-11 05:15:59,573 DEBUG : BROWSER_OUTPUT: |4;prototype.html;367.5424096999236;370.30752492838394;370.96846768024716;374.6085340818844;377.2699825837005;6017.127516510103;6023.1868697725795;6044.395560443953;6055.122007308938;6062.393760623935;5750.568707346944;5812.157237200603;5819.621724587899;5923.200367950325;5950.464458198761;4629.259318509039;4635.721856688592;4638.9072218555775;4644.674872758908;4676.906461870761;4628.143793398232;4628.861134165981;4638.512956139607;4639.443266807988;4640.118377508279;4568.725876447407;4586.1744885920525;4594.471635761896;4598.379218805452;4599.678022538424;4518.932216016762;4587.72473651582;4591.540845915415;4597.839075632371;4607.493175750665;4043.130726893732;4050.5746896576024;4057.6348128668265;4059.8579049733116;4067.5118985721606;5717.514011309002;5720.771169153229;5726.484616384504;5730.885382292331;5734.97132514339;5261.905706015334;5317.601179911522;5321.760520776575;5338.893222135574;5340.279062326575;6339.746410143589;6363.713632886531;6365.2679941806355;6374.553781235269;6377.202849643794;4541.182587134314;4544.772761361952;4545.11370282795;4546.772661366951;4554.453465584118;6517.641529715864;6578.440832529241;6591.637459939701;6595.6372399518;6595.769148079842;4534.410526631516;4592.2422800238255;4600.861974140781;4612.423447069116;4618.237990731492;4669.626429885601;4673.766311684402;4675.462321833033;4676.929846052312;4680.251159814414;5336.146216605324;5339.46605339463;5340.439253878365;5341.5192632662465;5345.812896548602;6293.465055470337;6294.181756371734;6296.685165741695;6297.748090076438;6305.5901366411035;1654.619437529351;1693.314207745865;1694.9152542372833;1695.4235559909444;1706.7695861058598;1048.627737153315;1092.9344239345664;1140.3613976173203;1143.9656810295705;1151.5278735718316;6097.298810636745;6119.204503414617;6120.14317995481;6120.1737765401995;6129.080637904261;6432.421082102634;6435.646039467874;6437.710303036374;6438;6439.452646525004;5981.551383646244;6024.969875150597;6108.511319094462;6113.083037544404;6118.694065296718;3554.3957527220437;3578.6421357864524;3581.3732596795458;3582.6954708849516;3585.4801053847045;6724.394804467622;6754.966225168941;6757.155355580552;6760.560563563353;6764.864702705919;6566.606003639797;6673.299303573055;6680.665966701646;6682.0311054896765;6689.632070236184;6749.730010799612;6753.763618273435;6756.425703815133;6760.7295708172105;6762.594244345355;6517.120188774645;6525.510586706111;6527.05357723118;6533.150690410216;6533.41199292066;6350.460210882126;6426.646534440651;6448.161738973903;6456.192975878015;6456.9354306456335;6718.7312507499155;6739.0902228198565;6740.966295168689;6761.966190169018;6765.255821859493;4595.494495605548;4602.562756538124;4603.447586289667;4608.585227329557;4617.58441740245;6436.259830119409;6526.412622863775;6537.346265373425;6539.280679125388;6560.803175904731;6374.07575901501;6374.840628984312;6407.743690252338;6422.133012043314;6426.485881129405;6331.651759153291;6332.2717887441695;6333.1766870306565;6336.651484168415;6343.4608058313715;6210.5652604319075;6288.1825362704385;6289.496840252677;6301.6219026858535;6305.747770089145;6384.9042264367;6387.457066149429;6392.424681778476;6392.456641185366;6393.392627700361;6268.404501572343;6274.027525733519;6274.121622972879;6274.466670333073;6277.874442511215 05:15:59 INFO - 2016-01-11 05:15:59,574 DEBUG : BROWSER_OUTPUT: |5;yui.html;815.844989452004;819.0376307838288;836.1805430677932;881.7751473374288;957.549951522784;14370.784438233435;15017.24913754312;16143.83856161438;16160.595985100379;16184.838151618465;15063;15157.469488567902;15184.696306073873;15184.924075379635;15195.924020379882;792.2117493094379;809.6518497046268;938.0713094036888;944.0512285153411;961.4375590279694;961.5240455974302;962.5043102802063;969.365065881845;970.7718686108759;971.0871780526282;817.5094943034192;999.0409207161134;1008.2085562833178;1009.7122320138762;1010.4139599032543;829.3862541719114;967.5839389062701;993.8459538771502;994.6767300627253;1005.6932635546192;730.5032577847062;732.9450291228126;733.3253406865697;733.5232099135551;733.5488674465219;15093;15324.846751532565;15367;15369.001014933994;15391.538253852403;13982.860171398257;14034.719305613933;14059.929700351433;14146.929265353607;14287.857121428757;11204.943975280072;11241.213115081948;11385.544578216945;11457.828132578017;11482.368469734161;3876.9030774230587;3899.317619416619;3921.941170882439;3983;3989.880303590897;51245.487545124444;51374.74312628413;52974.205386919224;52984;53034.20448693273;9116.544172791333;9236.353455258068;9337.673181438753;9435.198008169382;11264.774704505864;13523.715247051514;13662.385192666354;13680.863191368158;13693.863061369259;13922.443102275998;7604.505707129019;7628.847423051508;7745.264199901;7765.7281995131025;8024.398170137263;4747.786349614275;4795.352627395257;4828.758562071953;4840.273958906122;4870.732109733999;3083.5066389377594;3094.659587445379;3097.1173215633885;3099.1477343730653;3101.1006808025872;476.27368263398597;486.60098719050745;487.25450061406104;487.5636305506552;487.57337329836395;628.6452694443482;632.705791806812;670.9060731497594;682.8224661587924;721.3075447570391;8645.3948223625;9689.12797848197;9733.367331123454;9813.852792208123;9868.457234852152;662.1458318768734;668.4251543672437;683.3883674111742;725.2421219825189;748.7304570354668;4160.375943608423;4211.87364379063;4267.0825772459075;4285.335772955197;4376.431063961664;66287.66856165785;66382.66808665925;66995;67460.32539674541;68903.65548172226;60462;60504.69747651234;61310;61394.69302653458;61690;53740;53853.73073134609;53871.46128538743;55710.16434753482;56249;8923.107689231025;8930.464172149692;9009.459432434074;9046.185843273874;9126.49804260772;39281.214375712894;39790.40314395229;40502.392464113655;41126;41242.1751564973;51357;52098.73950630223;52882.735586321825;52903;53840.19239711486;8829.779255518664;9251.167394934218;9297.190851993886;9362;9387.389819661701;13263.86736132665;13375.331233438095;13632.591022269347;13688.041837071309;13735.107218030797;11198.410638340316;12122;12312.692182695504;12849.87150128524;13279.734405312032;12511;12528.87471125277;12696;12704.555340563036;12942.93528532389;11256.268342557707;12069.336186509827;12272.551680418312;13075.934620326838;13095.083344165816;10626.203034772578;10791.838122428013;11352.318860868374;11464.885351146715;11550.306981581132;10896.346219226873;10942.914282319887;11115.610953616584;11220;11316.377599231791 05:15:59 INFO - 2016-01-11 05:15:59,574 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:15:59 INFO - 2016-01-11 05:15:59,574 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:15:59 INFO - 2016-01-11 05:15:59,575 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,840 05:15:59 INFO - 2016-01-11 05:15:59,575 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:15:59 INFO - 2016-01-11 05:15:59,575 DEBUG : BROWSER_OUTPUT: __startTimestamp1452518159562__endTimestamp 05:15:59 INFO - 2016-01-11 05:15:59,575 DEBUG : BROWSER_OUTPUT: 05:15:59 INFO - 2016-01-11 05:15:59,575 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:15:59 INFO - 2016-01-11 05:15:59,575 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:15:59 INFO - 2016-01-11 05:15:59,575 DEBUG : BROWSER_OUTPUT: 05:15:59 INFO - 2016-01-11 05:15:59,575 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5582.10 Median:5798.33 stddev:632.66 (10.9%) stddev-sans-first:606.61 05:15:59 INFO - 2016-01-11 05:15:59,575 DEBUG : BROWSER_OUTPUT: Values: 3209.8 3281.3 3305.4 3313.2 3323.7 5468.8 5472.8 5533.3 5551.6 5559.9 5566.2 5619.9 5625.9 5630.1 5641.9 5001.8 5040.5 5092.0 5118.7 5204.5 4954.0 5005.7 5068.4 5083.9 5134.7 5137.7 5203.9 5208.6 5215.9 5231.4 4886.6 4995.0 5126.2 5146.8 5202.1 4881.4 4991.9 5005.9 5008.3 5014.8 5393.7 5486.5 5494.0 5522.6 5549.8 5882.1 5900.9 6035.6 6049.9 6065.1 6023.0 6036.3 6052.2 6055.0 6087.9 5626.1 5627.3 5628.8 5632.0 5635.5 5949.7 6024.8 6046.6 6108.3 6136.2 5902.8 5951.9 5953.9 5961.5 5977.2 6052.5 6065.3 6066.7 6069.7 6071.7 5848.7 5909.1 5985.9 6006.5 6013.7 5990.4 6053.1 6059.1 6059.8 6061.8 4544.1 4654.8 4656.9 4667.9 4676.8 4045.3 4095.2 4112.4 4127.1 4132.6 5715.9 5759.5 5771.8 5774.6 5780.5 5874.4 5998.1 6063.6 6082.7 6085.6 5639.6 5730.2 5735.4 5736.1 5743.0 5267.9 5289.4 5293.7 5296.7 5303.3 6051.2 6147.4 6243.9 6258.4 6274.9 5938.1 6010.7 6024.0 6027.6 6050.4 6132.2 6226.9 6236.1 6250.9 6259.9 5702.2 5795.7 5798.3 5978.0 5985.1 6069.0 6097.9 6107.4 6120.6 6129.1 5911.3 5947.4 5949.4 5949.9 5955.5 5676.3 5797.4 5802.8 5936.6 5937.0 5803.9 5811.2 5817.6 5822.5 5827.5 5926.4 5942.5 5947.6 5968.6 5971.5 5546.9 5676.1 5726.5 5808.8 5837.8 05:15:59 INFO - 2016-01-11 05:15:59,575 DEBUG : BROWSER_OUTPUT: 05:15:59 INFO - 2016-01-11 05:15:59,575 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52153.34 Median:20678.43 stddev:85250.99 (412.3%) stddev-sans-first:85402.15 05:15:59 INFO - 2016-01-11 05:15:59,577 DEBUG : BROWSER_OUTPUT: Values: 566.7 609.3 624.7 641.2 642.6 36710.8 42882.6 42933.0 42950.0 43042.4 47734.8 47906.3 47970.3 48014.5 48823.0 8314.6 8454.0 9362.6 9560.0 10707.5 11067.6 11096.7 11172.9 11193.7 11210.6 11158.0 11222.6 11261.8 11264.3 11278.1 11123.7 11155.0 11222.7 11224.3 11226.3 10994.8 11116.9 11118.8 11121.1 11127.7 46423.5 46640.0 46693.3 46986.3 47043.8 3667.8 4226.4 4284.1 4319.8 4398.8 34310.5 34621.1 34844.0 34948.8 34972.5 3678.9 3762.6 3763.5 3843.1 3849.0 313250.0 313952.0 314064.0 314280.0 315724.0 59601.0 60646.4 68109.7 69276.0 69586.7 72643.0 72801.7 73014.3 73232.0 73636.0 17933.0 18151.8 18168.9 18202.3 18260.5 13582.6 13737.5 13768.0 13772.2 13778.5 22274.1 22287.3 22433.9 22573.4 22609.4 8472.5 8741.7 8859.7 8886.7 8947.9 1038.4 1071.5 1087.3 1091.8 1215.6 30274.4 30724.5 30785.5 30828.9 31647.7 1081.7 1089.7 1092.1 1155.1 1157.4 13784.5 14333.4 14426.8 14801.1 15308.2 386145.0 392153.0 392733.0 392741.0 393251.0 60709.3 60939.4 60984.1 61007.0 61054.4 1258.5 1436.0 1525.1 1533.2 1546.1 27942.7 27985.9 28499.6 28760.3 30736.0 56066.4 57552.1 57626.4 57703.1 57808.4 256430.0 257376.0 258421.0 259259.0 259504.0 37427.6 38160.8 38271.6 38272.4 38725.0 50567.7 51038.5 51216.0 51728.5 52113.7 41917.2 41931.6 42092.0 42247.4 43444.8 42433.0 42521.4 42777.0 43231.8 43265.4 40129.2 40463.8 41560.0 41583.4 41649.2 37594.2 38491.5 38710.0 38722.8 38831.2 27691.4 27692.3 27733.0 28159.0 28180.0 05:15:59 INFO - 2016-01-11 05:15:59,577 DEBUG : BROWSER_OUTPUT: 05:15:59 INFO - 2016-01-11 05:15:59,577 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32551.90 Median:19676.74 stddev:100177.23 (509.1%) stddev-sans-first:100429.14 05:15:59 INFO - 2016-01-11 05:15:59,577 DEBUG : BROWSER_OUTPUT: Values: 386.2 388.9 389.8 393.5 394.1 14619.0 18236.6 20780.3 20794.9 21733.6 19482.4 19803.5 20540.7 20769.2 20789.9 5711.2 5846.7 5863.9 5865.6 5867.3 5963.6 6025.1 6984.7 7186.7 7246.8 4583.8 6823.1 7236.9 7239.9 7243.5 7092.8 7306.4 7317.0 7318.3 7319.0 6937.3 6938.2 6949.5 6956.2 6956.8 22994.5 25292.9 25424.5 26181.5 26810.9 2414.7 2464.8 2473.0 2509.1 2533.5 15491.3 15801.3 15915.5 16245.6 16282.8 2137.9 2156.9 2167.0 2168.8 2232.1 74771.6 76394.2 78184.6 78390.6 78524.0 17710.3 17849.6 17999.9 18054.5 18075.3 28345.0 28386.6 28626.7 28691.6 28726.6 10072.3 10263.3 10384.6 10388.8 10445.8 8736.3 8742.7 8799.0 8828.6 8894.9 8880.5 8985.8 9053.6 9080.7 9083.9 2204.2 3333.3 3336.7 3365.5 3380.5 515.7 518.5 527.6 531.4 563.0 12403.5 13253.7 13409.6 13500.9 13724.1 534.0 536.4 544.3 546.7 549.3 6772.3 7004.8 7145.4 7313.7 7459.6 574989.0 575573.0 615054.0 647475.0 648071.0 69851.0 77551.2 83830.6 86300.0 87250.0 614.5 620.6 622.1 623.4 624.4 11727.8 11916.7 11935.5 12015.2 12072.7 35521.0 35973.5 38960.0 39956.6 40260.6 52517.0 53043.2 53765.5 54467.7 54854.5 7572.2 7710.4 7717.2 7727.7 7737.5 13329.0 13796.1 13891.2 13953.8 14183.8 12181.2 12232.6 12360.5 12441.7 12595.1 11813.3 11962.9 12293.6 12328.3 12487.6 11906.9 12434.6 12539.9 12556.5 12679.9 7804.4 7837.3 7924.5 7937.2 7941.3 11947.4 12002.9 12222.9 12460.2 12464.3 05:15:59 INFO - 2016-01-11 05:15:59,577 DEBUG : BROWSER_OUTPUT: 05:15:59 INFO - 2016-01-11 05:15:59,577 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5746.03 Median:6819.49 stddev:2950.11 (43.3%) stddev-sans-first:2941.90 05:15:59 INFO - 2016-01-11 05:15:59,577 DEBUG : BROWSER_OUTPUT: Values: 1595.9 1602.7 1864.9 1890.5 1892.2 6775.1 6863.9 6869.4 6880.5 6891.7 8165.9 8214.5 8220.7 8227.7 8241.0 2378.5 2380.5 2396.7 2400.3 2424.1 2378.3 2394.5 2399.7 2414.7 2421.5 2086.1 2141.5 2301.7 2331.6 2335.7 2251.4 2266.8 2268.7 2271.3 2274.2 2309.8 2388.4 2388.6 2388.6 2389.7 7157.6 7301.0 7882.2 8004.2 8028.8 5122.9 5210.1 5211.1 5213.5 5215.4 3431.7 3462.6 3475.5 3497.3 3498.3 1114.3 1185.6 1206.0 1231.0 1252.3 11099.6 11131.6 11142.2 11156.5 11165.6 4592.1 4596.8 4640.5 4719.0 4719.5 9696.6 9704.8 9705.9 9715.1 9716.9 5148.1 5166.5 5172.9 5176.6 5179.5 4685.6 4698.7 4718.2 4718.4 4720.6 3881.3 3893.9 3923.7 3952.0 3954.6 1295.6 1300.2 1305.3 1309.3 1314.2 1178.5 1187.2 1204.3 1435.0 1452.0 7731.8 7771.8 7798.1 7855.9 7864.1 563.3 566.4 566.6 567.4 567.9 5896.4 5981.6 6282.3 6330.4 6339.1 9620.3 9847.7 9850.1 9881.2 9884.7 9500.9 9713.7 9799.7 9865.3 9874.9 7536.3 7544.8 7588.1 7603.8 7612.9 7585.1 7643.5 7683.5 7695.3 7705.7 8568.3 8660.0 8701.3 8743.4 8752.5 8613.7 8796.5 8797.0 8842.6 8884.1 7177.4 7184.2 7254.8 7262.6 7272.0 8065.3 8114.2 8116.6 8120.6 8124.0 7435.7 7467.6 7535.9 7558.7 7640.9 7410.5 7423.3 7452.7 7539.1 7599.7 7642.5 7681.1 7688.5 7692.2 7698.3 6918.7 6942.2 6945.8 6946.9 6957.5 7008.9 7139.0 7142.9 7144.1 7145.4 05:15:59 INFO - 2016-01-11 05:15:59,577 DEBUG : BROWSER_OUTPUT: 05:15:59 INFO - 2016-01-11 05:15:59,577 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5330.01 Median:6058.76 stddev:1570.79 (25.9%) stddev-sans-first:1530.40 05:15:59 INFO - 2016-01-11 05:15:59,579 DEBUG : BROWSER_OUTPUT: Values: 367.5 370.3 371.0 374.6 377.3 6017.1 6023.2 6044.4 6055.1 6062.4 5750.6 5812.2 5819.6 5923.2 5950.5 4629.3 4635.7 4638.9 4644.7 4676.9 4628.1 4628.9 4638.5 4639.4 4640.1 4568.7 4586.2 4594.5 4598.4 4599.7 4518.9 4587.7 4591.5 4597.8 4607.5 4043.1 4050.6 4057.6 4059.9 4067.5 5717.5 5720.8 5726.5 5730.9 5735.0 5261.9 5317.6 5321.8 5338.9 5340.3 6339.7 6363.7 6365.3 6374.6 6377.2 4541.2 4544.8 4545.1 4546.8 4554.5 6517.6 6578.4 6591.6 6595.6 6595.8 4534.4 4592.2 4600.9 4612.4 4618.2 4669.6 4673.8 4675.5 4676.9 4680.3 5336.1 5339.5 5340.4 5341.5 5345.8 6293.5 6294.2 6296.7 6297.7 6305.6 1654.6 1693.3 1694.9 1695.4 1706.8 1048.6 1092.9 1140.4 1144.0 1151.5 6097.3 6119.2 6120.1 6120.2 6129.1 6432.4 6435.6 6437.7 6438.0 6439.5 5981.6 6025.0 6108.5 6113.1 6118.7 3554.4 3578.6 3581.4 3582.7 3585.5 6724.4 6755.0 6757.2 6760.6 6764.9 6566.6 6673.3 6680.7 6682.0 6689.6 6749.7 6753.8 6756.4 6760.7 6762.6 6517.1 6525.5 6527.1 6533.2 6533.4 6350.5 6426.6 6448.2 6456.2 6456.9 6718.7 6739.1 6741.0 6762.0 6765.3 4595.5 4602.6 4603.4 4608.6 4617.6 6436.3 6526.4 6537.3 6539.3 6560.8 6374.1 6374.8 6407.7 6422.1 6426.5 6331.7 6332.3 6333.2 6336.7 6343.5 6210.6 6288.2 6289.5 6301.6 6305.7 6384.9 6387.5 6392.4 6392.5 6393.4 6268.4 6274.0 6274.1 6274.5 6277.9 05:15:59 INFO - 2016-01-11 05:15:59,579 DEBUG : BROWSER_OUTPUT: 05:15:59 INFO - 2016-01-11 05:15:59,579 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15422.55 Median:486.93 stddev:18626.81 (3825.4%) stddev-sans-first:18646.77 05:15:59 INFO - 2016-01-11 05:15:59,579 DEBUG : BROWSER_OUTPUT: Values: 815.8 819.0 836.2 881.8 957.5 14370.8 15017.2 16143.8 16160.6 16184.8 15063.0 15157.5 15184.7 15184.9 15195.9 792.2 809.7 938.1 944.1 961.4 961.5 962.5 969.4 970.8 971.1 817.5 999.0 1008.2 1009.7 1010.4 829.4 967.6 993.8 994.7 1005.7 730.5 732.9 733.3 733.5 733.5 15093.0 15324.8 15367.0 15369.0 15391.5 13982.9 14034.7 14059.9 14146.9 14287.9 11204.9 11241.2 11385.5 11457.8 11482.4 3876.9 3899.3 3921.9 3983.0 3989.9 51245.5 51374.7 52974.2 52984.0 53034.2 9116.5 9236.4 9337.7 9435.2 11264.8 13523.7 13662.4 13680.9 13693.9 13922.4 7604.5 7628.8 7745.3 7765.7 8024.4 4747.8 4795.4 4828.8 4840.3 4870.7 3083.5 3094.7 3097.1 3099.1 3101.1 476.3 486.6 487.3 487.6 487.6 628.6 632.7 670.9 682.8 721.3 8645.4 9689.1 9733.4 9813.9 9868.5 662.1 668.4 683.4 725.2 748.7 4160.4 4211.9 4267.1 4285.3 4376.4 66287.7 66382.7 66995.0 67460.3 68903.7 60462.0 60504.7 61310.0 61394.7 61690.0 53740.0 53853.7 53871.5 55710.2 56249.0 8923.1 8930.5 9009.5 9046.2 9126.5 39281.2 39790.4 40502.4 41126.0 41242.2 51357.0 52098.7 52882.7 52903.0 53840.2 8829.8 9251.2 9297.2 9362.0 9387.4 13263.9 13375.3 13632.6 13688.0 13735.1 11198.4 12122.0 12312.7 12849.9 13279.7 12511.0 12528.9 12696.0 12704.6 12942.9 11256.3 12069.3 12272.6 13075.9 13095.1 10626.2 10791.8 11352.3 11464.9 11550.3 10896.3 10942.9 11115.6 11220.0 11316.4 05:15:59 INFO - 2016-01-11 05:15:59,579 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:15:59 INFO - 2016-01-11 05:15:59,579 DEBUG : BROWSER_OUTPUT: 05:16:00 INFO - 2016-01-11 05:16:00,113 INFO : Browser exited with error code: 0 05:16:00 INFO - 2016-01-11 05:16:00,129 INFO : Completed test dromaeo_css (00:18:29) 05:16:00 INFO - 2016-01-11 05:16:00,129 INFO : Starting test kraken 05:16:00 INFO - 2016-01-11 05:16:00,129 DEBUG : operating with platform_type : linux_ 05:16:00 INFO - 2016-01-11 05:16:00,129 INFO : Initialising browser for kraken test... 05:16:00 INFO - 2016-01-11 05:16:00,136 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSAZ0_d/profile http://localhost:36506/getInfo.html 05:16:03 INFO - 2016-01-11 05:16:03,398 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:16:03 INFO - 2016-01-11 05:16:03,398 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:16:03 INFO - 2016-01-11 05:16:03,398 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:16:03 INFO - 2016-01-11 05:16:03,398 DEBUG : BROWSER_OUTPUT: __metrics 05:16:03 INFO - 2016-01-11 05:16:03,523 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] 05:16:04 INFO - 2016-01-11 05:16:04,645 INFO : Browser initialized. 05:16:04 INFO - 2016-01-11 05:16:04,646 INFO : Running cycle 1/1 for kraken test... 05:16:04 INFO - 2016-01-11 05:16:04,646 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSAZ0_d/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:16:16 INFO - 2016-01-11 05:16:16,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 128913408 05:16:16 INFO - 2016-01-11 05:16:16,209 DEBUG : BROWSER_OUTPUT: 05:16:18 INFO - 2016-01-11 05:16:18,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36506/tests/kraken/driver.html?testName=audio-beat-detection) 05:16:19 INFO - 2016-01-11 05:16:19,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 162631680 05:16:19 INFO - 2016-01-11 05:16:19,210 DEBUG : BROWSER_OUTPUT: 05:16:21 INFO - 2016-01-11 05:16:21,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36506/tests/kraken/driver.html?testName=audio-dft) 05:16:22 INFO - 2016-01-11 05:16:22,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 160243712 05:16:22 INFO - 2016-01-11 05:16:22,301 DEBUG : BROWSER_OUTPUT: 05:16:25 INFO - 2016-01-11 05:16:25,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36506/tests/kraken/driver.html?testName=audio-fft) 05:16:25 INFO - 2016-01-11 05:16:25,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 156729344 05:16:25 INFO - 2016-01-11 05:16:25,625 DEBUG : BROWSER_OUTPUT: 05:16:27 INFO - 2016-01-11 05:16:27,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36506/tests/kraken/driver.html?testName=audio-oscillator) 05:16:28 INFO - 2016-01-11 05:16:28,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 156663808 05:16:28 INFO - 2016-01-11 05:16:28,143 DEBUG : BROWSER_OUTPUT: 05:16:30 INFO - 2016-01-11 05:16:30,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36506/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:16:30 INFO - 2016-01-11 05:16:30,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 154988544 05:16:30 INFO - 2016-01-11 05:16:30,818 DEBUG : BROWSER_OUTPUT: 05:16:33 INFO - 2016-01-11 05:16:33,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36506/tests/kraken/driver.html?testName=imaging-darkroom) 05:16:34 INFO - 2016-01-11 05:16:34,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 155131904 05:16:34 INFO - 2016-01-11 05:16:34,245 DEBUG : BROWSER_OUTPUT: 05:16:37 INFO - 2016-01-11 05:16:37,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36506/tests/kraken/driver.html?testName=imaging-desaturate) 05:16:38 INFO - 2016-01-11 05:16:38,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 157827072 05:16:38 INFO - 2016-01-11 05:16:38,160 DEBUG : BROWSER_OUTPUT: 05:16:40 INFO - 2016-01-11 05:16:40,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36506/tests/kraken/driver.html?testName=json-parse-financial) 05:16:41 INFO - 2016-01-11 05:16:41,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 155750400 05:16:41 INFO - 2016-01-11 05:16:41,447 DEBUG : BROWSER_OUTPUT: 05:16:42 INFO - 2016-01-11 05:16:42,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36506/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:16:43 INFO - 2016-01-11 05:16:43,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 160567296 05:16:43 INFO - 2016-01-11 05:16:43,524 DEBUG : BROWSER_OUTPUT: 05:16:45 INFO - 2016-01-11 05:16:45,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36506/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:16:45 INFO - 2016-01-11 05:16:45,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 160288768 05:16:45 INFO - 2016-01-11 05:16:45,837 DEBUG : BROWSER_OUTPUT: 05:16:47 INFO - 2016-01-11 05:16:47,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36506/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:16:48 INFO - 2016-01-11 05:16:48,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 163889152 05:16:48 INFO - 2016-01-11 05:16:48,356 DEBUG : BROWSER_OUTPUT: 05:16:50 INFO - 2016-01-11 05:16:50,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36506/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:16:51 INFO - 2016-01-11 05:16:51,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 168775680 05:16:51 INFO - 2016-01-11 05:16:51,209 DEBUG : BROWSER_OUTPUT: 05:16:53 INFO - 2016-01-11 05:16:53,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36506/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:16:54 INFO - 2016-01-11 05:16:54,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 163454976 05:16:54 INFO - 2016-01-11 05:16:54,201 DEBUG : BROWSER_OUTPUT: 05:16:55 INFO - 2016-01-11 05:16:55,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36506/tests/kraken/driver.html?testName=ai-astar) 05:16:56 INFO - 2016-01-11 05:16:56,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 225083392 05:16:56 INFO - 2016-01-11 05:16:56,060 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,061 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:16:56 INFO - 2016-01-11 05:16:56,062 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:16:56 INFO - 2016-01-11 05:16:56,062 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:16:56 INFO - 2016-01-11 05:16:56,062 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:16:56 INFO - 2016-01-11 05:16:56,062 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;103;109;110;109;100;109;100;107 05:16:56 INFO - 2016-01-11 05:16:56,063 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;121;142;155;123;147;154;124;163;122 05:16:56 INFO - 2016-01-11 05:16:56,063 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;158;160;160;161;160;162;161;158 05:16:56 INFO - 2016-01-11 05:16:56,063 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;70;71;143;71;70;70;72;153;71 05:16:56 INFO - 2016-01-11 05:16:56,063 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;89;131;88;89;89;140;88;90;129 05:16:56 INFO - 2016-01-11 05:16:56,064 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;111;109;110;109;110;110;109;109 05:16:56 INFO - 2016-01-11 05:16:56,064 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;146;147;147;146;147;146;146;146 05:16:56 INFO - 2016-01-11 05:16:56,064 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;96;96;96;96;97;95 05:16:56 INFO - 2016-01-11 05:16:56,064 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;55;55;55;57;55;57;55;53;55 05:16:56 INFO - 2016-01-11 05:16:56,065 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;64;64;63;64;63;64;63;64 05:16:56 INFO - 2016-01-11 05:16:56,065 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;77;77;78;78;78;77;78;78;77 05:16:56 INFO - 2016-01-11 05:16:56,065 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;111;113;114;107;114;113;112;108;114;106 05:16:56 INFO - 2016-01-11 05:16:56,065 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;140;135;139;137;135;147;134;136;135 05:16:56 INFO - 2016-01-11 05:16:56,065 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;60;61;64;61;61;61;64;61;62;62 05:16:56 INFO - 2016-01-11 05:16:56,065 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:16:56 INFO - 2016-01-11 05:16:56,065 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:16:56 INFO - 2016-01-11 05:16:56,066 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,865 05:16:56 INFO - 2016-01-11 05:16:56,066 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:16:56 INFO - 2016-01-11 05:16:56,066 DEBUG : BROWSER_OUTPUT: __startTimestamp1452518216060__endTimestamp 05:16:56 INFO - 2016-01-11 05:16:56,066 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,066 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:16:56 INFO - 2016-01-11 05:16:56,066 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:16:56 INFO - 2016-01-11 05:16:56,066 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,066 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.60 Median:109.00 stddev:4.09 (3.8%) stddev-sans-first:4.30 05:16:56 INFO - 2016-01-11 05:16:56,067 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 103.0 109.0 110.0 109.0 100.0 109.0 100.0 107.0 05:16:56 INFO - 2016-01-11 05:16:56,067 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,067 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.80 Median:147.00 stddev:15.92 (10.8%) stddev-sans-first:16.67 05:16:56 INFO - 2016-01-11 05:16:56,068 DEBUG : BROWSER_OUTPUT: Values: 147.0 121.0 142.0 155.0 123.0 147.0 154.0 124.0 163.0 122.0 05:16:56 INFO - 2016-01-11 05:16:56,068 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,068 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 05:16:56 INFO - 2016-01-11 05:16:56,068 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 158.0 160.0 160.0 161.0 160.0 162.0 161.0 158.0 05:16:56 INFO - 2016-01-11 05:16:56,068 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,069 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.10 Median:70.50 stddev:32.72 (46.4%) stddev-sans-first:34.18 05:16:56 INFO - 2016-01-11 05:16:56,069 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 143.0 71.0 70.0 70.0 72.0 153.0 71.0 05:16:56 INFO - 2016-01-11 05:16:56,069 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,069 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.20 Median:89.00 stddev:21.67 (24.3%) stddev-sans-first:22.45 05:16:56 INFO - 2016-01-11 05:16:56,070 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 131.0 88.0 89.0 89.0 140.0 88.0 90.0 129.0 05:16:56 INFO - 2016-01-11 05:16:56,070 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,070 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:16:56 INFO - 2016-01-11 05:16:56,070 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 111.0 109.0 110.0 109.0 110.0 110.0 109.0 109.0 05:16:56 INFO - 2016-01-11 05:16:56,070 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,070 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 05:16:56 INFO - 2016-01-11 05:16:56,070 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 146.0 147.0 147.0 146.0 147.0 146.0 146.0 146.0 05:16:56 INFO - 2016-01-11 05:16:56,070 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,070 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 05:16:56 INFO - 2016-01-11 05:16:56,070 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 97.0 95.0 05:16:56 INFO - 2016-01-11 05:16:56,071 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,071 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:1.16 (2.1%) stddev-sans-first:1.20 05:16:56 INFO - 2016-01-11 05:16:56,071 DEBUG : BROWSER_OUTPUT: Values: 56.0 55.0 55.0 55.0 57.0 55.0 57.0 55.0 53.0 55.0 05:16:56 INFO - 2016-01-11 05:16:56,071 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,071 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 05:16:56 INFO - 2016-01-11 05:16:56,071 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 64.0 63.0 64.0 63.0 64.0 63.0 64.0 05:16:56 INFO - 2016-01-11 05:16:56,071 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,071 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:0.67 (0.9%) stddev-sans-first:0.53 05:16:56 INFO - 2016-01-11 05:16:56,071 DEBUG : BROWSER_OUTPUT: Values: 79.0 77.0 77.0 78.0 78.0 78.0 77.0 78.0 78.0 77.0 05:16:56 INFO - 2016-01-11 05:16:56,072 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,072 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:111.20 Median:113.00 stddev:3.08 (2.7%) stddev-sans-first:3.27 05:16:56 INFO - 2016-01-11 05:16:56,072 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 114.0 107.0 114.0 113.0 112.0 108.0 114.0 106.0 05:16:56 INFO - 2016-01-11 05:16:56,072 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,072 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.50 Median:138.00 stddev:4.86 (3.5%) stddev-sans-first:4.07 05:16:56 INFO - 2016-01-11 05:16:56,072 DEBUG : BROWSER_OUTPUT: Values: 147.0 140.0 135.0 139.0 137.0 135.0 147.0 134.0 136.0 135.0 05:16:56 INFO - 2016-01-11 05:16:56,072 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,072 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:61.50 stddev:1.34 (2.2%) stddev-sans-first:1.27 05:16:56 INFO - 2016-01-11 05:16:56,072 DEBUG : BROWSER_OUTPUT: Values: 60.0 61.0 64.0 61.0 61.0 61.0 64.0 61.0 62.0 62.0 05:16:56 INFO - 2016-01-11 05:16:56,073 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:16:56 INFO - 2016-01-11 05:16:56,073 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2016-01-11 05:16:56,741 INFO : Browser exited with error code: 0 05:16:56 INFO - 2016-01-11 05:16:56,789 INFO : Completed test kraken (00:00:56) 05:16:56 INFO - 2016-01-11 05:16:56,789 INFO : Starting test v8_7 05:16:56 INFO - 2016-01-11 05:16:56,789 DEBUG : operating with platform_type : linux_ 05:16:56 INFO - 2016-01-11 05:16:56,789 INFO : Initialising browser for v8_7 test... 05:16:56 INFO - 2016-01-11 05:16:56,795 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdWy7pY/profile http://localhost:36506/getInfo.html 05:17:00 INFO - 2016-01-11 05:17:00,130 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:17:00 INFO - 2016-01-11 05:17:00,130 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:17:00 INFO - 2016-01-11 05:17:00,130 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:17:00 INFO - 2016-01-11 05:17:00,130 DEBUG : BROWSER_OUTPUT: __metrics 05:17:00 INFO - 2016-01-11 05:17:00,279 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] 05:17:01 INFO - 2016-01-11 05:17:01,393 INFO : Browser initialized. 05:17:01 INFO - 2016-01-11 05:17:01,394 INFO : Running cycle 1/1 for v8_7 test... 05:17:01 INFO - 2016-01-11 05:17:01,395 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdWy7pY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:17:13 INFO - 2016-01-11 05:17:13,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 128741376 05:17:13 INFO - 2016-01-11 05:17:13,003 DEBUG : BROWSER_OUTPUT: 05:17:34 INFO - 2016-01-11 05:17:34,459 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36506/tests/v8_7/run.html (next: http://localhost:36506/tests/v8_7/run.html) 05:17:34 INFO - 2016-01-11 05:17:34,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 415883264 05:17:34 INFO - 2016-01-11 05:17:34,717 DEBUG : BROWSER_OUTPUT: 05:17:34 INFO - 2016-01-11 05:17:34,717 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:17:34 INFO - 2016-01-11 05:17:34,717 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:17:34 INFO - 2016-01-11 05:17:34,717 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:17:34 INFO - 2016-01-11 05:17:34,717 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: |0;Richards;163.18537859007833 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;172.8608470181504 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.6420581655481 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5015 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: |4;RayTrace;951.4747859181732 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: |5;Earley;561.7977528089888 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: |6;Boyer;10600 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: |7;RegExp;24261.904761904763 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: |8;Splay;532.0275277924828 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: __startTimestamp1452518254710__endTimestamp 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:17:34 INFO - 2016-01-11 05:17:34,718 DEBUG : BROWSER_OUTPUT: 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.19 Median:163.19 stddev:0.00 (0.0%) 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: Values: 163.2 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:172.86 Median:172.86 stddev:0.00 (0.0%) 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: Values: 172.9 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: Values: 279.6 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5015.00 Median:5015.00 stddev:0.00 (0.0%) 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: Values: 5015.0 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:951.47 Median:951.47 stddev:0.00 (0.0%) 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: Values: 951.5 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: 05:17:34 INFO - 2016-01-11 05:17:34,719 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:561.80 Median:561.80 stddev:0.00 (0.0%) 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: Values: 561.8 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10600.00 Median:10600.00 stddev:0.00 (0.0%) 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: Values: 10600.0 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24261.90 Median:24261.90 stddev:0.00 (0.0%) 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: Values: 24261.9 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:532.03 Median:532.03 stddev:0.00 (0.0%) 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: Values: 532.0 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: Values: 4822.1 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:17:34 INFO - 2016-01-11 05:17:34,720 DEBUG : BROWSER_OUTPUT: 05:17:35 INFO - 2016-01-11 05:17:35,385 INFO : Browser exited with error code: 0 05:17:35 INFO - 2016-01-11 05:17:35,402 INFO : Completed test v8_7 (00:00:38) 05:17:35 INFO - 2016-01-11 05:17:35,676 INFO : Completed test suite (00:20:04) 05:17:35 INFO - 2016-01-11 05:17:35,676 DEBUG : Working with test: dromaeo_css 05:17:35 INFO - 2016-01-11 05:17:35,676 DEBUG : Generating results file: dromaeo_css 05:17:35 INFO - 2016-01-11 05:17:35,678 DEBUG : Working with test: kraken 05:17:35 INFO - 2016-01-11 05:17:35,678 DEBUG : Generating results file: kraken 05:17:35 INFO - 2016-01-11 05:17:35,678 INFO : javascript benchmark 05:17:35 INFO - 2016-01-11 05:17:35,678 DEBUG : Working with test: v8_7 05:17:35 INFO - 2016-01-11 05:17:35,678 DEBUG : Generating results file: v8_7 05:17:35 INFO - 2016-01-11 05:17:35,679 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:17:35 INFO - 2016-01-11 05:17:35,731 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 05:17:35 INFO - 2016-01-11 05:17:35,731 DEBUG : process_Request line: dromaeo_css 7454.80 graph.html#tests=[[72,53,35]] 05:17:35 INFO - 2016-01-11 05:17:35,731 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:17:35 INFO - 2016-01-11 05:17:35,759 DEBUG : process_Request line: kraken 1454.70 graph.html#tests=[[232,53,35]] 05:17:35 INFO - 2016-01-11 05:17:35,759 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:17:35 INFO - 2016-01-11 05:17:35,791 DEBUG : process_Request line: v8_7 23169.12 graph.html#tests=[[230,53,35]] 05:17:35 INFO - 2016-01-11 05:17:35,792 INFO : javascript benchmark 05:17:35 INFO - 2016-01-11 05:17:35,796 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3209.8074115553063, 3281.34373125375, 3305.3885031269215, 3313.1551454379146, 3323.700866921977, 5468.7539060742265, 5472.808451704186, 5533.280673512443, 5551.583631227654, 5559.916601250974, 5566.192902029204, 5619.943800561993, 5625.9029489249615, 5630.09918413054, 5641.943580564203, 5001.8249361272365, 5040.546350828425, 5092.032513822381, 5118.718470484122, 5204.505571970657, 4953.950460495403, 5005.724685142316, 5068.4171320298265, 5083.949160508403, 5134.717590532519, 5137.691738495702, 5203.947960520403, 5208.609354298424, 5215.869603259911, 5231.372235331765, 4886.584640305578, 4994.975025124888, 5126.154184559543, 5146.768395422215, 5202.08963431398, 4881.438634557, 4991.900161996776, 5005.899882002376, 5008.348914641109, 5014.821516943515, 5393.7303134843105, 5486.451354864522, 5494.0, 5522.585806064521, 5549.805756798533, 5882.088276317135, 5900.881982360329, 6035.637861728311, 6049.909251361233, 6065.090236464565, 6023.036314189709, 6036.305824830113, 6052.243469566304, 6054.969725151346, 6087.939120608781, 5626.071698169797, 5627.324721033461, 5628.774849005994, 5632.0, 5635.464630860103, 5949.672767997802, 6024.849378765478, 6046.565041766711, 6108.297545782292, 6136.202293701879, 5902.822915312548, 5951.940480595225, 5953.940460595425, 5961.5230781537375, 5977.163197152402, 6052.455279024909, 6065.332813390523, 6066.696665166724, 6069.696515174223, 6071.666058366833, 5848.707564621752, 5909.143174239711, 5985.880282394328, 6006.459418652343, 6013.729382177812, 5990.430909063632, 6053.092036194518, 6059.121427393004, 6059.787907423307, 6061.818145455643, 4544.091181763594, 4654.790534425959, 4656.883577910579, 4667.859964201011, 4676.766161691902, 4045.3122969095325, 4095.2219078375015, 4112.444819949328, 4127.112670775738, 4132.648724858421, 5715.8571035724435, 5759.452851979056, 5771.797987070432, 5774.595778295563, 5780.479756821906, 5874.353821079678, 5998.100284957204, 6063.575549711478, 6082.695865206722, 6085.604435711664, 5639.605227634026, 5730.169125476783, 5735.397783232784, 5736.13957906309, 5743.0, 5267.894642107136, 5289.418164001957, 5293.708846013506, 5296.682199068068, 5303.337082864642, 6051.243594550681, 6147.354527774609, 6243.937560624427, 6258.43674069336, 6274.874502510015, 5938.138969849434, 6010.7295171716505, 6023.969880150571, 6027.57806953509, 6050.364711705383, 6132.172156758959, 6226.862838158447, 6236.126942228001, 6250.874982500233, 6259.906101408574, 5702.230198923258, 5795.710214489343, 5798.33319168301, 5977.954983538397, 5985.102234664835, 6069.0, 6097.878042439038, 6107.389261073857, 6120.632762034292, 6129.08063790435, 5911.349751527243, 5947.405259474191, 5949.3753155918, 5949.851253718692, 5955.464008239279, 5676.318841739017, 5797.391273916178, 5802.82591522255, 5936.554758393051, 5937.020391635332, 5803.912941305968, 5811.186433899173, 5817.563682723728, 5822.534197264124, 5827.5337972961215, 5926.407359264039, 5942.465178133989, 5947.6431414115295, 5968.582199246185, 5971.462568368867, 5546.861328466659, 5676.063449530781, 5726.455986681259, 5808.82573522795, 5837.824865254049], "unit": "ms", "name": "dojo.html", "value": 5539.774087479846}, {"lowerIsBetter": false, "replicates": [566.6628356128105, 609.3206075226122, 624.6720471752329, 641.224118816232, 642.5502148496054, 36710.816445917764, 42882.57117428825, 42933.0, 42950.0, 43042.35436468456, 47734.76132619341, 47906.281405778944, 47970.28044579334, 48014.519854801445, 48823.0, 8314.625841837102, 8454.0, 9362.578683959238, 9560.04399560042, 10707.518161682705, 11067.557297708083, 11096.722581935475, 11172.944135279313, 11193.66419007427, 11210.551577936872, 11158.0, 11222.551097956071, 11261.774764504706, 11264.267822591546, 11278.097752179807, 11123.72190695231, 11155.0, 11222.66332010041, 11224.326540407601, 11226.270292431007, 10994.780104397947, 11116.888831111666, 11118.833217501744, 11121.110311175167, 11127.72180695481, 46423.5357646426, 46640.0, 46693.29960050602, 46986.29520557194, 47043.76478117587, 3667.7982710950887, 4226.387173859804, 4284.121755040209, 4319.805608747614, 4398.834308908142, 34310.485342719876, 34621.13447163841, 34844.0, 34948.82525587381, 34972.47541286883, 3678.886347976315, 3762.6049264827348, 3763.49192858966, 3843.13529455873, 3849.0377405648587, 313250.0, 313952.0, 314064.0, 314280.0, 315723.99999999773, 59601.0, 60646.393536064956, 68109.65945170341, 69276.0, 69586.65206673935, 72643.0, 72801.71982801783, 73014.26985730181, 73232.0, 73636.0, 17933.0, 18151.81848181501, 18168.909155454403, 18202.271909123752, 18260.452186434428, 13582.59252222435, 13737.450501979809, 13768.036237463282, 13772.173669579857, 13778.517751878637, 22274.109035638718, 22287.331380058626, 22433.887830560743, 22573.4356641082, 22609.4347641307, 8472.491650500866, 8741.737747867573, 8859.734207973772, 8886.73339799807, 8947.865782013276, 1038.3977293169944, 1071.5445935477392, 1087.3149915553151, 1091.8307662312354, 1215.562397536886, 30274.394512110073, 30724.53913191304, 30785.538216926765, 30828.87059387769, 31647.683523164935, 1081.6863109698256, 1089.7057794395628, 1092.126298960828, 1155.058627218814, 1157.4097210422576, 13784.517541885985, 14333.426662933365, 14426.783598246035, 14801.111933284037, 15308.234588270765, 386145.0, 392153.0, 392733.0, 392741.0, 393251.0, 60709.30633498362, 60939.39060609337, 60984.085238721455, 61007.0, 61054.38945610576, 1258.5091814192472, 1435.9641008974859, 1525.1306755149458, 1533.2487081330069, 1546.0646308983128, 27942.720572794824, 27985.860070699517, 28499.572506412005, 28760.280992974505, 30736.0, 56066.43933560612, 57552.13671794843, 57626.4237357621, 57703.1344529824, 57808.4219157803, 256430.0, 257376.0, 258421.0, 259259.0, 259504.0, 37427.625723742414, 38160.80919595384, 38271.6172838268, 38272.42591361188, 38725.0, 50567.74716126396, 51038.489615103375, 51216.0, 51728.48271517387, 52113.7394313026, 41917.161656767305, 41931.580684193985, 42092.0, 42247.366289505066, 43444.782776085915, 42433.0, 42521.36217956671, 42777.0, 43231.78384108059, 43265.35101973536, 40129.1974160521, 40463.797681011405, 41560.0, 41583.37624935689, 41649.1670166601, 37594.24811503809, 38491.535761781575, 38710.0, 38722.80638596789, 38831.2233755329, 27691.44617107687, 27692.307692307855, 27733.0, 28159.0, 28180.0], "unit": "ms", "name": "ext.html", "value": 21050.61943899933}, {"lowerIsBetter": false, "replicates": [386.175515274888, 388.9202713443744, 389.8128898128898, 393.4806056006073, 394.11914371379976, 14619.0, 18236.635267294663, 20780.272690455837, 20794.89602551987, 21733.565328693418, 19482.4155275342, 19803.50491237716, 20540.69188962163, 20769.169233230652, 20789.896050519765, 5711.171880077386, 5846.678432686201, 5863.853403664921, 5865.560082993771, 5867.3252575953675, 5963.582549221556, 6025.0661147522205, 6984.720611175547, 7186.748463803768, 7246.782596522113, 4583.793729282191, 6823.112995310603, 7236.891446628305, 7239.89140162898, 7243.456740744439, 7092.822679433056, 7306.415486761046, 7317.0487836580905, 7318.304761047719, 7319.048523691913, 6937.306269373073, 6938.202106757737, 6949.5135340526185, 6956.20003699576, 6956.826079348057, 22994.540109197722, 25292.87353563239, 25424.49151016988, 26181.476370472676, 26810.865945670343, 2414.6860908082012, 2464.827462077655, 2473.0355161487037, 2509.109266210487, 2533.4553071089804, 15491.302891369915, 15801.288941997638, 15915.522534323989, 16245.593860153473, 16282.83717162825, 2137.8931053447263, 2156.9352919412445, 2167.0, 2168.826493880486, 2232.084845213471, 74771.62614186894, 76394.23605763927, 78184.60907695425, 78390.60804695997, 78524.0, 17710.291588336324, 17849.553761156076, 17999.910000450174, 18054.458366249033, 18075.276988920297, 28345.0, 28386.574201386997, 28626.713732862405, 28691.56962645562, 28726.569101463494, 10072.345297555636, 10263.332883362558, 10384.636537721144, 10388.844167337496, 10445.791084178274, 8736.301095912311, 8742.737717868475, 8799.032106468283, 8828.646854125891, 8894.911050889537, 8880.467171969702, 8985.775355616162, 9053.637854485878, 9080.682176123804, 9083.863742043875, 2204.239537359608, 3333.300006998509, 3336.6663333666925, 3365.5120007599253, 3380.543626610376, 515.6596646213482, 518.4892880512692, 527.614841165951, 531.3835950297636, 562.9690367029852, 12403.511049420275, 13253.722468597516, 13409.597712068653, 13500.93249533746, 13724.107932984323, 533.9652922560099, 536.369765525506, 544.281548356166, 546.7239044282612, 549.2667289169004, 6772.322767723188, 7004.754833580801, 7145.39264162552, 7313.744018959311, 7459.589722565311, 574989.0, 575573.0, 615054.0, 647475.0, 648071.0, 69851.0, 77551.22448775553, 83830.5808470966, 86300.0, 87250.0, 614.4531367083299, 620.5532016947791, 622.0762168180248, 623.4482483002485, 624.372505631837, 11727.824082638937, 11916.702082448008, 11935.52257909674, 12015.219010764273, 12072.698182545506, 35521.0, 35973.46039809353, 38960.0, 39956.600433995285, 40260.59739402569, 52517.0, 53043.20435193552, 53765.46234537604, 54467.72766136144, 54854.45145548653, 7572.242775722384, 7710.421718371257, 7717.151113377637, 7727.690892364468, 7737.535747855147, 13329.0, 13796.103253288504, 13891.166530008231, 13953.790693139408, 14183.787243191568, 12181.208221465577, 12232.571859984857, 12360.505579777067, 12441.688957776129, 12595.055370847407, 11813.291202527877, 11962.940185299018, 12293.56972505958, 12328.321942292901, 12487.625371238877, 11906.880931190577, 12434.564790232298, 12539.87460125387, 12556.497740090294, 12679.93660031694, 7804.375649948104, 7837.333826624801, 7924.48490848093, 7937.166597507178, 7941.285284324438, 11947.402629868646, 12002.879971200176, 12222.938885305517, 12460.190087644636, 12464.314462704639], "unit": "ms", "name": "jquery.html", "value": 9524.860614791372}, {"lowerIsBetter": false, "replicates": [1595.9361625534973, 1602.6714523522678, 1864.878782879112, 1890.5084677983725, 1892.2336453736236, 6775.08536347593, 6863.897041544368, 6869.416099631525, 6880.518363714542, 6891.724331026766, 8165.91834081659, 8214.507129572215, 8220.671173153067, 8227.712030078934, 8240.95879520603, 2378.5005148918704, 2380.5238952209543, 2396.676448679423, 2400.31590996566, 2424.078850036992, 2378.2984019714227, 2394.5330660521204, 2399.6760437341, 2414.710234771821, 2421.5278020785954, 2086.09254974086, 2141.496748264157, 2301.735300440446, 2331.5919714049974, 2335.708036495438, 2251.3808702606916, 2266.784655457729, 2268.6710426988075, 2271.250487339182, 2274.1585613323177, 2309.7690230976937, 2388.36708272308, 2388.5700573896693, 2388.581998150334, 2389.7371289158177, 7157.642117894085, 7301.0, 7882.211778822129, 8004.199580042007, 8028.799280017988, 5122.948770512285, 5210.088234558975, 5211.062008838408, 5213.478652134794, 5215.3741551013745, 3431.7083047940955, 3462.6191118976894, 3475.4613034979366, 3497.265574229415, 3498.3353162898966, 1114.3425379026332, 1185.6443067079929, 1205.9879401206051, 1230.9569165079179, 1252.3237451776122, 11099.556017759362, 11131.554737810478, 11142.164337674707, 11156.497957591846, 11165.609203677832, 4592.127495775859, 4596.839110631112, 4640.466346370143, 4719.032598317337, 4719.480857105716, 9696.563654635558, 9704.757381065388, 9705.9029409705, 9715.0770676787, 9716.854247186298, 5148.124818780816, 5166.483351664879, 5172.922406163911, 5176.637635365489, 5179.48205179479, 4685.601723853442, 4698.694584851974, 4718.197906355927, 4718.363020992191, 4720.575148236675, 3881.2819628368843, 3893.922121557553, 3923.705722070856, 3951.980240098781, 3954.5847685992558, 1295.6307452376216, 1300.1873828856965, 1305.2560040776857, 1309.2798960571647, 1314.1589382795019, 1178.5462596900254, 1187.1867770577182, 1204.277433539869, 1434.96412589684, 1452.0053763172261, 7731.806704832424, 7771.766846994599, 7798.142204357516, 7855.921440785633, 7864.056313242333, 563.3099453169834, 566.4052744618134, 566.6090397625625, 567.3503838105429, 567.8722287485283, 5896.410358964155, 5981.581289309794, 6282.340354262737, 6330.430261276507, 6339.11252424661, 9620.278479114095, 9847.655332063343, 9850.113489785954, 9881.160101391319, 9884.654037108667, 9500.857487137699, 9713.70858874235, 9799.657012004545, 9865.309428339948, 9874.901250987541, 7536.321731044232, 7544.8491030180185, 7588.051493563305, 7603.847923041508, 7612.923870761332, 7585.127710313384, 7643.503172293783, 7683.500572462772, 7695.268949449794, 7705.730299439493, 8568.271696905833, 8660.047394786443, 8701.260392866678, 8743.431676940978, 8752.47485150893, 8613.65545378178, 8796.47221166732, 8797.0, 8842.602082906413, 8884.067172946747, 7177.3899218567, 7184.1738200105565, 7254.782356529313, 7262.636868156676, 7272.0, 8065.314448271963, 8114.229148230908, 8116.634751436081, 8120.553369564731, 8124.0, 7435.665395057344, 7467.551946883204, 7535.886961695689, 7558.659860306409, 7640.923590764021, 7410.5183163094225, 7423.294786995227, 7452.664630091551, 7539.0576177977755, 7599.658015389431, 7642.5032372895585, 7681.116671582616, 7688.46180767341, 7692.19231980634, 7698.345640620386, 6918.654067296716, 6942.201646810681, 6945.756898508528, 6946.930530694831, 6957.512974091765, 7008.929910700827, 7139.0, 7142.857142857218, 7144.071270734771, 7145.428365730625], "unit": "ms", "name": "mootools.html", "value": 4680.120366134567}, {"lowerIsBetter": false, "replicates": [367.5424096999236, 370.30752492838394, 370.96846768024716, 374.6085340818844, 377.2699825837005, 6017.127516510103, 6023.1868697725795, 6044.395560443953, 6055.122007308938, 6062.393760623935, 5750.568707346944, 5812.157237200603, 5819.621724587899, 5923.200367950325, 5950.464458198761, 4629.259318509039, 4635.721856688592, 4638.9072218555775, 4644.674872758908, 4676.906461870761, 4628.143793398232, 4628.861134165981, 4638.512956139607, 4639.443266807988, 4640.118377508279, 4568.725876447407, 4586.1744885920525, 4594.471635761896, 4598.379218805452, 4599.678022538424, 4518.932216016762, 4587.72473651582, 4591.540845915415, 4597.839075632371, 4607.493175750665, 4043.130726893732, 4050.5746896576024, 4057.6348128668265, 4059.8579049733116, 4067.5118985721606, 5717.514011309002, 5720.771169153229, 5726.484616384504, 5730.885382292331, 5734.97132514339, 5261.905706015334, 5317.601179911522, 5321.760520776575, 5338.893222135574, 5340.279062326575, 6339.746410143589, 6363.713632886531, 6365.2679941806355, 6374.553781235269, 6377.202849643794, 4541.182587134314, 4544.772761361952, 4545.11370282795, 4546.772661366951, 4554.453465584118, 6517.641529715864, 6578.440832529241, 6591.637459939701, 6595.6372399518, 6595.769148079842, 4534.410526631516, 4592.2422800238255, 4600.861974140781, 4612.423447069116, 4618.237990731492, 4669.626429885601, 4673.766311684402, 4675.462321833033, 4676.929846052312, 4680.251159814414, 5336.146216605324, 5339.46605339463, 5340.439253878365, 5341.5192632662465, 5345.812896548602, 6293.465055470337, 6294.181756371734, 6296.685165741695, 6297.748090076438, 6305.5901366411035, 1654.619437529351, 1693.314207745865, 1694.9152542372833, 1695.4235559909444, 1706.7695861058598, 1048.627737153315, 1092.9344239345664, 1140.3613976173203, 1143.9656810295705, 1151.5278735718316, 6097.298810636745, 6119.204503414617, 6120.14317995481, 6120.1737765401995, 6129.080637904261, 6432.421082102634, 6435.646039467874, 6437.710303036374, 6438.0, 6439.452646525004, 5981.551383646244, 6024.969875150597, 6108.511319094462, 6113.083037544404, 6118.694065296718, 3554.3957527220437, 3578.6421357864524, 3581.3732596795458, 3582.6954708849516, 3585.4801053847045, 6724.394804467622, 6754.966225168941, 6757.155355580552, 6760.560563563353, 6764.864702705919, 6566.606003639797, 6673.299303573055, 6680.665966701646, 6682.0311054896765, 6689.632070236184, 6749.730010799612, 6753.763618273435, 6756.425703815133, 6760.7295708172105, 6762.594244345355, 6517.120188774645, 6525.510586706111, 6527.05357723118, 6533.150690410216, 6533.41199292066, 6350.460210882126, 6426.646534440651, 6448.161738973903, 6456.192975878015, 6456.9354306456335, 6718.7312507499155, 6739.0902228198565, 6740.966295168689, 6761.966190169018, 6765.255821859493, 4595.494495605548, 4602.562756538124, 4603.447586289667, 4608.585227329557, 4617.58441740245, 6436.259830119409, 6526.412622863775, 6537.346265373425, 6539.280679125388, 6560.803175904731, 6374.07575901501, 6374.840628984312, 6407.743690252338, 6422.133012043314, 6426.485881129405, 6331.651759153291, 6332.2717887441695, 6333.1766870306565, 6336.651484168415, 6343.4608058313715, 6210.5652604319075, 6288.1825362704385, 6289.496840252677, 6301.6219026858535, 6305.747770089145, 6384.9042264367, 6387.457066149429, 6392.424681778476, 6392.456641185366, 6393.392627700361, 6268.404501572343, 6274.027525733519, 6274.121622972879, 6274.466670333073, 6277.874442511215], "unit": "ms", "name": "prototype.html", "value": 4833.395985792377}, {"lowerIsBetter": false, "replicates": [815.844989452004, 819.0376307838288, 836.1805430677932, 881.7751473374288, 957.549951522784, 14370.784438233435, 15017.24913754312, 16143.83856161438, 16160.595985100379, 16184.838151618465, 15063.0, 15157.469488567902, 15184.696306073873, 15184.924075379635, 15195.924020379882, 792.2117493094379, 809.6518497046268, 938.0713094036888, 944.0512285153411, 961.4375590279694, 961.5240455974302, 962.5043102802063, 969.365065881845, 970.7718686108759, 971.0871780526282, 817.5094943034192, 999.0409207161134, 1008.2085562833178, 1009.7122320138762, 1010.4139599032543, 829.3862541719114, 967.5839389062701, 993.8459538771502, 994.6767300627253, 1005.6932635546192, 730.5032577847062, 732.9450291228126, 733.3253406865697, 733.5232099135551, 733.5488674465219, 15093.0, 15324.846751532565, 15367.0, 15369.001014933994, 15391.538253852403, 13982.860171398257, 14034.719305613933, 14059.929700351433, 14146.929265353607, 14287.857121428757, 11204.943975280072, 11241.213115081948, 11385.544578216945, 11457.828132578017, 11482.368469734161, 3876.9030774230587, 3899.317619416619, 3921.941170882439, 3983.0, 3989.880303590897, 51245.487545124444, 51374.74312628413, 52974.205386919224, 52984.0, 53034.20448693273, 9116.544172791333, 9236.353455258068, 9337.673181438753, 9435.198008169382, 11264.774704505864, 13523.715247051514, 13662.385192666354, 13680.863191368158, 13693.863061369259, 13922.443102275998, 7604.505707129019, 7628.847423051508, 7745.264199901, 7765.7281995131025, 8024.398170137263, 4747.786349614275, 4795.352627395257, 4828.758562071953, 4840.273958906122, 4870.732109733999, 3083.5066389377594, 3094.659587445379, 3097.1173215633885, 3099.1477343730653, 3101.1006808025872, 476.27368263398597, 486.60098719050745, 487.25450061406104, 487.5636305506552, 487.57337329836395, 628.6452694443482, 632.705791806812, 670.9060731497594, 682.8224661587924, 721.3075447570391, 8645.3948223625, 9689.12797848197, 9733.367331123454, 9813.852792208123, 9868.457234852152, 662.1458318768734, 668.4251543672437, 683.3883674111742, 725.2421219825189, 748.7304570354668, 4160.375943608423, 4211.87364379063, 4267.0825772459075, 4285.335772955197, 4376.431063961664, 66287.66856165785, 66382.66808665925, 66995.0, 67460.32539674541, 68903.65548172226, 60462.0, 60504.69747651234, 61310.0, 61394.69302653458, 61690.0, 53740.0, 53853.73073134609, 53871.46128538743, 55710.16434753482, 56249.0, 8923.107689231025, 8930.464172149692, 9009.459432434074, 9046.185843273874, 9126.49804260772, 39281.214375712894, 39790.40314395229, 40502.392464113655, 41126.0, 41242.1751564973, 51357.0, 52098.73950630223, 52882.735586321825, 52903.0, 53840.19239711486, 8829.779255518664, 9251.167394934218, 9297.190851993886, 9362.0, 9387.389819661701, 13263.86736132665, 13375.331233438095, 13632.591022269347, 13688.041837071309, 13735.107218030797, 11198.410638340316, 12122.0, 12312.692182695504, 12849.87150128524, 13279.734405312032, 12511.0, 12528.87471125277, 12696.0, 12704.555340563036, 12942.93528532389, 11256.268342557707, 12069.336186509827, 12272.551680418312, 13075.934620326838, 13095.083344165816, 10626.203034772578, 10791.838122428013, 11352.318860868374, 11464.885351146715, 11550.306981581132, 10896.346219226873, 10942.914282319887, 11115.610953616584, 11220.0, 11316.377599231791], "unit": "ms", "name": "yui.html", "value": 6830.435634734145}], "name": "dromaeo_css", "value": 7454.79624571408}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 103.0, 109.0, 110.0, 109.0, 100.0, 109.0, 100.0, 107.0], "unit": "ms", "name": "ai-astar", "value": 106.6}, {"lowerIsBetter": true, "replicates": [147.0, 121.0, 142.0, 155.0, 123.0, 147.0, 154.0, 124.0, 163.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.8}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 158.0, 160.0, 160.0, 161.0, 160.0, 162.0, 161.0, 158.0], "unit": "ms", "name": "audio-dft", "value": 159.9}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 143.0, 71.0, 70.0, 70.0, 72.0, 153.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 86.1}, {"lowerIsBetter": true, "replicates": [89.0, 89.0, 131.0, 88.0, 89.0, 89.0, 140.0, 88.0, 90.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 102.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 111.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 55.0, 57.0, 55.0, 57.0, 55.0, 53.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 63.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.6}, {"lowerIsBetter": true, "replicates": [79.0, 77.0, 77.0, 78.0, 78.0, 78.0, 77.0, 78.0, 78.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.7}, {"lowerIsBetter": true, "replicates": [111.0, 113.0, 114.0, 107.0, 114.0, 113.0, 112.0, 108.0, 114.0, 106.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 111.2}, {"lowerIsBetter": true, "replicates": [147.0, 140.0, 135.0, 139.0, 137.0, 135.0, 147.0, 134.0, 136.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.5}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 64.0, 61.0, 61.0, 61.0, 64.0, 61.0, 62.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 61.7}], "name": "kraken", "value": 1454.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.18537859007833], "unit": "score", "name": "Richards", "value": 216.33065600000006}, {"lowerIsBetter": false, "replicates": [172.8608470181504], "unit": "score", "name": "DeltaBlue", "value": 382.49263000000013}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5015.0], "unit": "score", "name": "Decrypt", "value": 53.07696909272185}, {"lowerIsBetter": false, "replicates": [951.4747859181732], "unit": "score", "name": "RayTrace", "value": 777.728439}, {"lowerIsBetter": false, "replicates": [561.7977528089888], "unit": "score", "name": "Earley", "value": 1186.3041400000002}, {"lowerIsBetter": false, "replicates": [10600.0], "unit": "score", "name": "Boyer", "value": 62.873867924528355}, {"lowerIsBetter": false, "replicates": [24261.904761904763], "unit": "score", "name": "RegExp", "value": 37.547958783120734}, {"lowerIsBetter": false, "replicates": [532.0275277924828], "unit": "score", "name": "Splay", "value": 153.17064577114422}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23169.12464312407}]} 05:17:35 INFO - RETURN: dromaeo_css: 7454.80 05:17:35 INFO - RETURN: kraken: 1454.70 05:17:35 INFO - RETURN: v8_7: 23169.12 05:17:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23169.12"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1454.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7454.80"}}} 05:17:35 INFO - Return code: 0 05:17:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:17:35 INFO - # TBPL SUCCESS # 05:17:35 INFO - Running post-action listener: _resource_record_post_action 05:17:35 INFO - Running post-run listener: _resource_record_post_run 05:17:37 INFO - Total resource usage - Wall time: 1220s; CPU: 12.0%; Read bytes: 593920; Write bytes: 372785152; Read time: 520; Write time: 191892 05:17:37 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108199936; Read time: 160; Write time: 56556 05:17:37 INFO - run-tests - Wall time: 1206s; CPU: 12.0%; Read bytes: 589824; Write bytes: 264585216; Read time: 360; Write time: 135336 05:17:37 INFO - Running post-run listener: _upload_blobber_files 05:17:37 INFO - Blob upload gear active. 05:17:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:17:37 INFO - Copying logs to upload dir... 05:17:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.909345 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-11 05:17:37.016420) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-11 05:17:37.020932) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010004 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452508593/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.12 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-11 05:17:37.150438) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:17:37.150944) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452516984.744327-658602353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:17:37.169822) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 05:17:37.170118) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 05:17:37.170390) ========= ========= Total master_lag: 0.24 =========