builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1450270145.67 results: success (0) buildid: 20151215222209 builduid: c7d83ec7ec38466f80723d81083dda01 revision: b2d75585bfc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:05.667367) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:05.667873) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:05.668248) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006167 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.40 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:06.079068) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:06.079440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:06.098006) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:06.098349) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:06.147171) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:06.148936) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:06.149387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:06.149708) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 04:49:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2015-12-16 04:49:06 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191273 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:06.354000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:06.357266) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014327 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:06.410365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 04:49:06.410784) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b2d75585bfc4 --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 b2d75585bfc4 --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=6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 04:49:06,486 Setting DEBUG logging. 2015-12-16 04:49:06,486 attempt 1/10 2015-12-16 04:49:06,486 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b2d75585bfc4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 04:49:07,218 unpacking tar archive at: mozilla-beta-b2d75585bfc4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.047289 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 04:49:07.470872) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:07.471200) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:07.481064) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:07.481331) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 04:49:07.481710) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-12-16 04:49:07.481986) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --system-bits 64 --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', '--system-bits', '64', '--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=6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:49:07 INFO - MultiFileLogger online at 20151216 04:49:07 in /builds/slave/test-pgo 04:49:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:49:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:49:07 INFO - {'append_to_log': False, 04:49:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:49:07 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:49:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:49:07 INFO - 'branch': 'Mozilla-Beta', 04:49:07 INFO - 'buildbot_json_path': 'buildprops.json', 04:49:07 INFO - 'config_files': ('talos/linux_config.py',), 04:49:07 INFO - 'default_actions': ('clobber', 04:49:07 INFO - 'read-buildbot-config', 04:49:07 INFO - 'download-and-extract', 04:49:07 INFO - 'populate-webroot', 04:49:07 INFO - 'create-virtualenv', 04:49:07 INFO - 'install', 04:49:07 INFO - 'run-tests'), 04:49:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:49:07 INFO - 'download_minidump_stackwalk': True, 04:49:07 INFO - 'download_symbols': 'ondemand', 04:49:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:49:07 INFO - 'tooltool.py': '/tools/tooltool.py', 04:49:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:49:07 INFO - '/tools/misc-python/virtualenv.py')}, 04:49:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:49:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:49:07 INFO - 'installer_path': 'installer.exe', 04:49:07 INFO - 'log_level': 'info', 04:49:07 INFO - 'log_name': 'talos', 04:49:07 INFO - 'log_to_console': True, 04:49:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:49:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:49:07 INFO - 'opt_config_files': (), 04:49:07 INFO - 'pip_index': False, 04:49:07 INFO - 'sps_profile': False, 04:49:07 INFO - 'sps_profile_interval': 0, 04:49:07 INFO - 'suite': 'dromaeojs', 04:49:07 INFO - 'system_bits': '64', 04:49:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:49:07 INFO - 'title': 'talos-linux64-ix-037', 04:49:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:49:07 INFO - 'use_talos_json': True, 04:49:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:49:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:49:07 INFO - 'work_dir': 'build'} 04:49:07 INFO - ##### 04:49:07 INFO - ##### Running clobber step. 04:49:07 INFO - ##### 04:49:07 INFO - Running pre-action listener: _resource_record_pre_action 04:49:07 INFO - Running main action method: clobber 04:49:07 INFO - rmtree: /builds/slave/test-pgo/build 04:49:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:49:08 INFO - Running post-action listener: _resource_record_post_action 04:49:08 INFO - ##### 04:49:08 INFO - ##### Running read-buildbot-config step. 04:49:08 INFO - ##### 04:49:08 INFO - Running pre-action listener: _resource_record_pre_action 04:49:08 INFO - Running main action method: read_buildbot_config 04:49:08 INFO - Using buildbot properties: 04:49:08 INFO - { 04:49:08 INFO - "properties": { 04:49:08 INFO - "buildnumber": 33, 04:49:08 INFO - "product": "firefox", 04:49:08 INFO - "script_repo_revision": "production", 04:49:08 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:49:08 INFO - "repository": "", 04:49:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:49:08 INFO - "buildid": "20151215222209", 04:49:08 INFO - "slavename": "talos-linux64-ix-037", 04:49:08 INFO - "pgo_build": "True", 04:49:08 INFO - "basedir": "/builds/slave/test-pgo", 04:49:08 INFO - "project": "", 04:49:08 INFO - "platform": "ubuntu64_hw", 04:49:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:49:08 INFO - "slavebuilddir": "test", 04:49:08 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:49:08 INFO - "branch": "mozilla-beta", 04:49:08 INFO - "repo_path": "releases/mozilla-beta", 04:49:08 INFO - "stage_platform": "linux64-pgo", 04:49:08 INFO - "builduid": "c7d83ec7ec38466f80723d81083dda01", 04:49:08 INFO - "revision": "b2d75585bfc4" 04:49:08 INFO - }, 04:49:08 INFO - "sourcestamp": { 04:49:08 INFO - "repository": "", 04:49:08 INFO - "hasPatch": false, 04:49:08 INFO - "project": "", 04:49:08 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:49:08 INFO - "changes": [ 04:49:08 INFO - { 04:49:08 INFO - "category": null, 04:49:08 INFO - "files": [ 04:49:08 INFO - { 04:49:08 INFO - "url": null, 04:49:08 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.tar.bz2" 04:49:08 INFO - } 04:49:08 INFO - ], 04:49:08 INFO - "repository": "", 04:49:08 INFO - "rev": "b2d75585bfc4", 04:49:08 INFO - "who": "sendchange", 04:49:08 INFO - "when": 1450255076, 04:49:08 INFO - "number": 7365134, 04:49:08 INFO - "comments": "Bug 1220010: Temporarily disable asyncInit_ r=me, a=bustage", 04:49:08 INFO - "project": "", 04:49:08 INFO - "at": "Wed 16 Dec 2015 00:37:56", 04:49:08 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:49:08 INFO - "revlink": "", 04:49:08 INFO - "properties": [ 04:49:08 INFO - [ 04:49:08 INFO - "buildid", 04:49:08 INFO - "20151215222209", 04:49:08 INFO - "Change" 04:49:08 INFO - ], 04:49:08 INFO - [ 04:49:08 INFO - "builduid", 04:49:08 INFO - "c7d83ec7ec38466f80723d81083dda01", 04:49:08 INFO - "Change" 04:49:08 INFO - ], 04:49:08 INFO - [ 04:49:08 INFO - "pgo_build", 04:49:08 INFO - "True", 04:49:08 INFO - "Change" 04:49:08 INFO - ] 04:49:08 INFO - ], 04:49:08 INFO - "revision": "b2d75585bfc4" 04:49:08 INFO - } 04:49:08 INFO - ], 04:49:08 INFO - "revision": "b2d75585bfc4" 04:49:08 INFO - } 04:49:08 INFO - } 04:49:08 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.tar.bz2. 04:49:08 INFO - Running post-action listener: _resource_record_post_action 04:49:08 INFO - ##### 04:49:08 INFO - ##### Running download-and-extract step. 04:49:08 INFO - ##### 04:49:08 INFO - Running pre-action listener: _resource_record_pre_action 04:49:08 INFO - Running main action method: download_and_extract 04:49:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:49:08 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:49:08 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/test_packages.json 04:49:08 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:49:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:49:08 INFO - Downloaded 1270 bytes. 04:49:08 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:49:08 INFO - Using the following test package requirements: 04:49:08 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:49:08 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:49:08 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:49:08 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:49:08 INFO - u'jsshell-linux-x86_64.zip'], 04:49:08 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:49:08 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:49:08 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:49:08 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:49:08 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 04:49:08 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:49:08 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 04:49:08 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:49:08 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:49:08 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:49:08 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:49:08 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:49:08 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:49:08 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:49:08 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:49:08 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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:49:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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:49:08 INFO - Downloaded 22571743 bytes. 04:49:08 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:49:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:49:08 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:49:09 INFO - Return code: 0 04:49:09 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:49: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:49:09 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:49:09 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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:49:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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:49:10 INFO - Downloaded 22571743 bytes. 04:49:10 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:49:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:49:10 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:49:11 INFO - Return code: 0 04:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:11 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 04:49:11 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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:49:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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:49:11 INFO - Downloaded 11131970 bytes. 04:49:11 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:49:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 04:49:11 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:49:11 INFO - Return code: 0 04:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:11 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:49:11 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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:49:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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:49:12 INFO - Downloaded 56629990 bytes. 04:49:12 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:49:12 INFO - mkdir: /builds/slave/test-pgo/properties 04:49:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:49:12 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:49:12 INFO - Contents: 04:49:12 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:49:12 INFO - Running post-action listener: _resource_record_post_action 04:49:12 INFO - Running post-action listener: set_extra_try_arguments 04:49:12 INFO - ##### 04:49:12 INFO - ##### Running populate-webroot step. 04:49:12 INFO - ##### 04:49:12 INFO - Running pre-action listener: _resource_record_pre_action 04:49:12 INFO - Running main action method: populate_webroot 04:49:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:49:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:49:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:49:12 INFO - '../fennec_ids.txt'], 04:49:12 INFO - 'tests': ['tcheck2']}, 04:49:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:49:12 INFO - '--tppagecycles', 04:49:12 INFO - '7'], 04:49:12 INFO - 'tests': ['tsvgm']}}, 04:49:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:49:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:49:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:49:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:49:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:49:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:49:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'talos_options': ['--e10s'], 04:49:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'tests': ['damp', 'tps']}, 04:49:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'talos_options': ['--e10s'], 04:49:12 INFO - 'tests': ['damp', 'tps']}, 04:49:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:49:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:49:12 INFO - 'other': {'tests': ['a11yr', 04:49:12 INFO - 'ts_paint', 04:49:12 INFO - 'tpaint', 04:49:12 INFO - 'sessionrestore', 04:49:12 INFO - 'sessionrestore_no_auto_restore']}, 04:49:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:49:12 INFO - 'tests': ['a11yr', 04:49:12 INFO - 'ts_paint', 04:49:12 INFO - 'tpaint', 04:49:12 INFO - 'sessionrestore', 04:49:12 INFO - 'sessionrestore_no_auto_restore']}, 04:49:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:49:12 INFO - 'tests': ['a11yr', 04:49:12 INFO - 'ts_paint', 04:49:12 INFO - 'tpaint', 04:49:12 INFO - 'sessionrestore', 04:49:12 INFO - 'sessionrestore_no_auto_restore']}, 04:49:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:49:12 INFO - 'tests': ['a11yr', 04:49:12 INFO - 'ts_paint', 04:49:12 INFO - 'tpaint', 04:49:12 INFO - 'sessionrestore', 04:49:12 INFO - 'sessionrestore_no_auto_restore']}, 04:49:12 INFO - 'other_l64': {'tests': ['a11yr', 04:49:12 INFO - 'ts_paint', 04:49:12 INFO - 'tpaint', 04:49:12 INFO - 'sessionrestore', 04:49:12 INFO - 'sessionrestore_no_auto_restore']}, 04:49:12 INFO - 'other_nol64': {'tests': ['a11yr', 04:49:12 INFO - 'ts_paint', 04:49:12 INFO - 'tpaint', 04:49:12 INFO - 'sessionrestore', 04:49:12 INFO - 'sessionrestore_no_auto_restore']}, 04:49:12 INFO - 'svgr': {'tests': ['tsvgx', 04:49:12 INFO - 'tsvgr_opacity', 04:49:12 INFO - 'tart', 04:49:12 INFO - 'tscrollx', 04:49:12 INFO - 'cart']}, 04:49:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:49:12 INFO - 'tests': ['tsvgx', 04:49:12 INFO - 'tsvgr_opacity', 04:49:12 INFO - 'tart', 04:49:12 INFO - 'tscrollx', 04:49:12 INFO - 'cart']}, 04:49:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'tests': ['tp5o']}, 04:49:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'talos_options': ['--e10s'], 04:49:12 INFO - 'tests': ['tp5o']}, 04:49:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'talos_options': ['--xperf_path', 04:49:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:12 INFO - 'tests': ['tp5n']}, 04:49:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'talos_options': ['--e10s', 04:49:12 INFO - '--xperf_path', 04:49:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:12 INFO - 'tests': ['tp5n']}}, 04:49:12 INFO - 'talos.zip': {'path': '', 04:49:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:49:12 INFO - Running post-action listener: _resource_record_post_action 04:49:12 INFO - ##### 04:49:12 INFO - ##### Running create-virtualenv step. 04:49:12 INFO - ##### 04:49:12 INFO - Running pre-action listener: _resource_record_pre_action 04:49:12 INFO - Running main action method: create_virtualenv 04:49:12 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:49:12 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:49:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:49:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:49:12 INFO - Using real prefix '/usr' 04:49:12 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:49:13 INFO - Installing distribute.............................................................................................................................................................................................done. 04:49:15 INFO - Installing pip.................done. 04:49:15 INFO - Return code: 0 04:49:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc12ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d6350>, '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 0x22d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d76e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', '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:49:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:49:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:49:15 INFO - Using env: {'DISPLAY': ':0', 04:49:15 INFO - 'HOME': '/home/cltbld', 04:49:15 INFO - 'LANG': 'en_US.UTF-8', 04:49:15 INFO - 'LANGUAGE': 'en_US:en', 04:49:15 INFO - 'LOGNAME': 'cltbld', 04:49:15 INFO - 'MAIL': '/var/mail/cltbld', 04:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:15 INFO - 'MOZ_NO_REMOTE': '1', 04:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:15 INFO - 'NO_EM_RESTART': '1', 04:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:49:15 INFO - 'PWD': '/builds/slave/test-pgo', 04:49:15 INFO - 'SHELL': '/bin/bash', 04:49:15 INFO - 'SHLVL': '1', 04:49:15 INFO - 'TERM': 'linux', 04:49:15 INFO - 'TMOUT': '86400', 04:49:15 INFO - 'USER': 'cltbld', 04:49:15 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', 04:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:15 INFO - '_': '/tools/buildbot/bin/python'} 04:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:15 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:49:15 INFO - Cleaning up... 04:49:15 INFO - Return code: 0 04:49:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbc12ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d6350>, '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 0x22d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d76e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', '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:49:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:49:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:49:15 INFO - Using env: {'DISPLAY': ':0', 04:49:15 INFO - 'HOME': '/home/cltbld', 04:49:15 INFO - 'LANG': 'en_US.UTF-8', 04:49:15 INFO - 'LANGUAGE': 'en_US:en', 04:49:15 INFO - 'LOGNAME': 'cltbld', 04:49:15 INFO - 'MAIL': '/var/mail/cltbld', 04:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:15 INFO - 'MOZ_NO_REMOTE': '1', 04:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:15 INFO - 'NO_EM_RESTART': '1', 04:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:49:15 INFO - 'PWD': '/builds/slave/test-pgo', 04:49:15 INFO - 'SHELL': '/bin/bash', 04:49:15 INFO - 'SHLVL': '1', 04:49:15 INFO - 'TERM': 'linux', 04:49:15 INFO - 'TMOUT': '86400', 04:49:15 INFO - 'USER': 'cltbld', 04:49:15 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', 04:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:15 INFO - '_': '/tools/buildbot/bin/python'} 04:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:15 INFO - Downloading/unpacking psutil>=0.7.1 04:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:17 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:49:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:49:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:49:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:17 INFO - Installing collected packages: psutil 04:49:17 INFO - Running setup.py install for psutil 04:49:17 INFO - building 'psutil._psutil_linux' extension 04:49:17 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:49:17 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:49:17 INFO - building 'psutil._psutil_posix' extension 04:49:17 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:49:17 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:49:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:18 INFO - Successfully installed psutil 04:49:18 INFO - Cleaning up... 04:49:18 INFO - Return code: 0 04:49:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbc12ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d6350>, '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 0x22d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d76e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', '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:49:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:49:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:49:18 INFO - Using env: {'DISPLAY': ':0', 04:49:18 INFO - 'HOME': '/home/cltbld', 04:49:18 INFO - 'LANG': 'en_US.UTF-8', 04:49:18 INFO - 'LANGUAGE': 'en_US:en', 04:49:18 INFO - 'LOGNAME': 'cltbld', 04:49:18 INFO - 'MAIL': '/var/mail/cltbld', 04:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:18 INFO - 'MOZ_NO_REMOTE': '1', 04:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:18 INFO - 'NO_EM_RESTART': '1', 04:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:49:18 INFO - 'PWD': '/builds/slave/test-pgo', 04:49:18 INFO - 'SHELL': '/bin/bash', 04:49:18 INFO - 'SHLVL': '1', 04:49:18 INFO - 'TERM': 'linux', 04:49:18 INFO - 'TMOUT': '86400', 04:49:18 INFO - 'USER': 'cltbld', 04:49:18 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', 04:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:18 INFO - '_': '/tools/buildbot/bin/python'} 04:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:49:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:49:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:20 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:49:20 INFO - Installing collected packages: mozsystemmonitor 04:49:20 INFO - Running setup.py install for mozsystemmonitor 04:49:20 INFO - Successfully installed mozsystemmonitor 04:49:20 INFO - Cleaning up... 04:49:20 INFO - Return code: 0 04:49:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:49:20 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:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:20 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:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:20 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 0x7fbc12ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d6350>, '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 0x22d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d76e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', '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:49:20 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:49:20 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:49:20 INFO - Using env: {'DISPLAY': ':0', 04:49:20 INFO - 'HOME': '/home/cltbld', 04:49:20 INFO - 'LANG': 'en_US.UTF-8', 04:49:20 INFO - 'LANGUAGE': 'en_US:en', 04:49:20 INFO - 'LOGNAME': 'cltbld', 04:49:20 INFO - 'MAIL': '/var/mail/cltbld', 04:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:20 INFO - 'MOZ_NO_REMOTE': '1', 04:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:20 INFO - 'NO_EM_RESTART': '1', 04:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:49:20 INFO - 'PWD': '/builds/slave/test-pgo', 04:49:20 INFO - 'SHELL': '/bin/bash', 04:49:20 INFO - 'SHLVL': '1', 04:49:20 INFO - 'TERM': 'linux', 04:49:20 INFO - 'TMOUT': '86400', 04:49:20 INFO - 'USER': 'cltbld', 04:49:20 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', 04:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:20 INFO - '_': '/tools/buildbot/bin/python'} 04:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:20 INFO - Downloading/unpacking blobuploader==1.2.4 04:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:22 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:49:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:49:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:49:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:22 INFO - Downloading docopt-0.6.1.tar.gz 04:49:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:49:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:22 INFO - Running setup.py install for blobuploader 04:49:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:22 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:49:22 INFO - Running setup.py install for requests 04:49:23 INFO - Running setup.py install for docopt 04:49:23 INFO - Successfully installed blobuploader requests docopt 04:49:23 INFO - Cleaning up... 04:49:23 INFO - Return code: 0 04:49:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:23 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 0x7fbc12ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d6350>, '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 0x22d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d76e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', '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:49:23 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:49:23 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:49:23 INFO - Using env: {'DISPLAY': ':0', 04:49:23 INFO - 'HOME': '/home/cltbld', 04:49:23 INFO - 'LANG': 'en_US.UTF-8', 04:49:23 INFO - 'LANGUAGE': 'en_US:en', 04:49:23 INFO - 'LOGNAME': 'cltbld', 04:49:23 INFO - 'MAIL': '/var/mail/cltbld', 04:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:23 INFO - 'MOZ_NO_REMOTE': '1', 04:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:23 INFO - 'NO_EM_RESTART': '1', 04:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:49:23 INFO - 'PWD': '/builds/slave/test-pgo', 04:49:23 INFO - 'SHELL': '/bin/bash', 04:49:23 INFO - 'SHLVL': '1', 04:49:23 INFO - 'TERM': 'linux', 04:49:23 INFO - 'TMOUT': '86400', 04:49:23 INFO - 'USER': 'cltbld', 04:49:23 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', 04:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:23 INFO - '_': '/tools/buildbot/bin/python'} 04:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:49:23 INFO - Running setup.py (path:/tmp/pip-5wj7Fb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:49:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:49:23 INFO - Running setup.py (path:/tmp/pip-O1MrxP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:49:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:49:23 INFO - Running setup.py (path:/tmp/pip-uqPAvQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:49:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:49:23 INFO - Running setup.py (path:/tmp/pip-th4y7F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:49:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:49:23 INFO - Running setup.py (path:/tmp/pip-DD34iM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:49:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:49:24 INFO - Running setup.py (path:/tmp/pip-hTtV1S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:49:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:49:24 INFO - Running setup.py (path:/tmp/pip-2iNMYX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:49:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:49:24 INFO - Running setup.py (path:/tmp/pip-IHoshH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:49:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:49:24 INFO - Running setup.py (path:/tmp/pip-Y39rpk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:49:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:49:24 INFO - Running setup.py (path:/tmp/pip-8TOpp5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:49:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:49:24 INFO - Running setup.py (path:/tmp/pip-Vt2GDS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:49:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:49:24 INFO - Running setup.py (path:/tmp/pip-SS7kir-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:49:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:49:24 INFO - Running setup.py (path:/tmp/pip-ntPRrq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:49:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:49:24 INFO - Running setup.py (path:/tmp/pip-MDWqNp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:49:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:49:24 INFO - Running setup.py (path:/tmp/pip-f3lW3E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:49:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:49:24 INFO - Running setup.py (path:/tmp/pip-HqImzk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:49:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:49:24 INFO - Running setup.py (path:/tmp/pip-ag5B4B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:49:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:49:24 INFO - Running setup.py install for manifestparser 04:49:24 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:49:24 INFO - Running setup.py install for mozcrash 04:49:25 INFO - Running setup.py install for mozdebug 04:49:25 INFO - Running setup.py install for mozdevice 04:49:25 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:49:25 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:49:25 INFO - Running setup.py install for mozfile 04:49:25 INFO - Running setup.py install for mozhttpd 04:49:25 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:49:25 INFO - Running setup.py install for mozinfo 04:49:25 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:49:25 INFO - Running setup.py install for mozInstall 04:49:25 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:49:25 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:49:25 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:49:25 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:49:25 INFO - Running setup.py install for mozleak 04:49:25 INFO - Running setup.py install for mozlog 04:49:25 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:49:25 INFO - Running setup.py install for moznetwork 04:49:25 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:49:25 INFO - Running setup.py install for mozprocess 04:49:26 INFO - Running setup.py install for mozprofile 04:49:26 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:49:26 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:49:26 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:49:26 INFO - Running setup.py install for mozrunner 04:49:26 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:49:26 INFO - Running setup.py install for mozscreenshot 04:49:26 INFO - Running setup.py install for moztest 04:49:26 INFO - Running setup.py install for mozversion 04:49:26 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:49:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:49:26 INFO - Cleaning up... 04:49:26 INFO - Return code: 0 04:49:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:26 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 0x7fbc12ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d6350>, '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 0x22d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d76e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', '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:49:26 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:49:26 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:49:26 INFO - Using env: {'DISPLAY': ':0', 04:49:26 INFO - 'HOME': '/home/cltbld', 04:49:26 INFO - 'LANG': 'en_US.UTF-8', 04:49:26 INFO - 'LANGUAGE': 'en_US:en', 04:49:26 INFO - 'LOGNAME': 'cltbld', 04:49:26 INFO - 'MAIL': '/var/mail/cltbld', 04:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:26 INFO - 'MOZ_NO_REMOTE': '1', 04:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:26 INFO - 'NO_EM_RESTART': '1', 04:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:49:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:49:26 INFO - 'SHELL': '/bin/bash', 04:49:26 INFO - 'SHLVL': '1', 04:49:26 INFO - 'TERM': 'linux', 04:49:26 INFO - 'TMOUT': '86400', 04:49:26 INFO - 'USER': 'cltbld', 04:49:26 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', 04:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:26 INFO - '_': '/tools/buildbot/bin/python'} 04:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:49:26 INFO - Running setup.py (path:/tmp/pip-IZgxhW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:49:26 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:49:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:49:26 INFO - Running setup.py (path:/tmp/pip-hLuXfl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:49:27 INFO - Running setup.py (path:/tmp/pip-NxEPCY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:49:27 INFO - Running setup.py (path:/tmp/pip-76zUg0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:49:27 INFO - Running setup.py (path:/tmp/pip-HOgAWU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:49:27 INFO - Running setup.py (path:/tmp/pip-4DhLzq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:49:27 INFO - Running setup.py (path:/tmp/pip-yqoiwr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:49:27 INFO - Running setup.py (path:/tmp/pip-UrgK6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:49:27 INFO - Running setup.py (path:/tmp/pip-y2Nq7O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:49:27 INFO - Running setup.py (path:/tmp/pip-x_x4Si-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:49:27 INFO - Running setup.py (path:/tmp/pip-gQ6g8_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:49:27 INFO - Running setup.py (path:/tmp/pip-DdsQBE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:49:27 INFO - Running setup.py (path:/tmp/pip-VsS5FL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:49:27 INFO - Running setup.py (path:/tmp/pip-jq1gMV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:49:27 INFO - Running setup.py (path:/tmp/pip-ut2jNI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:49:27 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:49:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:49:27 INFO - Running setup.py (path:/tmp/pip-olKBrj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:49:28 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:49:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:49:28 INFO - Running setup.py (path:/tmp/pip-eaJ4jK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:49:28 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:49:28 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:49:28 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:49:28 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:49:28 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:49:28 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:49:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:49:28 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:49:28 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:49:28 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:49:28 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:49:28 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:49:28 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:49:29 INFO - Downloading blessings-1.5.1.tar.gz 04:49:29 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:49:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:49:29 INFO - Installing collected packages: blessings 04:49:29 INFO - Running setup.py install for blessings 04:49:29 INFO - Successfully installed blessings 04:49:29 INFO - Cleaning up... 04:49:30 INFO - Return code: 0 04:49:30 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:49:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:49:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:49:30 INFO - Reading from file tmpfile_stdout 04:49:30 INFO - Current package versions: 04:49:30 INFO - argparse == 1.2.1 04:49:30 INFO - blessings == 1.5.1 04:49:30 INFO - blobuploader == 1.2.4 04:49:30 INFO - docopt == 0.6.1 04:49:30 INFO - manifestparser == 1.1 04:49:30 INFO - mozInstall == 1.12 04:49:30 INFO - mozcrash == 0.16 04:49:30 INFO - mozdebug == 0.1 04:49:30 INFO - mozdevice == 0.46 04:49:30 INFO - mozfile == 1.2 04:49:30 INFO - mozhttpd == 0.7 04:49:30 INFO - mozinfo == 0.8 04:49:30 INFO - mozleak == 0.1 04:49:30 INFO - mozlog == 3.0 04:49:30 INFO - moznetwork == 0.27 04:49:30 INFO - mozprocess == 0.22 04:49:30 INFO - mozprofile == 0.27 04:49:30 INFO - mozrunner == 6.11 04:49:30 INFO - mozscreenshot == 0.1 04:49:30 INFO - mozsystemmonitor == 0.0 04:49:30 INFO - moztest == 0.7 04:49:30 INFO - mozversion == 1.4 04:49:30 INFO - psutil == 3.1.1 04:49:30 INFO - requests == 1.2.3 04:49:30 INFO - wsgiref == 0.1.2 04:49:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:49:30 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:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:30 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:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:30 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 0x7fbc12ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d6350>, '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 0x22d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d76e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', '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:49:30 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:49:30 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:49:30 INFO - Using env: {'DISPLAY': ':0', 04:49:30 INFO - 'HOME': '/home/cltbld', 04:49:30 INFO - 'LANG': 'en_US.UTF-8', 04:49:30 INFO - 'LANGUAGE': 'en_US:en', 04:49:30 INFO - 'LOGNAME': 'cltbld', 04:49:30 INFO - 'MAIL': '/var/mail/cltbld', 04:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:30 INFO - 'MOZ_NO_REMOTE': '1', 04:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:30 INFO - 'NO_EM_RESTART': '1', 04:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:49:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:49:30 INFO - 'SHELL': '/bin/bash', 04:49:30 INFO - 'SHLVL': '1', 04:49:30 INFO - 'TERM': 'linux', 04:49:30 INFO - 'TMOUT': '86400', 04:49:30 INFO - 'USER': 'cltbld', 04:49:30 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', 04:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:30 INFO - '_': '/tools/buildbot/bin/python'} 04:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:30 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:49:30 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:49:30 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:49:30 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:49:30 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:49:30 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:49:30 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:49:30 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:49:30 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:49:30 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:49:30 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:49:30 INFO - Cleaning up... 04:49:30 INFO - Return code: 0 04:49:30 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:49:30 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:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:30 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:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:30 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 0x7fbc12ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d6350>, '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 0x22d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d76e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', '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:49:30 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:49:30 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:49:30 INFO - Using env: {'DISPLAY': ':0', 04:49:30 INFO - 'HOME': '/home/cltbld', 04:49:30 INFO - 'LANG': 'en_US.UTF-8', 04:49:30 INFO - 'LANGUAGE': 'en_US:en', 04:49:30 INFO - 'LOGNAME': 'cltbld', 04:49:30 INFO - 'MAIL': '/var/mail/cltbld', 04:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:30 INFO - 'MOZ_NO_REMOTE': '1', 04:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:30 INFO - 'NO_EM_RESTART': '1', 04:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:49:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:49:30 INFO - 'SHELL': '/bin/bash', 04:49:30 INFO - 'SHLVL': '1', 04:49:30 INFO - 'TERM': 'linux', 04:49:30 INFO - 'TMOUT': '86400', 04:49:30 INFO - 'USER': 'cltbld', 04:49:30 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', 04:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:30 INFO - '_': '/tools/buildbot/bin/python'} 04:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:30 INFO - Downloading/unpacking jsonschema 04:49:30 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:49:30 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:49:30 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:49:30 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:49:30 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:49:30 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:49:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:49:32 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:49:32 INFO - Downloading/unpacking functools32 (from jsonschema) 04:49:32 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:49:32 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:49:32 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:49:32 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:49:32 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:49:32 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:49:32 INFO - Downloading functools32-3.2.3-2.tar.gz 04:49:32 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:49:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:49:32 INFO - warning: no files found matching '*.txt' 04:49:32 INFO - no previously-included directories found matching 'build' 04:49:32 INFO - no previously-included directories found matching 'dist' 04:49:32 INFO - no previously-included directories found matching '.git*' 04:49:32 INFO - Installing collected packages: jsonschema, functools32 04:49:32 INFO - Running setup.py install for functools32 04:49:32 INFO - warning: no files found matching '*.txt' 04:49:32 INFO - no previously-included directories found matching 'build' 04:49:32 INFO - no previously-included directories found matching 'dist' 04:49:32 INFO - no previously-included directories found matching '.git*' 04:49:32 INFO - Successfully installed jsonschema functools32 04:49:32 INFO - Cleaning up... 04:49:32 INFO - Return code: 0 04:49:32 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:49: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:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:32 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 0x7fbc12ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d6350>, '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 0x22d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d76e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', '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:49:32 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:49:32 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:49:32 INFO - Using env: {'DISPLAY': ':0', 04:49:32 INFO - 'HOME': '/home/cltbld', 04:49:32 INFO - 'LANG': 'en_US.UTF-8', 04:49:32 INFO - 'LANGUAGE': 'en_US:en', 04:49:32 INFO - 'LOGNAME': 'cltbld', 04:49:32 INFO - 'MAIL': '/var/mail/cltbld', 04:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:32 INFO - 'MOZ_NO_REMOTE': '1', 04:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:32 INFO - 'NO_EM_RESTART': '1', 04:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:49:32 INFO - 'PWD': '/builds/slave/test-pgo', 04:49:32 INFO - 'SHELL': '/bin/bash', 04:49:32 INFO - 'SHLVL': '1', 04:49:32 INFO - 'TERM': 'linux', 04:49:32 INFO - 'TMOUT': '86400', 04:49:32 INFO - 'USER': 'cltbld', 04:49:32 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', 04:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:32 INFO - '_': '/tools/buildbot/bin/python'} 04:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:33 INFO - Downloading/unpacking flake8 04:49:33 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:49:33 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:49:33 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:49:33 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:49:33 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:49:33 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:49:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:49:34 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:49:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:49:34 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:49:34 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:49:34 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:49:34 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:49:34 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:49:34 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:49:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:49:34 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:49:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:49:34 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:49:34 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:49:34 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:49:34 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:49:34 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:49:34 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:49:35 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:49:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:49:35 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:49:35 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:49:35 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:49:35 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:49:35 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:49:35 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:49:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:49:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:49:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:49:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:49:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:49:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:49:35 INFO - no previously-included directories found matching 'docs/_build' 04:49:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:49:35 INFO - Running setup.py install for pep8 04:49:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:49:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:49:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:49:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:49:35 INFO - no previously-included directories found matching 'docs/_build' 04:49:35 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:49:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:49:35 INFO - Cleaning up... 04:49:35 INFO - Return code: 0 04:49:35 INFO - Running post-action listener: _resource_record_post_action 04:49:35 INFO - Running post-action listener: _start_resource_monitoring 04:49:35 INFO - Starting resource monitoring. 04:49:35 INFO - ##### 04:49:35 INFO - ##### Running install step. 04:49:35 INFO - ##### 04:49:35 INFO - Running pre-action listener: _resource_record_pre_action 04:49:35 INFO - Running main action method: install 04:49:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:49:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:49:35 INFO - Reading from file tmpfile_stdout 04:49:35 INFO - Detecting whether we're running mozinstall >=1.0... 04:49:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:49:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:49:35 INFO - Reading from file tmpfile_stdout 04:49:35 INFO - Output received: 04:49:35 INFO - Usage: mozinstall [options] installer 04:49:35 INFO - Options: 04:49:35 INFO - -h, --help show this help message and exit 04:49:35 INFO - -d DEST, --destination=DEST 04:49:35 INFO - Directory to install application into. [default: 04:49:35 INFO - "/builds/slave/test-pgo"] 04:49:35 INFO - --app=APP Application being installed. [default: firefox] 04:49:35 INFO - mkdir: /builds/slave/test-pgo/build/application 04:49:35 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:49:35 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:49:50 INFO - Reading from file tmpfile_stdout 04:49:50 INFO - Output received: 04:49:50 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:49:50 INFO - Running post-action listener: _resource_record_post_action 04:49:50 INFO - ##### 04:49:50 INFO - ##### Running run-tests step. 04:49:50 INFO - ##### 04:49:50 INFO - Running pre-action listener: _resource_record_pre_action 04:49:50 INFO - Running main action method: run_tests 04:49:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:49:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:49:50 INFO - Python 2.7.3 04:49:50 INFO - Return code: 0 04:49:50 INFO - grabbing minidump binary from tooltool 04:49:50 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:49:50 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 0x22d6350>, '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 0x22d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d76e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:49:50 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:49:50 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:49:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:49:50 INFO - Return code: 0 04:49:50 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:49:50 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:49:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:49:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:49:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:49:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:49:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:49:51 INFO - Return code: 0 04:49:51 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/1450246929/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:49:51 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/1450246929/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost 04:49:51 INFO - Using env: {'DISPLAY': ':0', 04:49:51 INFO - 'HOME': '/home/cltbld', 04:49:51 INFO - 'LANG': 'en_US.UTF-8', 04:49:51 INFO - 'LANGUAGE': 'en_US:en', 04:49:51 INFO - 'LOGNAME': 'cltbld', 04:49:51 INFO - 'MAIL': '/var/mail/cltbld', 04:49:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:49:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:51 INFO - 'MOZ_NO_REMOTE': '1', 04:49:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:51 INFO - 'NO_EM_RESTART': '1', 04:49:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:49:51 INFO - 'PWD': '/builds/slave/test-pgo', 04:49:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:49:51 INFO - 'SHELL': '/bin/bash', 04:49:51 INFO - 'SHLVL': '1', 04:49:51 INFO - 'TERM': 'linux', 04:49:51 INFO - 'TMOUT': '86400', 04:49:51 INFO - 'USER': 'cltbld', 04:49:51 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604', 04:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:51 INFO - '_': '/tools/buildbot/bin/python'} 04:49:51 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/1450246929/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] with output_timeout 3600 04:49:51 INFO - mozversion INFO | application_buildid: 20151215222209 04:49:51 INFO - mozversion INFO | application_changeset: b2d75585bfc485f884f2822b0541f694b069d87c 04:49:51 INFO - mozversion INFO | application_display_name: Nightly 04:49:51 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:49:51 INFO - mozversion INFO | application_name: Firefox 04:49:51 INFO - mozversion INFO | application_remotingname: firefox 04:49:51 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:49:51 INFO - mozversion INFO | application_vendor: Mozilla 04:49:51 INFO - mozversion INFO | application_version: 44.0 04:49:51 INFO - mozversion INFO | platform_buildid: 20151215222209 04:49:51 INFO - mozversion INFO | platform_changeset: b2d75585bfc485f884f2822b0541f694b069d87c 04:49:51 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:49:51 INFO - mozversion INFO | platform_version: 44.0 04:49:51 INFO - 2015-12-16 04:49:51,330 DEBUG : using testdate: 1450270191 04:49:51 INFO - 2015-12-16 04:49:51,331 DEBUG : actual date: 1450270191 04:49:51 INFO - 2015-12-16 04:49:51,339 INFO : starting webserver on 'localhost:55964' 04:49:51 INFO - 2015-12-16 04:49:51,340 INFO : Starting test suite talos-linux64-ix-037 04:49:51 INFO - 2015-12-16 04:49:51,341 INFO : Starting test dromaeo_css 04:49:51 INFO - 2015-12-16 04:49:51,341 DEBUG : operating with platform_type : linux_ 04:49:51 INFO - 2015-12-16 04:49:51,341 INFO : Initialising browser for dromaeo_css test... 04:49:51 INFO - 2015-12-16 04:49:51,356 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCEZWXG/profile http://localhost:55964/getInfo.html 04:49:55 INFO - 2015-12-16 04:49:55,092 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:49:55 INFO - 2015-12-16 04:49:55,092 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:49:55 INFO - 2015-12-16 04:49:55,092 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:49:55 INFO - 2015-12-16 04:49:55,092 DEBUG : BROWSER_OUTPUT: __metrics 04:49:55 INFO - 2015-12-16 04:49:55,214 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:49:56 INFO - 2015-12-16 04:49:56,475 INFO : Browser initialized. 04:49:56 INFO - 2015-12-16 04:49:56,476 INFO : Running cycle 1/1 for dromaeo_css test... 04:49:56 INFO - 2015-12-16 04:49:56,476 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCEZWXG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:50:08 INFO - 2015-12-16 04:50:08,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 131768320 04:50:08 INFO - 2015-12-16 04:50:08,052 DEBUG : BROWSER_OUTPUT: 04:50:58 INFO - 2015-12-16 04:50:58,818 DEBUG : BROWSER_OUTPUT: 1450270258810 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] 04:53:06 INFO - 2015-12-16 04:53:06,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55964/tests/dromaeo/cssquery-ext.html) 04:53:07 INFO - 2015-12-16 04:53:07,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 229580800 04:53:07 INFO - 2015-12-16 04:53:07,908 DEBUG : BROWSER_OUTPUT: 04:56:09 INFO - 2015-12-16 04:56:09,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/dromaeo/cssquery-ext.html (next: http://localhost:55964/tests/dromaeo/cssquery-jquery.html) 04:56:10 INFO - 2015-12-16 04:56:10,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 209702912 04:56:10 INFO - 2015-12-16 04:56:10,451 DEBUG : BROWSER_OUTPUT: 04:59:12 INFO - 2015-12-16 04:59:12,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55964/tests/dromaeo/cssquery-mootools.html) 04:59:12 INFO - 2015-12-16 04:59:12,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 204877824 04:59:12 INFO - 2015-12-16 04:59:12,658 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-12-16 05:02:14,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55964/tests/dromaeo/cssquery-prototype.html) 05:02:14 INFO - 2015-12-16 05:02:14,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 197197824 05:02:14 INFO - 2015-12-16 05:02:14,932 DEBUG : BROWSER_OUTPUT: 05:05:17 INFO - 2015-12-16 05:05:17,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55964/tests/dromaeo/cssquery-yui.html) 05:05:17 INFO - 2015-12-16 05:05:17,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 196022272 05:05:17 INFO - 2015-12-16 05:05:17,805 DEBUG : BROWSER_OUTPUT: 05:08:19 INFO - 2015-12-16 05:08:19,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/dromaeo/cssquery-yui.html (next: http://localhost:55964/tests/dromaeo/cssquery-dojo.html) 05:08:20 INFO - 2015-12-16 05:08:20,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 236933120 05:08:20 INFO - 2015-12-16 05:08:20,090 DEBUG : BROWSER_OUTPUT: 05:08:20 INFO - 2015-12-16 05:08:20,091 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:08:20 INFO - 2015-12-16 05:08:20,092 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:08:20 INFO - 2015-12-16 05:08:20,092 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:08:20 INFO - 2015-12-16 05:08:20,092 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:08:20 INFO - 2015-12-16 05:08:20,093 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3294.9505757413644;3388.390089783838;3422.6577342265778;3428.3486137633863;3445.9138521536956;5633.577481688869;5641.294838145232;5653.982283189024;5660.60375773696;5672.234248376468;5671.262735844334;5681.261436013323;5685;5691.004074287004;5691.686957217351;4909.68087074339;5128.230765385185;5153.072446959546;5236.083685355066;5276.498732620395;4984.252362145689;5083.389993200803;5102.566281866028;5128.871778205556;5130.486951304877;5047.4447810740785;5090.211017292307;5095.490450954912;5106.157484015133;5109.489051094898;5167.819126330561;5221.843344699646;5242.213667949838;5243.397009343936;5246.685198888079;4930.605551555867;4948.455669876311;5009.398872135331;5054.469280725508;5135.3324067870935;5460.34475862895;5473.8357849264585;5481.698506582136;5494.697791621459;5507.752151153208;6118.4799292060225;6120.846978825521;6124.5100391968535;6134.693265336716;6143.078538219258;5898.4101589840675;5945.643261404286;5985.4912332451795;6052.636841789506;6059.515238780887;5649.0114230009585;5650.63270887391;5654.095344744862;5659.236003139524;5671.177679236487;6169.96915015422;6176.258848938156;6187.752489900444;6189.566730328834;6195.287541932646;5644;5734.910367030251;5842.561807864342;5915.201447804578;5936.22829032223;6079.817605471843;6102.0541816018585;6125.326214116443;6132.724027418777;6133.080037994337;5755.539556835443;6074.51403887688;6080.6047606906295;6082.1789058477425;6085.2393450818645;5905.114232865105;5988.131720900445;6058.606190597597;6073.18012068374;6104.938950610526;4628.421447319085;4628.652851036186;4631;4635.258358662598;4654.906901861944;4046.615571520701;4128.339465685536;4134.462519872397;4150.439690641725;4180.143070670505;5647.068233741386;5780.71096445176;5809.128630705343;5816.272965879265;5838.766449341979;6039.245094363205;6103.938960610426;6106.908396374058;6114.144019837227;6116.510679145657;5464.480874316933;5582.413846546055;5589.161625756169;5685.573581981285;5717.085266357363;5239.554637855748;5239.816606418757;5250.842474725764;5261.579073674096;5289.418164001957;6209.192804935329;6209.59637623553;6214.906776398358;6219.751209951552;6221.440070393596;5876.647401155944;5974;6040;6103.908441373472;6173.135760993554;6308.873822523432;6327.96836015817;6332.081848131903;6342.23893132827;6347.238331400077;6041;6079.361667025076;6092.329843717276;6096.237970253718;6096.847578810565;5761.222234998221;5854.795082172103;6040.909386359296;6118.010103775335;6129.816105516842;5936.643801371932;5944.078667806497;5944.167816505779;5954.404559544011;5955.493783028491;5683.3748287687495;5935.2877654681715;5938.8218353449465;5946.821595352147;5957.582969192115;5718.370979192368;5728.713564321684;5829.679367634821;5838.649681019152;5864.32560255576;5795.884082318245;5817.069268916953;5817.360090389969;5841.532677385714;5933.050711886078;5681.0626246668835;5709.314882214161;5714.428557144252;5744.109663002241;5779.653220806596 05:08:20 INFO - 2015-12-16 05:08:20,097 DEBUG : BROWSER_OUTPUT: |1;ext.html;585.7891159182697;621.2824188062788;631.4884943196008;631.725199538201;684.076496729415;35334.293314133734;42182.78908605457;42638.99999999992;42645.14709705804;42690.57309426905;47195.76402117984;48310.275345869755;48430.51569484313;48444;48451.51548484514;8288.958555207246;8423.15768423159;8953.149450802164;9213.30900182489;9230.261579073658;11253.437328133561;11450.942745286262;11486.655400338002;11493;11502.712432189179;11087.168462365315;11165.050970667504;11185.217034807567;11187;11192.720181995475;11043.447827608587;11122.666320010332;11134.443277836075;11137.276077055007;11152.944235278852;10862.78274434507;10944.3980581068;10969.616063437741;10975.176861735401;11032.779344413148;44004.339934901;44296.335554966376;44421.33367999482;44425.33361999573;44425.33361999573;3283.3761585298957;3398.303347813692;4031.3348297530874;4132.421460995463;4180.184863951531;32969.3406131876;33356.66643333584;33552.16119597005;33848.83075584631;34347;3817.9045523861846;3874.670652994499;3892.104815892332;3953.782541960191;4007.0182805212908;302090;302697;303929;305231;306202.9999999978;64139.679301603195;65185.674071629335;66479.33520664828;66568;68350;69325.3067469329;69479;69595.65202173957;69766.65116674385;69783;16980.660386792195;17212.655746884993;17243.827561724473;17265.654686906193;17303.307867685402;13057;13232.338383080807;13235.470581176838;13404.865951340556;13442.395092220873;21683.34949951504;21845.45386365322;21893.890530547564;21909.452263693536;21927.67108493374;7312.416915711369;7731.226877312224;7752.883706744404;7756.146823849372;7836.451448398558;853.7353420439683;955.7037318431309;1055.3404122423485;1089.591403223791;1179.351356753782;30141.397172056873;30544.847275763477;30758;31636.683633163833;33509.49735753966;1041.3231399590327;1078.9352638841694;1081.167501024207;1139.789139009286;1141.1384404774342;13513.459461621622;13692.452301908012;14212.786808197678;16201.59496012609;16605.791091013518;292320;295909;296261;296863;297244;55977.72011139918;56171.71914140403;56262.43737562654;56263.156052659244;56280.155797663065;1344.193483909666;1353.2759973414372;1450.4125829039256;1450.5720812360169;1465.4211586423517;30189;30232.54651180278;30284.697153028188;30809.38381232318;31170;53257.4674253268;53594.46405535895;53638.463615364904;53697.463025369245;53730.194047088546;337881;338539;339858;340546;341781;35853.82073089618;36465.63534364622;36544.26911461809;36679.08302292357;36763.816180918926;47245.2913206309;47385.28922066103;47831;47879.5212047875;48513.757431212616;39341.21317573575;39686.40470393004;39845;40120.598794012854;40974.79512602418;38617.42073868951;39474.40788388119;40191.598084018784;40294.1941161181;40753;39155.41266880942;39559.40660890147;40014;40247.79876100601;40248.3962740565;34279.65720342765;34381.31237375289;35028;35072.29855402827;35188.296234075686;27038.72961270362;27615.2885335998;27759.30601734892;28060.71939280581;29238.41523169567 05:08:20 INFO - 2015-12-16 05:08:20,098 DEBUG : BROWSER_OUTPUT: |2;jquery.html;386.2622391232746;388.06282826972864;391.30347980594536;391.6025234387097;397.09264331003664;12687.555935542257;15258.465953691622;17181.742273865886;18956.810431895676;18985.810141898593;18081.276748930028;18259.726104108417;18306.908465457655;18824.15291311894;19257;5548.750306236209;5667.971660141693;5679.659220446766;5687.7156142192935;5689.11818668105;4432.445944256968;4539.841105561306;5622.128570071625;6292.1820163378925;6495.447886929593;6287.528435367343;6355.046742988542;6383.872322553546;6390.073439351315;6420.743170273184;6329.05064240363;6335.936640633581;6347;6349.079383489415;6359.077933699634;5724.055530837407;5735.827925162252;5819.330776960619;5819.7963071292725;5868.618539794899;22893.885530572406;23723.288301350985;23765.049398024057;23937.760622393725;24238.15166469165;2310.353101131686;2313.3175713164655;2324.7675232476786;2433.9269821905373;2466.8766561671846;14487.130772153705;14694.485693000694;14717.926410367987;14731.484398046125;15078.849211507853;1865.9067046647613;1939.4666466721765;1970.8916009619466;1980.1188471130354;1982.6431242376366;62590.687046565385;70274.64862675653;70729.64635176843;72333.2766672337;73643;7795.883061754078;7918.445708800444;8088.231617996281;8129.3090087343235;8143.837123257502;9685.6610018649;9725.61097556104;9732.854007189897;9736.561854716554;9757;6444.291127975919;6491.610503369719;6519.837004074936;6526.608403495806;6535.44448721864;6617.8014659560295;6644.734210631617;6656.434203092791;6773.762918297836;6812.216595091529;3702.0559757261726;3734.9066273343383;3735.6824669903363;3754.8685795997553;3757.830897609614;1259.2633309513853;1275.9234445933273;1278.514164617458;1291.6189724031433;1295.0804928500681;501.55111175498456;507.92888995540653;509.36075225591645;519.6128883981459;520.2066848056744;11606.361650109156;12785.488580456678;12945.417456214493;13403.128796628189;13511.391987360395;524.9238860365302;530.3185406752305;542.1894268069261;558.2324304081887;584.8187062010705;7005.579665220103;7238;7284.344409003215;7438.5908775016815;7633.313001829862;662586;672548;679194;683727;683872.5806370936;81413;86056.56971715101;86450;87861.56069219741;88461.55769221112;605.5186127029023;617.6325086573481;620.5407998081387;620.9782657606962;626.6866566716642;11948.462319195483;12083;12114.575989840314;12226.327551984727;12240.816387754012;37257.25485490221;38794.6120538791;39638.40542391924;39641;40316.39525407062;48574.75712621414;49005.50994490152;50138.49861501484;55278.72360638171;55430;7385.113786345673;7539;7592.8481430369975;7602.087749470099;7613.505122167041;12953.352332383154;13135.211887286794;13229.867701322864;13365.331733413095;13529.932350338186;10867.673969780919;10883.67348979532;10917.454127293444;11300.773984520429;11316.37759923212;11500.654980350602;11518.481668325114;11581.305121692725;11835.467403967014;12037.819432708691;9112.453252804853;10566.735831603964;10634;10642.04221620058;10898;7236.638168091679;7254.492185546961;7322.157951835394;7324.707011719472;7327.926720732938;10721.142308615135;10744.19418543628;10802.351858888493;11001.22991390595;11154 05:08:20 INFO - 2015-12-16 05:08:20,100 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1515.780211869279;1518.5747990562643;1724.9913750431253;1858.2009735813594;1867.1691097461626;6346.14327065846;6448.419642232192;6450.193725784277;6483.740650373985;6488.3187265337165;7041.260667629902;7263.818404539889;7805.960970195155;7982.082060563037;8030.799230019238;2379.3694670912264;2395.077895010425;2421.7457166997474;2422.903083876643;2425.3087869957067;2114.947126321839;2343.7656234376595;2370.762923707624;2393.4614711689906;2405.759424057589;2085.2076211039785;2282.7945484906354;2309.9884500577473;2310.0528783198893;2310.1798861404213;2335.90656373744;2345.413646588353;2346.9882650586724;2397.3167647220457;2397.9040838366445;2381.3332266965276;2392.760723927611;2416.516696660675;2420.673209116782;2431.088341871798;7941.64262608184;7967.123616402191;8022.27799498048;8027.919720802775;8037.598120093972;4834.081524510367;4891.608671306287;4902.19113846215;4908.460069392364;4908.754562271872;3357.4124528207467;3373.291608762163;3383.915402114942;3414.436617958034;3417.2482053948092;1165.1086918507349;1176.923499972499;1185.4013723069882;1199.0287866827898;1237.202004706968;10556.947215263874;10583.576656933714;10595.629152979685;10599.417032063233;10601.098906592872;4447.466304043535;4456.242438785414;4494.640428765691;4495.370648109268;4502.122086193161;9143.49710765901;9153.313501487282;9157.038510956254;9168.495732734631;9168.633254669872;4827.372441582572;4827.517248275215;4829.879253018632;4833.516648335139;4836.782344794493;4439.245328294198;4440.711353761995;4445.110977804452;4448.755318457451;4449.7330160190495;3896.5713771485116;3952.5256969163884;3953.090789118519;3973.8807835764396;3977.985613668496;1170.9531618735325;1204.5783975608642;1253.7429826885466;1305.28209484783;1306.8431788185478;1107.9446027698582;1112.0991996482874;1180.9548549533554;1401.6145559970885;1485.5543336999074;7575.393968482508;7592.81017974555;7682.385409167253;7695.422843286776;7701.114371847198;1105.5854054729477;1146.7362506623356;1189.8572171339495;1190.4166958190597;1197.2277880766856;6056.424639659225;6144.907826382608;6151.138840562325;6151.907721384183;6156.445919867144;9208;9548.665796697082;9556.139947404767;9564.56959436827;9573.808523829484;9730.36752611078;9743.853842192373;9755.170810481188;9769.951150244204;9771.267154963407;7393.186749457555;7649.311561959339;7672.271134242238;7679.654415551314;7699.345555627722;7328.120625524971;7432.888506672296;7498.775036748906;7503.624818759149;7512.436567257587;8649.567521623767;8858.778530536789;8870.73387798367;8902.55487225649;8910.910890891008;8751.69369072105;8931.374803763674;8953;8966.641334346554;9091.181793638605;7208.531445456028;7213.314735100157;7277.927220727936;7295.051643286551;7298.2701729826595;7806.297433231037;7914.44598878073;7951.681932722858;7966.800829979297;7982.08206056311;6573.079768832463;7458.627068646654;7584.772456826304;7599.164091949991;7644.235576442311;6677.69950352245;7302.306280903305;7314.451416143704;7390.482666213314;7436.256374362737;7391.445641576795;7394.55632662042;7403.925960740324;7434.36807871337;7441.739539116322;6844.315568443315;6912.135983002125;6947.096877405905;6947.79156625302;6964.233934267328;6647.867042659216;6736.292689267556;6737.764178253738;6742.561733487308;6744.730210791513 05:08:20 INFO - 2015-12-16 05:08:20,101 DEBUG : BROWSER_OUTPUT: |4;prototype.html;363.09408026972704;368.7990045425243;369.83727160049557;369.96485333893287;373.4883210002299;5992.880142397149;6000.48995835354;6024.9698751506185;6035.879282414349;6051.243594550676;5743.081107022877;5774.5091667208335;5827.35899051104;5938.46553810157;5965.045592705168;4652.97673511632;4667.113248482794;4674.0418214266165;4674.439067311927;4688.437387513503;4607.35497030416;4671;4683.69555978862;4687.460941991663;4693.108309421199;4636.721796692193;4637.0725854829;4644.814207431698;4646.3727396801505;4646.72119672819;4554.72671639701;4635.791389387452;4640.883977900546;4644.9535504644855;4646.954435252058;4070.61329173728;4074.8777536673947;4077.673786097105;4091.243120022805;4097.037196258877;5628.662280263156;5628.802991895264;5634.661920284796;5642.915356269659;5648.463395977416;5319.441458646864;5332.92000619991;5338.599605029638;5341.359036915595;5352.143657014859;6205.131281620576;6247.812565623039;6268.937310626881;6287;6287.9056814147825;4470.664700147502;4476.485204201526;4478.8880277992985;4480.529544397824;4481.753503557303;6427.58220715652;6435.420812126931;6479.967600161969;6491.837704057342;6499.317571655003;4498.055408364215;4547.840825571089;4585.95414045862;4586.564276393738;4641.094986477672;4680.134175177603;4681.063787242497;4685.1332503486965;4686.507916668701;4686.8593942181105;5366.543843773245;5371.274877891513;5374.167004114369;5378.91931621026;5380.300560927054;6313.526485513605;6338.397852204033;6354.23749150105;6367.522435817332;6375.234971803413;1646.0535192264497;1675.6481138960712;1686.325469812085;1689.121656738489;1694.940677076321;1058.1746237934424;1116.4975760907623;1141.1612464838338;1157.7568710570706;1163.6974386659529;6028.487578555784;6074.878502430015;6075.787347442907;6081.087836824423;6082.513398928075;6357.936420635827;6383.744650214032;6407.359264073555;6410.45511131559;6446.194225721785;5956.195913551615;6058.848528786815;6059.848503787441;6065.757369705162;6083.543734219951;3580.1944562473755;3593.1735700788963;3609.5488063992;3612.115031817169;3612.7651702639246;6701.497387695942;6707.5975441473665;6709.36261055199;6715.597064176165;6717.596944183365;6656.334366563305;6665.900011499832;6711.395974362331;6716.46268298535;6718.160229971254;6708.396244338033;6723.865522689616;6741.460683145435;6742.190937087483;6748.19021717397;6561.573497722633;6563.212414510289;6571.408573228432;6571.934280657323;6573.309802470863;6340.302566717565;6404.455621272244;6415.743370265137;6491.5131365148745;6509.934900650933;6658.300878407697;6680;6745.696443660146;6774.119364482585;6779.35596118368;4597.517260687579;4638.5593368629925;4642.16441040616;4644.140833945731;4645.047765208056;6486.254080780771;6588.209414870246;6592.110065141144;6598.04328372393;6601.933980660132;6458.321876202931;6459.063435801876;6465;6465.256495502889;6466.773662921775;6450;6450.129232553545;6453.096566480603;6456.644884531396;6457.0637257596445;6277.654728989949;6313.337099604475;6320.652364120017;6338.90491642635;6344.206974128234;6441.1304473895425;6505.089287499848;6512;6516.120323756232;6521.445677117498;6296.559240853279;6303.716332765129;6310.905336420049;6312.905306420315;6346.111544383883 05:08:20 INFO - 2015-12-16 05:08:20,105 DEBUG : BROWSER_OUTPUT: |5;yui.html;669.748844183431;694.9096617439732;830.9376796740244;836.9539675317857;853.2704537620334;14760.33578488968;15169.92415037926;15182.6963460731;15233.009854359472;15259.313330900108;14596.708065838704;14643.926780366084;14650.560483185494;14658.560243192722;14705.411783528645;780.6565111350988;786.4141214794986;923.4367036107968;930.902255263196;945.2154711589365;927.4018258223442;928;929.4376901974309;935.0088905759882;935.7005758157393;967.5452537307455;977.5307852230933;978.4569563892037;983.8179936711731;984.7685793838442;800.8398320335956;813.8535063688533;958.7315551645585;965.0253244223314;971.9659811906549;723.4682508356353;726.2156870579761;727.2908913809047;728.446380750628;729.3800269770705;13975.720485590333;14157.22135282559;14161.858381416157;14179;14257.930655200902;11878.346690931996;12353.691157721129;12769.36153192346;13590.660233494144;14166.645833854132;10542.78914421715;10705.625303114432;10867.619633312876;10961.506732196991;11128.666140015812;3824.063104539378;3831.1954489556947;3891.8248678809523;3907.5310962684375;3964.127891863814;52049;52484.737576312255;52594;54117.72941135309;54200;8785.34109941757;8803.427777194462;8839.29285657146;8873.822523549492;8967.327450441244;20518.179272829217;20658.483537911372;20713.58572828535;20768.68846967297;20771.792282077287;7802.570858602831;7945.0863150738405;7960.960195198987;7972.3622110231045;7987.1214166442805;4573.679842410999;4681.976590117096;4684.74233917131;4707.929381059287;4730.337752714623;3255.641879393265;3290.901272961815;3295.6374798772117;3302.8513716882317;3305.0415379539663;471.6533347989225;492.51979320162553;495.1285737102725;539.5872157799287;566.1790403914341;605.2766943502472;646.9126667899774;679.4869873245668;682.952193346471;692.7817737412698;8540.359473039423;9670;9735.1725103367;9812.754681133028;9949.452780097019;567.6367125039977;673.8854394752904;695.0165515795094;695.7182341151841;707.2361849202952;4215.430916826251;4469.530699276529;4495.505494395614;4505.211587972091;4519.276915693474;65853.34146658472;66344.33655663382;66404;66688.33311666918;66755;58776;59201.40798591959;59995.700021499615;60016;60224.69887650621;54203.18695219496;54211.45788542143;54650;55011.72494137504;55651.77392904319;8987.910120898707;9216.354855160344;9294.395864268801;9467.479129730862;9496.14534691881;39168.412473813485;39342;40396.596034039285;40629.390559141044;41214.58785412108;47049;47137.2929406066;52311.47688523066;54889.451105488435;55053.72473137609;7445.813854653677;7488.326050655467;7591.127020392725;8345.666173352998;8404.075551689431;11757.470913808727;11854.94072529632;12032;12062.638120856038;12269.69325766863;11083.833742493707;11144.164187685794;11168.162387821108;11170.720731981766;11439.828402573801;11333.716657083638;11486.827697584376;11542.94228528852;11928.701782455508;12201.08491863096;11160.720981975515;11342.149338799458;11388.772224555629;11574;11590.362530060927;9793.706188814347;10013.098821106136;10070.194384449373;10134.797304054026;10433.26967112295;9887.950560247153;9993.850092248767;10010.499475026365;10028.498575071364;10303 05:08:20 INFO - 2015-12-16 05:08:20,105 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:08:20 INFO - 2015-12-16 05:08:20,105 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:08:20 INFO - 2015-12-16 05:08:20,106 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,767 05:08:20 INFO - 2015-12-16 05:08:20,106 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:08:20 INFO - 2015-12-16 05:08:20,106 DEBUG : BROWSER_OUTPUT: __startTimestamp1450271300090__endTimestamp 05:08:20 INFO - 2015-12-16 05:08:20,106 DEBUG : BROWSER_OUTPUT: 05:08:20 INFO - 2015-12-16 05:08:20,107 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:08:20 INFO - 2015-12-16 05:08:20,107 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:08:20 INFO - 2015-12-16 05:08:20,107 DEBUG : BROWSER_OUTPUT: 05:08:20 INFO - 2015-12-16 05:08:20,107 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5607.49 Median:5779.65 stddev:628.59 (10.9%) stddev-sans-first:603.78 05:08:20 INFO - 2015-12-16 05:08:20,107 DEBUG : BROWSER_OUTPUT: Values: 3295.0 3388.4 3422.7 3428.3 3445.9 5633.6 5641.3 5654.0 5660.6 5672.2 5671.3 5681.3 5685.0 5691.0 5691.7 4909.7 5128.2 5153.1 5236.1 5276.5 4984.3 5083.4 5102.6 5128.9 5130.5 5047.4 5090.2 5095.5 5106.2 5109.5 5167.8 5221.8 5242.2 5243.4 5246.7 4930.6 4948.5 5009.4 5054.5 5135.3 5460.3 5473.8 5481.7 5494.7 5507.8 6118.5 6120.8 6124.5 6134.7 6143.1 5898.4 5945.6 5985.5 6052.6 6059.5 5649.0 5650.6 5654.1 5659.2 5671.2 6170.0 6176.3 6187.8 6189.6 6195.3 5644.0 5734.9 5842.6 5915.2 5936.2 6079.8 6102.1 6125.3 6132.7 6133.1 5755.5 6074.5 6080.6 6082.2 6085.2 5905.1 5988.1 6058.6 6073.2 6104.9 4628.4 4628.7 4631.0 4635.3 4654.9 4046.6 4128.3 4134.5 4150.4 4180.1 5647.1 5780.7 5809.1 5816.3 5838.8 6039.2 6103.9 6106.9 6114.1 6116.5 5464.5 5582.4 5589.2 5685.6 5717.1 5239.6 5239.8 5250.8 5261.6 5289.4 6209.2 6209.6 6214.9 6219.8 6221.4 5876.6 5974.0 6040.0 6103.9 6173.1 6308.9 6328.0 6332.1 6342.2 6347.2 6041.0 6079.4 6092.3 6096.2 6096.8 5761.2 5854.8 6040.9 6118.0 6129.8 5936.6 5944.1 5944.2 5954.4 5955.5 5683.4 5935.3 5938.8 5946.8 5957.6 5718.4 5728.7 5829.7 5838.6 5864.3 5795.9 5817.1 5817.4 5841.5 5933.1 5681.1 5709.3 5714.4 5744.1 5779.7 05:08:20 INFO - 2015-12-16 05:08:20,107 DEBUG : BROWSER_OUTPUT: 05:08:20 INFO - 2015-12-16 05:08:20,108 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50581.32 Median:34364.16 stddev:81825.47 (238.1%) stddev-sans-first:81968.91 05:08:20 INFO - 2015-12-16 05:08:20,109 DEBUG : BROWSER_OUTPUT: Values: 585.8 621.3 631.5 631.7 684.1 35334.3 42182.8 42639.0 42645.1 42690.6 47195.8 48310.3 48430.5 48444.0 48451.5 8289.0 8423.2 8953.1 9213.3 9230.3 11253.4 11450.9 11486.7 11493.0 11502.7 11087.2 11165.1 11185.2 11187.0 11192.7 11043.4 11122.7 11134.4 11137.3 11152.9 10862.8 10944.4 10969.6 10975.2 11032.8 44004.3 44296.3 44421.3 44425.3 44425.3 3283.4 3398.3 4031.3 4132.4 4180.2 32969.3 33356.7 33552.2 33848.8 34347.0 3817.9 3874.7 3892.1 3953.8 4007.0 302090.0 302697.0 303929.0 305231.0 306203.0 64139.7 65185.7 66479.3 66568.0 68350.0 69325.3 69479.0 69595.7 69766.7 69783.0 16980.7 17212.7 17243.8 17265.7 17303.3 13057.0 13232.3 13235.5 13404.9 13442.4 21683.3 21845.5 21893.9 21909.5 21927.7 7312.4 7731.2 7752.9 7756.1 7836.5 853.7 955.7 1055.3 1089.6 1179.4 30141.4 30544.8 30758.0 31636.7 33509.5 1041.3 1078.9 1081.2 1139.8 1141.1 13513.5 13692.5 14212.8 16201.6 16605.8 292320.0 295909.0 296261.0 296863.0 297244.0 55977.7 56171.7 56262.4 56263.2 56280.2 1344.2 1353.3 1450.4 1450.6 1465.4 30189.0 30232.5 30284.7 30809.4 31170.0 53257.5 53594.5 53638.5 53697.5 53730.2 337881.0 338539.0 339858.0 340546.0 341781.0 35853.8 36465.6 36544.3 36679.1 36763.8 47245.3 47385.3 47831.0 47879.5 48513.8 39341.2 39686.4 39845.0 40120.6 40974.8 38617.4 39474.4 40191.6 40294.2 40753.0 39155.4 39559.4 40014.0 40247.8 40248.4 34279.7 34381.3 35028.0 35072.3 35188.3 27038.7 27615.3 27759.3 28060.7 29238.4 05:08:20 INFO - 2015-12-16 05:08:20,109 DEBUG : BROWSER_OUTPUT: 05:08:20 INFO - 2015-12-16 05:08:20,109 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32587.40 Median:508.64 stddev:110717.65 (21767.2%) stddev-sans-first:111001.84 05:08:20 INFO - 2015-12-16 05:08:20,109 DEBUG : BROWSER_OUTPUT: Values: 386.3 388.1 391.3 391.6 397.1 12687.6 15258.5 17181.7 18956.8 18985.8 18081.3 18259.7 18306.9 18824.2 19257.0 5548.8 5668.0 5679.7 5687.7 5689.1 4432.4 4539.8 5622.1 6292.2 6495.4 6287.5 6355.0 6383.9 6390.1 6420.7 6329.1 6335.9 6347.0 6349.1 6359.1 5724.1 5735.8 5819.3 5819.8 5868.6 22893.9 23723.3 23765.0 23937.8 24238.2 2310.4 2313.3 2324.8 2433.9 2466.9 14487.1 14694.5 14717.9 14731.5 15078.8 1865.9 1939.5 1970.9 1980.1 1982.6 62590.7 70274.6 70729.6 72333.3 73643.0 7795.9 7918.4 8088.2 8129.3 8143.8 9685.7 9725.6 9732.9 9736.6 9757.0 6444.3 6491.6 6519.8 6526.6 6535.4 6617.8 6644.7 6656.4 6773.8 6812.2 3702.1 3734.9 3735.7 3754.9 3757.8 1259.3 1275.9 1278.5 1291.6 1295.1 501.6 507.9 509.4 519.6 520.2 11606.4 12785.5 12945.4 13403.1 13511.4 524.9 530.3 542.2 558.2 584.8 7005.6 7238.0 7284.3 7438.6 7633.3 662586.0 672548.0 679194.0 683727.0 683872.6 81413.0 86056.6 86450.0 87861.6 88461.6 605.5 617.6 620.5 621.0 626.7 11948.5 12083.0 12114.6 12226.3 12240.8 37257.3 38794.6 39638.4 39641.0 40316.4 48574.8 49005.5 50138.5 55278.7 55430.0 7385.1 7539.0 7592.8 7602.1 7613.5 12953.4 13135.2 13229.9 13365.3 13529.9 10867.7 10883.7 10917.5 11300.8 11316.4 11500.7 11518.5 11581.3 11835.5 12037.8 9112.5 10566.7 10634.0 10642.0 10898.0 7236.6 7254.5 7322.2 7324.7 7327.9 10721.1 10744.2 10802.4 11001.2 11154.0 05:08:20 INFO - 2015-12-16 05:08:20,110 DEBUG : BROWSER_OUTPUT: 05:08:20 INFO - 2015-12-16 05:08:20,110 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5634.46 Median:6397.28 stddev:2851.00 (44.6%) stddev-sans-first:2842.19 05:08:20 INFO - 2015-12-16 05:08:20,111 DEBUG : BROWSER_OUTPUT: Values: 1515.8 1518.6 1725.0 1858.2 1867.2 6346.1 6448.4 6450.2 6483.7 6488.3 7041.3 7263.8 7806.0 7982.1 8030.8 2379.4 2395.1 2421.7 2422.9 2425.3 2114.9 2343.8 2370.8 2393.5 2405.8 2085.2 2282.8 2310.0 2310.1 2310.2 2335.9 2345.4 2347.0 2397.3 2397.9 2381.3 2392.8 2416.5 2420.7 2431.1 7941.6 7967.1 8022.3 8027.9 8037.6 4834.1 4891.6 4902.2 4908.5 4908.8 3357.4 3373.3 3383.9 3414.4 3417.2 1165.1 1176.9 1185.4 1199.0 1237.2 10556.9 10583.6 10595.6 10599.4 10601.1 4447.5 4456.2 4494.6 4495.4 4502.1 9143.5 9153.3 9157.0 9168.5 9168.6 4827.4 4827.5 4829.9 4833.5 4836.8 4439.2 4440.7 4445.1 4448.8 4449.7 3896.6 3952.5 3953.1 3973.9 3978.0 1171.0 1204.6 1253.7 1305.3 1306.8 1107.9 1112.1 1181.0 1401.6 1485.6 7575.4 7592.8 7682.4 7695.4 7701.1 1105.6 1146.7 1189.9 1190.4 1197.2 6056.4 6144.9 6151.1 6151.9 6156.4 9208.0 9548.7 9556.1 9564.6 9573.8 9730.4 9743.9 9755.2 9770.0 9771.3 7393.2 7649.3 7672.3 7679.7 7699.3 7328.1 7432.9 7498.8 7503.6 7512.4 8649.6 8858.8 8870.7 8902.6 8910.9 8751.7 8931.4 8953.0 8966.6 9091.2 7208.5 7213.3 7277.9 7295.1 7298.3 7806.3 7914.4 7951.7 7966.8 7982.1 6573.1 7458.6 7584.8 7599.2 7644.2 6677.7 7302.3 7314.5 7390.5 7436.3 7391.4 7394.6 7403.9 7434.4 7441.7 6844.3 6912.1 6947.1 6947.8 6964.2 6647.9 6736.3 6737.8 6742.6 6744.7 05:08:20 INFO - 2015-12-16 05:08:20,111 DEBUG : BROWSER_OUTPUT: 05:08:20 INFO - 2015-12-16 05:08:20,111 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5336.90 Median:6043.56 stddev:1570.58 (26.0%) stddev-sans-first:1529.98 05:08:20 INFO - 2015-12-16 05:08:20,113 DEBUG : BROWSER_OUTPUT: Values: 363.1 368.8 369.8 370.0 373.5 5992.9 6000.5 6025.0 6035.9 6051.2 5743.1 5774.5 5827.4 5938.5 5965.0 4653.0 4667.1 4674.0 4674.4 4688.4 4607.4 4671.0 4683.7 4687.5 4693.1 4636.7 4637.1 4644.8 4646.4 4646.7 4554.7 4635.8 4640.9 4645.0 4647.0 4070.6 4074.9 4077.7 4091.2 4097.0 5628.7 5628.8 5634.7 5642.9 5648.5 5319.4 5332.9 5338.6 5341.4 5352.1 6205.1 6247.8 6268.9 6287.0 6287.9 4470.7 4476.5 4478.9 4480.5 4481.8 6427.6 6435.4 6480.0 6491.8 6499.3 4498.1 4547.8 4586.0 4586.6 4641.1 4680.1 4681.1 4685.1 4686.5 4686.9 5366.5 5371.3 5374.2 5378.9 5380.3 6313.5 6338.4 6354.2 6367.5 6375.2 1646.1 1675.6 1686.3 1689.1 1694.9 1058.2 1116.5 1141.2 1157.8 1163.7 6028.5 6074.9 6075.8 6081.1 6082.5 6357.9 6383.7 6407.4 6410.5 6446.2 5956.2 6058.8 6059.8 6065.8 6083.5 3580.2 3593.2 3609.5 3612.1 3612.8 6701.5 6707.6 6709.4 6715.6 6717.6 6656.3 6665.9 6711.4 6716.5 6718.2 6708.4 6723.9 6741.5 6742.2 6748.2 6561.6 6563.2 6571.4 6571.9 6573.3 6340.3 6404.5 6415.7 6491.5 6509.9 6658.3 6680.0 6745.7 6774.1 6779.4 4597.5 4638.6 4642.2 4644.1 4645.0 6486.3 6588.2 6592.1 6598.0 6601.9 6458.3 6459.1 6465.0 6465.3 6466.8 6450.0 6450.1 6453.1 6456.6 6457.1 6277.7 6313.3 6320.7 6338.9 6344.2 6441.1 6505.1 6512.0 6516.1 6521.4 6296.6 6303.7 6310.9 6312.9 6346.1 05:08:20 INFO - 2015-12-16 05:08:20,113 DEBUG : BROWSER_OUTPUT: 05:08:20 INFO - 2015-12-16 05:08:20,113 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15193.37 Median:26566.79 stddev:18521.43 (69.7%) stddev-sans-first:18541.27 05:08:20 INFO - 2015-12-16 05:08:20,114 DEBUG : BROWSER_OUTPUT: Values: 669.7 694.9 830.9 837.0 853.3 14760.3 15169.9 15182.7 15233.0 15259.3 14596.7 14643.9 14650.6 14658.6 14705.4 780.7 786.4 923.4 930.9 945.2 927.4 928.0 929.4 935.0 935.7 967.5 977.5 978.5 983.8 984.8 800.8 813.9 958.7 965.0 972.0 723.5 726.2 727.3 728.4 729.4 13975.7 14157.2 14161.9 14179.0 14257.9 11878.3 12353.7 12769.4 13590.7 14166.6 10542.8 10705.6 10867.6 10961.5 11128.7 3824.1 3831.2 3891.8 3907.5 3964.1 52049.0 52484.7 52594.0 54117.7 54200.0 8785.3 8803.4 8839.3 8873.8 8967.3 20518.2 20658.5 20713.6 20768.7 20771.8 7802.6 7945.1 7961.0 7972.4 7987.1 4573.7 4682.0 4684.7 4707.9 4730.3 3255.6 3290.9 3295.6 3302.9 3305.0 471.7 492.5 495.1 539.6 566.2 605.3 646.9 679.5 683.0 692.8 8540.4 9670.0 9735.2 9812.8 9949.5 567.6 673.9 695.0 695.7 707.2 4215.4 4469.5 4495.5 4505.2 4519.3 65853.3 66344.3 66404.0 66688.3 66755.0 58776.0 59201.4 59995.7 60016.0 60224.7 54203.2 54211.5 54650.0 55011.7 55651.8 8987.9 9216.4 9294.4 9467.5 9496.1 39168.4 39342.0 40396.6 40629.4 41214.6 47049.0 47137.3 52311.5 54889.5 55053.7 7445.8 7488.3 7591.1 8345.7 8404.1 11757.5 11854.9 12032.0 12062.6 12269.7 11083.8 11144.2 11168.2 11170.7 11439.8 11333.7 11486.8 11542.9 11928.7 12201.1 11160.7 11342.1 11388.8 11574.0 11590.4 9793.7 10013.1 10070.2 10134.8 10433.3 9888.0 9993.9 10010.5 10028.5 10303.0 05:08:20 INFO - 2015-12-16 05:08:20,114 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:08:20 INFO - 2015-12-16 05:08:20,115 DEBUG : BROWSER_OUTPUT: 05:08:20 INFO - 2015-12-16 05:08:20,655 INFO : Browser exited with error code: 0 05:08:20 INFO - 2015-12-16 05:08:20,676 INFO : Completed test dromaeo_css (00:18:29) 05:08:20 INFO - 2015-12-16 05:08:20,676 INFO : Starting test kraken 05:08:20 INFO - 2015-12-16 05:08:20,676 DEBUG : operating with platform_type : linux_ 05:08:20 INFO - 2015-12-16 05:08:20,676 INFO : Initialising browser for kraken test... 05:08:20 INFO - 2015-12-16 05:08:20,682 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH0Prf3/profile http://localhost:55964/getInfo.html 05:08:24 INFO - 2015-12-16 05:08:24,434 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:08:24 INFO - 2015-12-16 05:08:24,434 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:08:24 INFO - 2015-12-16 05:08:24,434 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:08:24 INFO - 2015-12-16 05:08:24,434 DEBUG : BROWSER_OUTPUT: __metrics 05:08:24 INFO - 2015-12-16 05:08:24,531 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:08:25 INFO - 2015-12-16 05:08:25,901 INFO : Browser initialized. 05:08:25 INFO - 2015-12-16 05:08:25,902 INFO : Running cycle 1/1 for kraken test... 05:08:25 INFO - 2015-12-16 05:08:25,902 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH0Prf3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:08:37 INFO - 2015-12-16 05:08:37,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 132005888 05:08:37 INFO - 2015-12-16 05:08:37,519 DEBUG : BROWSER_OUTPUT: 05:08:39 INFO - 2015-12-16 05:08:39,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55964/tests/kraken/driver.html?testName=audio-beat-detection) 05:08:40 INFO - 2015-12-16 05:08:40,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 165126144 05:08:40 INFO - 2015-12-16 05:08:40,506 DEBUG : BROWSER_OUTPUT: 05:08:43 INFO - 2015-12-16 05:08:43,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55964/tests/kraken/driver.html?testName=audio-dft) 05:08:43 INFO - 2015-12-16 05:08:43,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 161959936 05:08:43 INFO - 2015-12-16 05:08:43,624 DEBUG : BROWSER_OUTPUT: 05:08:46 INFO - 2015-12-16 05:08:46,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55964/tests/kraken/driver.html?testName=audio-fft) 05:08:46 INFO - 2015-12-16 05:08:46,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 158572544 05:08:46 INFO - 2015-12-16 05:08:46,947 DEBUG : BROWSER_OUTPUT: 05:08:48 INFO - 2015-12-16 05:08:48,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55964/tests/kraken/driver.html?testName=audio-oscillator) 05:08:49 INFO - 2015-12-16 05:08:49,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 159531008 05:08:49 INFO - 2015-12-16 05:08:49,458 DEBUG : BROWSER_OUTPUT: 05:08:51 INFO - 2015-12-16 05:08:51,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55964/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:08:52 INFO - 2015-12-16 05:08:52,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 155856896 05:08:52 INFO - 2015-12-16 05:08:52,124 DEBUG : BROWSER_OUTPUT: 05:08:54 INFO - 2015-12-16 05:08:54,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55964/tests/kraken/driver.html?testName=imaging-darkroom) 05:08:55 INFO - 2015-12-16 05:08:55,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 157343744 05:08:55 INFO - 2015-12-16 05:08:55,559 DEBUG : BROWSER_OUTPUT: 05:08:58 INFO - 2015-12-16 05:08:58,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55964/tests/kraken/driver.html?testName=imaging-desaturate) 05:08:59 INFO - 2015-12-16 05:08:59,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 158674944 05:08:59 INFO - 2015-12-16 05:08:59,526 DEBUG : BROWSER_OUTPUT: 05:09:02 INFO - 2015-12-16 05:09:02,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55964/tests/kraken/driver.html?testName=json-parse-financial) 05:09:02 INFO - 2015-12-16 05:09:02,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 156114944 05:09:02 INFO - 2015-12-16 05:09:02,790 DEBUG : BROWSER_OUTPUT: 05:09:04 INFO - 2015-12-16 05:09:04,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55964/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:09:04 INFO - 2015-12-16 05:09:04,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 160641024 05:09:04 INFO - 2015-12-16 05:09:04,866 DEBUG : BROWSER_OUTPUT: 05:09:06 INFO - 2015-12-16 05:09:06,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55964/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:09:07 INFO - 2015-12-16 05:09:07,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 158351360 05:09:07 INFO - 2015-12-16 05:09:07,165 DEBUG : BROWSER_OUTPUT: 05:09:09 INFO - 2015-12-16 05:09:09,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55964/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:09:09 INFO - 2015-12-16 05:09:09,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 163864576 05:09:09 INFO - 2015-12-16 05:09:09,710 DEBUG : BROWSER_OUTPUT: 05:09:12 INFO - 2015-12-16 05:09:12,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:09:12 INFO - 2015-12-16 05:09:12,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 168267776 05:09:12 INFO - 2015-12-16 05:09:12,597 DEBUG : BROWSER_OUTPUT: 05:09:15 INFO - 2015-12-16 05:09:15,031 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:09:15 INFO - 2015-12-16 05:09:15,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 167522304 05:09:15 INFO - 2015-12-16 05:09:15,601 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55964/tests/kraken/driver.html?testName=ai-astar) 05:09:17 INFO - 2015-12-16 05:09:17,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 226877440 05:09:17 INFO - 2015-12-16 05:09:17,448 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,448 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:09:17 INFO - 2015-12-16 05:09:17,448 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:09:17 INFO - 2015-12-16 05:09:17,448 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:09:17 INFO - 2015-12-16 05:09:17,448 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:09:17 INFO - 2015-12-16 05:09:17,448 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;104;108;110;109;98;109;106;109 05:09:17 INFO - 2015-12-16 05:09:17,449 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;121;149;163;130;151;146;126;167;120 05:09:17 INFO - 2015-12-16 05:09:17,449 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;160;159;159;160;162;158;160 05:09:17 INFO - 2015-12-16 05:09:17,449 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;71;72;138;72;72;70;69;151;70 05:09:17 INFO - 2015-12-16 05:09:17,449 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;134;89;89;89;126;88;89;135 05:09:17 INFO - 2015-12-16 05:09:17,450 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;110;110;109;110;109 05:09:17 INFO - 2015-12-16 05:09:17,450 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;158;147;145;145;146;146;145;146;145;146 05:09:17 INFO - 2015-12-16 05:09:17,450 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;96 05:09:17 INFO - 2015-12-16 05:09:17,450 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;56;55;55;54;54;56;55;53;55 05:09:17 INFO - 2015-12-16 05:09:17,450 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;62;61;61;62;61;61;62;61;62 05:09:17 INFO - 2015-12-16 05:09:17,450 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;76;85;78;78;76;79;79;78;77 05:09:17 INFO - 2015-12-16 05:09:17,451 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;115;120;108;122;113;115;109;115;108 05:09:17 INFO - 2015-12-16 05:09:17,451 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;136;134;141;144;138;137;133;134;125 05:09:17 INFO - 2015-12-16 05:09:17,451 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;62;60;60;61;60;64;62;61;59 05:09:17 INFO - 2015-12-16 05:09:17,451 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:09:17 INFO - 2015-12-16 05:09:17,451 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:09:17 INFO - 2015-12-16 05:09:17,451 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,869 05:09:17 INFO - 2015-12-16 05:09:17,452 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:09:17 INFO - 2015-12-16 05:09:17,452 DEBUG : BROWSER_OUTPUT: __startTimestamp1450271357442__endTimestamp 05:09:17 INFO - 2015-12-16 05:09:17,452 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,452 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:09:17 INFO - 2015-12-16 05:09:17,452 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:09:17 INFO - 2015-12-16 05:09:17,453 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,453 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.10 Median:109.00 stddev:3.70 (3.4%) stddev-sans-first:3.91 05:09:17 INFO - 2015-12-16 05:09:17,453 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 104.0 108.0 110.0 109.0 98.0 109.0 106.0 109.0 05:09:17 INFO - 2015-12-16 05:09:17,453 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,453 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.70 Median:147.50 stddev:16.80 (11.4%) stddev-sans-first:17.80 05:09:17 INFO - 2015-12-16 05:09:17,454 DEBUG : BROWSER_OUTPUT: Values: 144.0 121.0 149.0 163.0 130.0 151.0 146.0 126.0 167.0 120.0 05:09:17 INFO - 2015-12-16 05:09:17,454 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,454 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 05:09:17 INFO - 2015-12-16 05:09:17,454 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 160.0 159.0 159.0 160.0 162.0 158.0 160.0 05:09:17 INFO - 2015-12-16 05:09:17,454 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,455 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.50 Median:70.50 stddev:31.26 (44.3%) stddev-sans-first:32.65 05:09:17 INFO - 2015-12-16 05:09:17,455 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 72.0 138.0 72.0 72.0 70.0 69.0 151.0 70.0 05:09:17 INFO - 2015-12-16 05:09:17,455 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,455 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.80 Median:89.00 stddev:20.75 (23.3%) stddev-sans-first:21.48 05:09:17 INFO - 2015-12-16 05:09:17,455 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 134.0 89.0 89.0 89.0 126.0 88.0 89.0 135.0 05:09:17 INFO - 2015-12-16 05:09:17,455 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,457 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:09:17 INFO - 2015-12-16 05:09:17,457 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 05:09:17 INFO - 2015-12-16 05:09:17,457 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,457 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:146.00 stddev:3.96 (2.7%) stddev-sans-first:0.71 05:09:17 INFO - 2015-12-16 05:09:17,457 DEBUG : BROWSER_OUTPUT: Values: 158.0 147.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 05:09:17 INFO - 2015-12-16 05:09:17,457 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,457 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 05:09:17 INFO - 2015-12-16 05:09:17,457 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 05:09:17 INFO - 2015-12-16 05:09:17,457 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,457 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:0.97 05:09:17 INFO - 2015-12-16 05:09:17,457 DEBUG : BROWSER_OUTPUT: Values: 54.0 56.0 55.0 55.0 54.0 54.0 56.0 55.0 53.0 55.0 05:09:17 INFO - 2015-12-16 05:09:17,457 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,457 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 61.0 61.0 62.0 61.0 61.0 62.0 61.0 62.0 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:2.55 (3.3%) stddev-sans-first:2.70 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: Values: 78.0 76.0 85.0 78.0 78.0 76.0 79.0 79.0 78.0 77.0 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:113.90 Median:115.00 stddev:4.72 (4.1%) stddev-sans-first:5.01 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: Values: 114.0 115.0 120.0 108.0 122.0 113.0 115.0 109.0 115.0 108.0 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.30 Median:137.50 stddev:5.33 (3.9%) stddev-sans-first:5.38 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: Values: 141.0 136.0 134.0 141.0 144.0 138.0 137.0 133.0 134.0 125.0 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.50 stddev:1.90 (3.1%) stddev-sans-first:1.50 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: Values: 65.0 62.0 60.0 60.0 61.0 60.0 64.0 62.0 61.0 59.0 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:09:17 INFO - 2015-12-16 05:09:17,458 DEBUG : BROWSER_OUTPUT: 05:09:18 INFO - 2015-12-16 05:09:18,115 INFO : Browser exited with error code: 0 05:09:18 INFO - 2015-12-16 05:09:18,168 INFO : Completed test kraken (00:00:57) 05:09:18 INFO - 2015-12-16 05:09:18,168 INFO : Starting test v8_7 05:09:18 INFO - 2015-12-16 05:09:18,168 DEBUG : operating with platform_type : linux_ 05:09:18 INFO - 2015-12-16 05:09:18,168 INFO : Initialising browser for v8_7 test... 05:09:18 INFO - 2015-12-16 05:09:18,174 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp054lxm/profile http://localhost:55964/getInfo.html 05:09:21 INFO - 2015-12-16 05:09:21,887 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:09:21 INFO - 2015-12-16 05:09:21,887 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:09:21 INFO - 2015-12-16 05:09:21,887 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:09:21 INFO - 2015-12-16 05:09:21,887 DEBUG : BROWSER_OUTPUT: __metrics 05:09:21 INFO - 2015-12-16 05:09:21,964 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:09:23 INFO - 2015-12-16 05:09:23,145 INFO : Browser initialized. 05:09:23 INFO - 2015-12-16 05:09:23,146 INFO : Running cycle 1/1 for v8_7 test... 05:09:23 INFO - 2015-12-16 05:09:23,146 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp054lxm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:09:34 INFO - 2015-12-16 05:09:34,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 131608576 05:09:34 INFO - 2015-12-16 05:09:34,797 DEBUG : BROWSER_OUTPUT: 05:09:56 INFO - 2015-12-16 05:09:56,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55964/tests/v8_7/run.html (next: http://localhost:55964/tests/v8_7/run.html) 05:09:56 INFO - 2015-12-16 05:09:56,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 428916736 05:09:56 INFO - 2015-12-16 05:09:56,468 DEBUG : BROWSER_OUTPUT: 05:09:56 INFO - 2015-12-16 05:09:56,468 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:09:56 INFO - 2015-12-16 05:09:56,468 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:09:56 INFO - 2015-12-16 05:09:56,468 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:09:56 INFO - 2015-12-16 05:09:56,468 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: |0;Richards;162.83992835043153 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.85255424568598 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5010 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: |4;RayTrace;946.073793755913 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: |5;Earley;553.7098560354374 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: |6;Boyer;10437.5 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: |7;RegExp;23348.837209302324 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: |8;Splay;527.9831045406547 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4812.5 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: __startTimestamp1450271396467__endTimestamp 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: 05:09:56 INFO - 2015-12-16 05:09:56,469 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:09:56 INFO - 2015-12-16 05:09:56,471 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:09:56 INFO - 2015-12-16 05:09:56,471 DEBUG : BROWSER_OUTPUT: 05:09:56 INFO - 2015-12-16 05:09:56,471 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.84 Median:162.84 stddev:0.00 (0.0%) 05:09:56 INFO - 2015-12-16 05:09:56,471 DEBUG : BROWSER_OUTPUT: Values: 162.8 05:09:56 INFO - 2015-12-16 05:09:56,471 DEBUG : BROWSER_OUTPUT: 05:09:56 INFO - 2015-12-16 05:09:56,471 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:170.85 Median:170.85 stddev:0.00 (0.0%) 05:09:56 INFO - 2015-12-16 05:09:56,471 DEBUG : BROWSER_OUTPUT: Values: 170.9 05:09:56 INFO - 2015-12-16 05:09:56,472 DEBUG : BROWSER_OUTPUT: 05:09:56 INFO - 2015-12-16 05:09:56,472 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 05:09:56 INFO - 2015-12-16 05:09:56,472 DEBUG : BROWSER_OUTPUT: Values: 279.3 05:09:56 INFO - 2015-12-16 05:09:56,472 DEBUG : BROWSER_OUTPUT: 05:09:56 INFO - 2015-12-16 05:09:56,472 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5010.00 Median:5010.00 stddev:0.00 (0.0%) 05:09:56 INFO - 2015-12-16 05:09:56,472 DEBUG : BROWSER_OUTPUT: Values: 5010.0 05:09:56 INFO - 2015-12-16 05:09:56,472 DEBUG : BROWSER_OUTPUT: 05:09:56 INFO - 2015-12-16 05:09:56,473 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:946.07 Median:946.07 stddev:0.00 (0.0%) 05:09:56 INFO - 2015-12-16 05:09:56,473 DEBUG : BROWSER_OUTPUT: Values: 946.1 05:09:56 INFO - 2015-12-16 05:09:56,473 DEBUG : BROWSER_OUTPUT: 05:09:56 INFO - 2015-12-16 05:09:56,473 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:553.71 Median:553.71 stddev:0.00 (0.0%) 05:09:56 INFO - 2015-12-16 05:09:56,473 DEBUG : BROWSER_OUTPUT: Values: 553.7 05:09:56 INFO - 2015-12-16 05:09:56,473 DEBUG : BROWSER_OUTPUT: 05:09:56 INFO - 2015-12-16 05:09:56,473 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10437.50 Median:10437.50 stddev:0.00 (0.0%) 05:09:56 INFO - 2015-12-16 05:09:56,473 DEBUG : BROWSER_OUTPUT: Values: 10437.5 05:09:56 INFO - 2015-12-16 05:09:56,474 DEBUG : BROWSER_OUTPUT: 05:09:56 INFO - 2015-12-16 05:09:56,474 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23348.84 Median:23348.84 stddev:0.00 (0.0%) 05:09:56 INFO - 2015-12-16 05:09:56,474 DEBUG : BROWSER_OUTPUT: Values: 23348.8 05:09:56 INFO - 2015-12-16 05:09:56,474 DEBUG : BROWSER_OUTPUT: 05:09:56 INFO - 2015-12-16 05:09:56,474 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:527.98 Median:527.98 stddev:0.00 (0.0%) 05:09:56 INFO - 2015-12-16 05:09:56,474 DEBUG : BROWSER_OUTPUT: Values: 528.0 05:09:56 INFO - 2015-12-16 05:09:56,474 DEBUG : BROWSER_OUTPUT: 05:09:56 INFO - 2015-12-16 05:09:56,475 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4812.50 Median:4812.50 stddev:0.00 (0.0%) 05:09:56 INFO - 2015-12-16 05:09:56,475 DEBUG : BROWSER_OUTPUT: Values: 4812.5 05:09:56 INFO - 2015-12-16 05:09:56,475 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:09:56 INFO - 2015-12-16 05:09:56,475 DEBUG : BROWSER_OUTPUT: 05:09:57 INFO - 2015-12-16 05:09:57,143 INFO : Browser exited with error code: 0 05:09:57 INFO - 2015-12-16 05:09:57,155 INFO : Completed test v8_7 (00:00:38) 05:09:57 INFO - 2015-12-16 05:09:57,465 INFO : Completed test suite (00:20:06) 05:09:57 INFO - 2015-12-16 05:09:57,466 DEBUG : Working with test: dromaeo_css 05:09:57 INFO - 2015-12-16 05:09:57,466 DEBUG : Generating results file: dromaeo_css 05:09:57 INFO - 2015-12-16 05:09:57,467 DEBUG : Working with test: kraken 05:09:57 INFO - 2015-12-16 05:09:57,467 DEBUG : Generating results file: kraken 05:09:57 INFO - 2015-12-16 05:09:57,467 INFO : javascript benchmark 05:09:57 INFO - 2015-12-16 05:09:57,468 DEBUG : Working with test: v8_7 05:09:57 INFO - 2015-12-16 05:09:57,468 DEBUG : Generating results file: v8_7 05:09:57 INFO - 2015-12-16 05:09:57,468 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:09:57 INFO - 2015-12-16 05:09:57,518 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 05:09:57 INFO - 2015-12-16 05:09:57,518 DEBUG : process_Request line: dromaeo_css 7191.24 graph.html#tests=[[72,53,35]] 05:09:57 INFO - 2015-12-16 05:09:57,518 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:09:57 INFO - 2015-12-16 05:09:57,551 DEBUG : process_Request line: kraken 1453.60 graph.html#tests=[[232,53,35]] 05:09:57 INFO - 2015-12-16 05:09:57,551 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:09:57 INFO - 2015-12-16 05:09:57,581 DEBUG : process_Request line: v8_7 23399.41 graph.html#tests=[[230,53,35]] 05:09:57 INFO - 2015-12-16 05:09:57,582 INFO : javascript benchmark 05:09:57 INFO - 2015-12-16 05:09:57,586 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3294.9505757413644, 3388.390089783838, 3422.6577342265778, 3428.3486137633863, 3445.9138521536956, 5633.577481688869, 5641.294838145232, 5653.982283189024, 5660.60375773696, 5672.234248376468, 5671.262735844334, 5681.261436013323, 5685.0, 5691.004074287004, 5691.686957217351, 4909.68087074339, 5128.230765385185, 5153.072446959546, 5236.083685355066, 5276.498732620395, 4984.252362145689, 5083.389993200803, 5102.566281866028, 5128.871778205556, 5130.486951304877, 5047.4447810740785, 5090.211017292307, 5095.490450954912, 5106.157484015133, 5109.489051094898, 5167.819126330561, 5221.843344699646, 5242.213667949838, 5243.397009343936, 5246.685198888079, 4930.605551555867, 4948.455669876311, 5009.398872135331, 5054.469280725508, 5135.3324067870935, 5460.34475862895, 5473.8357849264585, 5481.698506582136, 5494.697791621459, 5507.752151153208, 6118.4799292060225, 6120.846978825521, 6124.5100391968535, 6134.693265336716, 6143.078538219258, 5898.4101589840675, 5945.643261404286, 5985.4912332451795, 6052.636841789506, 6059.515238780887, 5649.0114230009585, 5650.63270887391, 5654.095344744862, 5659.236003139524, 5671.177679236487, 6169.96915015422, 6176.258848938156, 6187.752489900444, 6189.566730328834, 6195.287541932646, 5644.0, 5734.910367030251, 5842.561807864342, 5915.201447804578, 5936.22829032223, 6079.817605471843, 6102.0541816018585, 6125.326214116443, 6132.724027418777, 6133.080037994337, 5755.539556835443, 6074.51403887688, 6080.6047606906295, 6082.1789058477425, 6085.2393450818645, 5905.114232865105, 5988.131720900445, 6058.606190597597, 6073.18012068374, 6104.938950610526, 4628.421447319085, 4628.652851036186, 4631.0, 4635.258358662598, 4654.906901861944, 4046.615571520701, 4128.339465685536, 4134.462519872397, 4150.439690641725, 4180.143070670505, 5647.068233741386, 5780.71096445176, 5809.128630705343, 5816.272965879265, 5838.766449341979, 6039.245094363205, 6103.938960610426, 6106.908396374058, 6114.144019837227, 6116.510679145657, 5464.480874316933, 5582.413846546055, 5589.161625756169, 5685.573581981285, 5717.085266357363, 5239.554637855748, 5239.816606418757, 5250.842474725764, 5261.579073674096, 5289.418164001957, 6209.192804935329, 6209.59637623553, 6214.906776398358, 6219.751209951552, 6221.440070393596, 5876.647401155944, 5974.0, 6040.0, 6103.908441373472, 6173.135760993554, 6308.873822523432, 6327.96836015817, 6332.081848131903, 6342.23893132827, 6347.238331400077, 6041.0, 6079.361667025076, 6092.329843717276, 6096.237970253718, 6096.847578810565, 5761.222234998221, 5854.795082172103, 6040.909386359296, 6118.010103775335, 6129.816105516842, 5936.643801371932, 5944.078667806497, 5944.167816505779, 5954.404559544011, 5955.493783028491, 5683.3748287687495, 5935.2877654681715, 5938.8218353449465, 5946.821595352147, 5957.582969192115, 5718.370979192368, 5728.713564321684, 5829.679367634821, 5838.649681019152, 5864.32560255576, 5795.884082318245, 5817.069268916953, 5817.360090389969, 5841.532677385714, 5933.050711886078, 5681.0626246668835, 5709.314882214161, 5714.428557144252, 5744.109663002241, 5779.653220806596], "unit": "ms", "name": "dojo.html", "value": 5566.636283639935}, {"lowerIsBetter": false, "replicates": [585.7891159182697, 621.2824188062788, 631.4884943196008, 631.725199538201, 684.076496729415, 35334.293314133734, 42182.78908605457, 42638.99999999992, 42645.14709705804, 42690.57309426905, 47195.76402117984, 48310.275345869755, 48430.51569484313, 48444.0, 48451.51548484514, 8288.958555207246, 8423.15768423159, 8953.149450802164, 9213.30900182489, 9230.261579073658, 11253.437328133561, 11450.942745286262, 11486.655400338002, 11493.0, 11502.712432189179, 11087.168462365315, 11165.050970667504, 11185.217034807567, 11187.0, 11192.720181995475, 11043.447827608587, 11122.666320010332, 11134.443277836075, 11137.276077055007, 11152.944235278852, 10862.78274434507, 10944.3980581068, 10969.616063437741, 10975.176861735401, 11032.779344413148, 44004.339934901, 44296.335554966376, 44421.33367999482, 44425.33361999573, 44425.33361999573, 3283.3761585298957, 3398.303347813692, 4031.3348297530874, 4132.421460995463, 4180.184863951531, 32969.3406131876, 33356.66643333584, 33552.16119597005, 33848.83075584631, 34347.0, 3817.9045523861846, 3874.670652994499, 3892.104815892332, 3953.782541960191, 4007.0182805212908, 302090.0, 302697.0, 303929.0, 305231.0, 306202.9999999978, 64139.679301603195, 65185.674071629335, 66479.33520664828, 66568.0, 68350.0, 69325.3067469329, 69479.0, 69595.65202173957, 69766.65116674385, 69783.0, 16980.660386792195, 17212.655746884993, 17243.827561724473, 17265.654686906193, 17303.307867685402, 13057.0, 13232.338383080807, 13235.470581176838, 13404.865951340556, 13442.395092220873, 21683.34949951504, 21845.45386365322, 21893.890530547564, 21909.452263693536, 21927.67108493374, 7312.416915711369, 7731.226877312224, 7752.883706744404, 7756.146823849372, 7836.451448398558, 853.7353420439683, 955.7037318431309, 1055.3404122423485, 1089.591403223791, 1179.351356753782, 30141.397172056873, 30544.847275763477, 30758.0, 31636.683633163833, 33509.49735753966, 1041.3231399590327, 1078.9352638841694, 1081.167501024207, 1139.789139009286, 1141.1384404774342, 13513.459461621622, 13692.452301908012, 14212.786808197678, 16201.59496012609, 16605.791091013518, 292320.0, 295909.0, 296261.0, 296863.0, 297244.0, 55977.72011139918, 56171.71914140403, 56262.43737562654, 56263.156052659244, 56280.155797663065, 1344.193483909666, 1353.2759973414372, 1450.4125829039256, 1450.5720812360169, 1465.4211586423517, 30189.0, 30232.54651180278, 30284.697153028188, 30809.38381232318, 31170.0, 53257.4674253268, 53594.46405535895, 53638.463615364904, 53697.463025369245, 53730.194047088546, 337881.0, 338539.0, 339858.0, 340546.0, 341781.0, 35853.82073089618, 36465.63534364622, 36544.26911461809, 36679.08302292357, 36763.816180918926, 47245.2913206309, 47385.28922066103, 47831.0, 47879.5212047875, 48513.757431212616, 39341.21317573575, 39686.40470393004, 39845.0, 40120.598794012854, 40974.79512602418, 38617.42073868951, 39474.40788388119, 40191.598084018784, 40294.1941161181, 40753.0, 39155.41266880942, 39559.40660890147, 40014.0, 40247.79876100601, 40248.3962740565, 34279.65720342765, 34381.31237375289, 35028.0, 35072.29855402827, 35188.296234075686, 27038.72961270362, 27615.2885335998, 27759.30601734892, 28060.71939280581, 29238.41523169567], "unit": "ms", "name": "ext.html", "value": 20439.131627925395}, {"lowerIsBetter": false, "replicates": [386.2622391232746, 388.06282826972864, 391.30347980594536, 391.6025234387097, 397.09264331003664, 12687.555935542257, 15258.465953691622, 17181.742273865886, 18956.810431895676, 18985.810141898593, 18081.276748930028, 18259.726104108417, 18306.908465457655, 18824.15291311894, 19257.0, 5548.750306236209, 5667.971660141693, 5679.659220446766, 5687.7156142192935, 5689.11818668105, 4432.445944256968, 4539.841105561306, 5622.128570071625, 6292.1820163378925, 6495.447886929593, 6287.528435367343, 6355.046742988542, 6383.872322553546, 6390.073439351315, 6420.743170273184, 6329.05064240363, 6335.936640633581, 6347.0, 6349.079383489415, 6359.077933699634, 5724.055530837407, 5735.827925162252, 5819.330776960619, 5819.7963071292725, 5868.618539794899, 22893.885530572406, 23723.288301350985, 23765.049398024057, 23937.760622393725, 24238.15166469165, 2310.353101131686, 2313.3175713164655, 2324.7675232476786, 2433.9269821905373, 2466.8766561671846, 14487.130772153705, 14694.485693000694, 14717.926410367987, 14731.484398046125, 15078.849211507853, 1865.9067046647613, 1939.4666466721765, 1970.8916009619466, 1980.1188471130354, 1982.6431242376366, 62590.687046565385, 70274.64862675653, 70729.64635176843, 72333.2766672337, 73643.0, 7795.883061754078, 7918.445708800444, 8088.231617996281, 8129.3090087343235, 8143.837123257502, 9685.6610018649, 9725.61097556104, 9732.854007189897, 9736.561854716554, 9757.0, 6444.291127975919, 6491.610503369719, 6519.837004074936, 6526.608403495806, 6535.44448721864, 6617.8014659560295, 6644.734210631617, 6656.434203092791, 6773.762918297836, 6812.216595091529, 3702.0559757261726, 3734.9066273343383, 3735.6824669903363, 3754.8685795997553, 3757.830897609614, 1259.2633309513853, 1275.9234445933273, 1278.514164617458, 1291.6189724031433, 1295.0804928500681, 501.55111175498456, 507.92888995540653, 509.36075225591645, 519.6128883981459, 520.2066848056744, 11606.361650109156, 12785.488580456678, 12945.417456214493, 13403.128796628189, 13511.391987360395, 524.9238860365302, 530.3185406752305, 542.1894268069261, 558.2324304081887, 584.8187062010705, 7005.579665220103, 7238.0, 7284.344409003215, 7438.5908775016815, 7633.313001829862, 662586.0, 672548.0, 679194.0, 683727.0, 683872.5806370936, 81413.0, 86056.56971715101, 86450.0, 87861.56069219741, 88461.55769221112, 605.5186127029023, 617.6325086573481, 620.5407998081387, 620.9782657606962, 626.6866566716642, 11948.462319195483, 12083.0, 12114.575989840314, 12226.327551984727, 12240.816387754012, 37257.25485490221, 38794.6120538791, 39638.40542391924, 39641.0, 40316.39525407062, 48574.75712621414, 49005.50994490152, 50138.49861501484, 55278.72360638171, 55430.0, 7385.113786345673, 7539.0, 7592.8481430369975, 7602.087749470099, 7613.505122167041, 12953.352332383154, 13135.211887286794, 13229.867701322864, 13365.331733413095, 13529.932350338186, 10867.673969780919, 10883.67348979532, 10917.454127293444, 11300.773984520429, 11316.37759923212, 11500.654980350602, 11518.481668325114, 11581.305121692725, 11835.467403967014, 12037.819432708691, 9112.453252804853, 10566.735831603964, 10634.0, 10642.04221620058, 10898.0, 7236.638168091679, 7254.492185546961, 7322.157951835394, 7324.707011719472, 7327.926720732938, 10721.142308615135, 10744.19418543628, 10802.351858888493, 11001.22991390595, 11154.0], "unit": "ms", "name": "jquery.html", "value": 8046.361763982278}, {"lowerIsBetter": false, "replicates": [1515.780211869279, 1518.5747990562643, 1724.9913750431253, 1858.2009735813594, 1867.1691097461626, 6346.14327065846, 6448.419642232192, 6450.193725784277, 6483.740650373985, 6488.3187265337165, 7041.260667629902, 7263.818404539889, 7805.960970195155, 7982.082060563037, 8030.799230019238, 2379.3694670912264, 2395.077895010425, 2421.7457166997474, 2422.903083876643, 2425.3087869957067, 2114.947126321839, 2343.7656234376595, 2370.762923707624, 2393.4614711689906, 2405.759424057589, 2085.2076211039785, 2282.7945484906354, 2309.9884500577473, 2310.0528783198893, 2310.1798861404213, 2335.90656373744, 2345.413646588353, 2346.9882650586724, 2397.3167647220457, 2397.9040838366445, 2381.3332266965276, 2392.760723927611, 2416.516696660675, 2420.673209116782, 2431.088341871798, 7941.64262608184, 7967.123616402191, 8022.27799498048, 8027.919720802775, 8037.598120093972, 4834.081524510367, 4891.608671306287, 4902.19113846215, 4908.460069392364, 4908.754562271872, 3357.4124528207467, 3373.291608762163, 3383.915402114942, 3414.436617958034, 3417.2482053948092, 1165.1086918507349, 1176.923499972499, 1185.4013723069882, 1199.0287866827898, 1237.202004706968, 10556.947215263874, 10583.576656933714, 10595.629152979685, 10599.417032063233, 10601.098906592872, 4447.466304043535, 4456.242438785414, 4494.640428765691, 4495.370648109268, 4502.122086193161, 9143.49710765901, 9153.313501487282, 9157.038510956254, 9168.495732734631, 9168.633254669872, 4827.372441582572, 4827.517248275215, 4829.879253018632, 4833.516648335139, 4836.782344794493, 4439.245328294198, 4440.711353761995, 4445.110977804452, 4448.755318457451, 4449.7330160190495, 3896.5713771485116, 3952.5256969163884, 3953.090789118519, 3973.8807835764396, 3977.985613668496, 1170.9531618735325, 1204.5783975608642, 1253.7429826885466, 1305.28209484783, 1306.8431788185478, 1107.9446027698582, 1112.0991996482874, 1180.9548549533554, 1401.6145559970885, 1485.5543336999074, 7575.393968482508, 7592.81017974555, 7682.385409167253, 7695.422843286776, 7701.114371847198, 1105.5854054729477, 1146.7362506623356, 1189.8572171339495, 1190.4166958190597, 1197.2277880766856, 6056.424639659225, 6144.907826382608, 6151.138840562325, 6151.907721384183, 6156.445919867144, 9208.0, 9548.665796697082, 9556.139947404767, 9564.56959436827, 9573.808523829484, 9730.36752611078, 9743.853842192373, 9755.170810481188, 9769.951150244204, 9771.267154963407, 7393.186749457555, 7649.311561959339, 7672.271134242238, 7679.654415551314, 7699.345555627722, 7328.120625524971, 7432.888506672296, 7498.775036748906, 7503.624818759149, 7512.436567257587, 8649.567521623767, 8858.778530536789, 8870.73387798367, 8902.55487225649, 8910.910890891008, 8751.69369072105, 8931.374803763674, 8953.0, 8966.641334346554, 9091.181793638605, 7208.531445456028, 7213.314735100157, 7277.927220727936, 7295.051643286551, 7298.2701729826595, 7806.297433231037, 7914.44598878073, 7951.681932722858, 7966.800829979297, 7982.08206056311, 6573.079768832463, 7458.627068646654, 7584.772456826304, 7599.164091949991, 7644.235576442311, 6677.69950352245, 7302.306280903305, 7314.451416143704, 7390.482666213314, 7436.256374362737, 7391.445641576795, 7394.55632662042, 7403.925960740324, 7434.36807871337, 7441.739539116322, 6844.315568443315, 6912.135983002125, 6947.096877405905, 6947.79156625302, 6964.233934267328, 6647.867042659216, 6736.292689267556, 6737.764178253738, 6742.561733487308, 6744.730210791513], "unit": "ms", "name": "mootools.html", "value": 4677.789898509986}, {"lowerIsBetter": false, "replicates": [363.09408026972704, 368.7990045425243, 369.83727160049557, 369.96485333893287, 373.4883210002299, 5992.880142397149, 6000.48995835354, 6024.9698751506185, 6035.879282414349, 6051.243594550676, 5743.081107022877, 5774.5091667208335, 5827.35899051104, 5938.46553810157, 5965.045592705168, 4652.97673511632, 4667.113248482794, 4674.0418214266165, 4674.439067311927, 4688.437387513503, 4607.35497030416, 4671.0, 4683.69555978862, 4687.460941991663, 4693.108309421199, 4636.721796692193, 4637.0725854829, 4644.814207431698, 4646.3727396801505, 4646.72119672819, 4554.72671639701, 4635.791389387452, 4640.883977900546, 4644.9535504644855, 4646.954435252058, 4070.61329173728, 4074.8777536673947, 4077.673786097105, 4091.243120022805, 4097.037196258877, 5628.662280263156, 5628.802991895264, 5634.661920284796, 5642.915356269659, 5648.463395977416, 5319.441458646864, 5332.92000619991, 5338.599605029638, 5341.359036915595, 5352.143657014859, 6205.131281620576, 6247.812565623039, 6268.937310626881, 6287.0, 6287.9056814147825, 4470.664700147502, 4476.485204201526, 4478.8880277992985, 4480.529544397824, 4481.753503557303, 6427.58220715652, 6435.420812126931, 6479.967600161969, 6491.837704057342, 6499.317571655003, 4498.055408364215, 4547.840825571089, 4585.95414045862, 4586.564276393738, 4641.094986477672, 4680.134175177603, 4681.063787242497, 4685.1332503486965, 4686.507916668701, 4686.8593942181105, 5366.543843773245, 5371.274877891513, 5374.167004114369, 5378.91931621026, 5380.300560927054, 6313.526485513605, 6338.397852204033, 6354.23749150105, 6367.522435817332, 6375.234971803413, 1646.0535192264497, 1675.6481138960712, 1686.325469812085, 1689.121656738489, 1694.940677076321, 1058.1746237934424, 1116.4975760907623, 1141.1612464838338, 1157.7568710570706, 1163.6974386659529, 6028.487578555784, 6074.878502430015, 6075.787347442907, 6081.087836824423, 6082.513398928075, 6357.936420635827, 6383.744650214032, 6407.359264073555, 6410.45511131559, 6446.194225721785, 5956.195913551615, 6058.848528786815, 6059.848503787441, 6065.757369705162, 6083.543734219951, 3580.1944562473755, 3593.1735700788963, 3609.5488063992, 3612.115031817169, 3612.7651702639246, 6701.497387695942, 6707.5975441473665, 6709.36261055199, 6715.597064176165, 6717.596944183365, 6656.334366563305, 6665.900011499832, 6711.395974362331, 6716.46268298535, 6718.160229971254, 6708.396244338033, 6723.865522689616, 6741.460683145435, 6742.190937087483, 6748.19021717397, 6561.573497722633, 6563.212414510289, 6571.408573228432, 6571.934280657323, 6573.309802470863, 6340.302566717565, 6404.455621272244, 6415.743370265137, 6491.5131365148745, 6509.934900650933, 6658.300878407697, 6680.0, 6745.696443660146, 6774.119364482585, 6779.35596118368, 4597.517260687579, 4638.5593368629925, 4642.16441040616, 4644.140833945731, 4645.047765208056, 6486.254080780771, 6588.209414870246, 6592.110065141144, 6598.04328372393, 6601.933980660132, 6458.321876202931, 6459.063435801876, 6465.0, 6465.256495502889, 6466.773662921775, 6450.0, 6450.129232553545, 6453.096566480603, 6456.644884531396, 6457.0637257596445, 6277.654728989949, 6313.337099604475, 6320.652364120017, 6338.90491642635, 6344.206974128234, 6441.1304473895425, 6505.089287499848, 6512.0, 6516.120323756232, 6521.445677117498, 6296.559240853279, 6303.716332765129, 6310.905336420049, 6312.905306420315, 6346.111544383883], "unit": "ms", "name": "prototype.html", "value": 4839.549240096946}, {"lowerIsBetter": false, "replicates": [669.748844183431, 694.9096617439732, 830.9376796740244, 836.9539675317857, 853.2704537620334, 14760.33578488968, 15169.92415037926, 15182.6963460731, 15233.009854359472, 15259.313330900108, 14596.708065838704, 14643.926780366084, 14650.560483185494, 14658.560243192722, 14705.411783528645, 780.6565111350988, 786.4141214794986, 923.4367036107968, 930.902255263196, 945.2154711589365, 927.4018258223442, 928.0, 929.4376901974309, 935.0088905759882, 935.7005758157393, 967.5452537307455, 977.5307852230933, 978.4569563892037, 983.8179936711731, 984.7685793838442, 800.8398320335956, 813.8535063688533, 958.7315551645585, 965.0253244223314, 971.9659811906549, 723.4682508356353, 726.2156870579761, 727.2908913809047, 728.446380750628, 729.3800269770705, 13975.720485590333, 14157.22135282559, 14161.858381416157, 14179.0, 14257.930655200902, 11878.346690931996, 12353.691157721129, 12769.36153192346, 13590.660233494144, 14166.645833854132, 10542.78914421715, 10705.625303114432, 10867.619633312876, 10961.506732196991, 11128.666140015812, 3824.063104539378, 3831.1954489556947, 3891.8248678809523, 3907.5310962684375, 3964.127891863814, 52049.0, 52484.737576312255, 52594.0, 54117.72941135309, 54200.0, 8785.34109941757, 8803.427777194462, 8839.29285657146, 8873.822523549492, 8967.327450441244, 20518.179272829217, 20658.483537911372, 20713.58572828535, 20768.68846967297, 20771.792282077287, 7802.570858602831, 7945.0863150738405, 7960.960195198987, 7972.3622110231045, 7987.1214166442805, 4573.679842410999, 4681.976590117096, 4684.74233917131, 4707.929381059287, 4730.337752714623, 3255.641879393265, 3290.901272961815, 3295.6374798772117, 3302.8513716882317, 3305.0415379539663, 471.6533347989225, 492.51979320162553, 495.1285737102725, 539.5872157799287, 566.1790403914341, 605.2766943502472, 646.9126667899774, 679.4869873245668, 682.952193346471, 692.7817737412698, 8540.359473039423, 9670.0, 9735.1725103367, 9812.754681133028, 9949.452780097019, 567.6367125039977, 673.8854394752904, 695.0165515795094, 695.7182341151841, 707.2361849202952, 4215.430916826251, 4469.530699276529, 4495.505494395614, 4505.211587972091, 4519.276915693474, 65853.34146658472, 66344.33655663382, 66404.0, 66688.33311666918, 66755.0, 58776.0, 59201.40798591959, 59995.700021499615, 60016.0, 60224.69887650621, 54203.18695219496, 54211.45788542143, 54650.0, 55011.72494137504, 55651.77392904319, 8987.910120898707, 9216.354855160344, 9294.395864268801, 9467.479129730862, 9496.14534691881, 39168.412473813485, 39342.0, 40396.596034039285, 40629.390559141044, 41214.58785412108, 47049.0, 47137.2929406066, 52311.47688523066, 54889.451105488435, 55053.72473137609, 7445.813854653677, 7488.326050655467, 7591.127020392725, 8345.666173352998, 8404.075551689431, 11757.470913808727, 11854.94072529632, 12032.0, 12062.638120856038, 12269.69325766863, 11083.833742493707, 11144.164187685794, 11168.162387821108, 11170.720731981766, 11439.828402573801, 11333.716657083638, 11486.827697584376, 11542.94228528852, 11928.701782455508, 12201.08491863096, 11160.720981975515, 11342.149338799458, 11388.772224555629, 11574.0, 11590.362530060927, 9793.706188814347, 10013.098821106136, 10070.194384449373, 10134.797304054026, 10433.26967112295, 9887.950560247153, 9993.850092248767, 10010.499475026365, 10028.498575071364, 10303.0], "unit": "ms", "name": "yui.html", "value": 6672.410912057293}], "name": "dromaeo_css", "value": 7191.237506074187}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 104.0, 108.0, 110.0, 109.0, 98.0, 109.0, 106.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.1}, {"lowerIsBetter": true, "replicates": [144.0, 121.0, 149.0, 163.0, 130.0, 151.0, 146.0, 126.0, 167.0, 120.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.7}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 160.0, 159.0, 159.0, 160.0, 162.0, 158.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 159.9}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 72.0, 138.0, 72.0, 72.0, 70.0, 69.0, 151.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 85.5}, {"lowerIsBetter": true, "replicates": [89.0, 90.0, 134.0, 89.0, 89.0, 89.0, 126.0, 88.0, 89.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 101.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [158.0, 147.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 55.0, 55.0, 54.0, 54.0, 56.0, 55.0, 53.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 54.7}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 61.5}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 85.0, 78.0, 78.0, 76.0, 79.0, 79.0, 78.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.4}, {"lowerIsBetter": true, "replicates": [114.0, 115.0, 120.0, 108.0, 122.0, 113.0, 115.0, 109.0, 115.0, 108.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 113.9}, {"lowerIsBetter": true, "replicates": [141.0, 136.0, 134.0, 141.0, 144.0, 138.0, 137.0, 133.0, 134.0, 125.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 136.3}, {"lowerIsBetter": true, "replicates": [65.0, 62.0, 60.0, 60.0, 61.0, 60.0, 64.0, 62.0, 61.0, 59.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 61.4}], "name": "kraken", "value": 1453.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.83992835043153], "unit": "score", "name": "Richards", "value": 216.78958200000002}, {"lowerIsBetter": false, "replicates": [170.85255424568598], "unit": "score", "name": "DeltaBlue", "value": 386.9886539999999}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5010.0], "unit": "score", "name": "Decrypt", "value": 53.12994011976049}, {"lowerIsBetter": false, "replicates": [946.073793755913], "unit": "score", "name": "RayTrace", "value": 782.1683729999996}, {"lowerIsBetter": false, "replicates": [553.7098560354374], "unit": "score", "name": "Earley", "value": 1203.6321779999998}, {"lowerIsBetter": false, "replicates": [10437.5], "unit": "score", "name": "Boyer", "value": 63.85274251497008}, {"lowerIsBetter": false, "replicates": [23348.837209302324], "unit": "score", "name": "RegExp", "value": 39.01628984063744}, {"lowerIsBetter": false, "replicates": [527.9831045406547], "unit": "score", "name": "Splay", "value": 154.34395400000002}, {"lowerIsBetter": false, "replicates": [4812.5], "unit": "score", "name": "NavierStokes", "value": 308.3636363636364}], "name": "v8_7", "value": 23399.405827105773}]} 05:09:57 INFO - RETURN: dromaeo_css: 7191.24 05:09:57 INFO - RETURN: kraken: 1453.60 05:09:57 INFO - RETURN: v8_7: 23399.41 05:09:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23399.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1453.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7191.24"}}} 05:09:57 INFO - Return code: 0 05:09:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:09:57 INFO - # TBPL SUCCESS # 05:09:57 INFO - Running post-action listener: _resource_record_post_action 05:09:57 INFO - Running post-run listener: _resource_record_post_run 05:09:58 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506040320; Read time: 8; Write time: 643500 05:09:58 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 240783360; Read time: 0; Write time: 461928 05:09:58 INFO - run-tests - Wall time: 1208s; CPU: 12.0%; Read bytes: 4096; Write bytes: 260317184; Read time: 8; Write time: 181236 05:09:58 INFO - Running post-run listener: _upload_blobber_files 05:09:58 INFO - Blob upload gear active. 05:09:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:09:58 INFO - Copying logs to upload dir... 05:09:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1251.316124 ========= master_lag: 3.61 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-12-16 05:10:02.411831) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:02.415788) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008713 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:02.441358) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:02.441830) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450270141.928501-1109821604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.22 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:10:02.665403) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 05:10:02.665759) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 05:10:02.666104) ========= ========= Total master_lag: 4.36 =========