builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1454542380.62 results: success (0) buildid: 20160203130427 builduid: 669d808f320948cc9396d3650a0d431f revision: 0daf679f5dd1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:00.617920) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:00.618497) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:00.618836) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006354 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:00.644290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:00.647632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:00.677549) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:00.677889) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004760 ========= master_lag: 0.22 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:00.897943) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:00.898260) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:00.898609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:00.898874) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-03 15:33:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-02-03 15:33:01 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.463052 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:01.376013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:01.376300) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017570 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:01.426007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:01.426385) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0daf679f5dd1 --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 0daf679f5dd1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-03 15:33:01,846 Setting DEBUG logging. 2016-02-03 15:33:01,846 attempt 1/10 2016-02-03 15:33:01,846 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0daf679f5dd1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-03 15:33:02,096 unpacking tar archive at: mozilla-beta-0daf679f5dd1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.553839 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:01.992895) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:01.993200) ========= echo 0daf679f5dd1 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0daf679f5dd1'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0daf679f5dd1 program finished with exit code 0 elapsedTime=0.003889 script_repo_revision: '0daf679f5dd1' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:02.042188) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:02.042534) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-03 15:33:02.053774) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-02-03 15:33:02.054053) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:33:02 INFO - MultiFileLogger online at 20160203 15:33:02 in /builds/slave/test-pgo 15:33:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:33:02 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:33:02 INFO - {'append_to_log': False, 15:33:02 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:33:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:33:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:33:02 INFO - 'branch': 'Mozilla-Beta', 15:33:02 INFO - 'buildbot_json_path': 'buildprops.json', 15:33:02 INFO - 'config_files': ('talos/linux_config.py',), 15:33:02 INFO - 'default_actions': ('clobber', 15:33:02 INFO - 'read-buildbot-config', 15:33:02 INFO - 'download-and-extract', 15:33:02 INFO - 'populate-webroot', 15:33:02 INFO - 'create-virtualenv', 15:33:02 INFO - 'install', 15:33:02 INFO - 'run-tests'), 15:33:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:33:02 INFO - 'download_minidump_stackwalk': True, 15:33:02 INFO - 'download_symbols': 'ondemand', 15:33:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:33:02 INFO - 'tooltool.py': '/tools/tooltool.py', 15:33:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:33:02 INFO - '/tools/misc-python/virtualenv.py')}, 15:33:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:33:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:33:02 INFO - 'installer_path': 'installer.exe', 15:33:02 INFO - 'log_level': 'info', 15:33:02 INFO - 'log_name': 'talos', 15:33:02 INFO - 'log_to_console': True, 15:33:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:33:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:33:02 INFO - 'opt_config_files': (), 15:33:02 INFO - 'pip_index': False, 15:33:02 INFO - 'sps_profile': False, 15:33:02 INFO - 'sps_profile_interval': 0, 15:33:02 INFO - 'suite': 'dromaeojs', 15:33:02 INFO - 'system_bits': '32', 15:33:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:33:02 INFO - 'title': 'talos-linux64-ix-041', 15:33:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:33:02 INFO - 'use_talos_json': True, 15:33:02 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:33:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:33:02 INFO - 'work_dir': 'build'} 15:33:02 INFO - ##### 15:33:02 INFO - ##### Running clobber step. 15:33:02 INFO - ##### 15:33:02 INFO - Running pre-action listener: _resource_record_pre_action 15:33:02 INFO - Running main action method: clobber 15:33:02 INFO - rmtree: /builds/slave/test-pgo/build 15:33:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:33:03 INFO - Running post-action listener: _resource_record_post_action 15:33:03 INFO - ##### 15:33:03 INFO - ##### Running read-buildbot-config step. 15:33:03 INFO - ##### 15:33:03 INFO - Running pre-action listener: _resource_record_pre_action 15:33:03 INFO - Running main action method: read_buildbot_config 15:33:03 INFO - Using buildbot properties: 15:33:03 INFO - { 15:33:03 INFO - "properties": { 15:33:03 INFO - "buildnumber": 102, 15:33:03 INFO - "product": "firefox", 15:33:03 INFO - "script_repo_revision": "production", 15:33:03 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 15:33:03 INFO - "repository": "", 15:33:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 15:33:03 INFO - "buildid": "20160203130427", 15:33:03 INFO - "slavename": "talos-linux64-ix-041", 15:33:03 INFO - "pgo_build": "True", 15:33:03 INFO - "basedir": "/builds/slave/test-pgo", 15:33:03 INFO - "project": "", 15:33:03 INFO - "platform": "ubuntu64_hw", 15:33:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:33:03 INFO - "slavebuilddir": "test", 15:33:03 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:33:03 INFO - "branch": "mozilla-beta", 15:33:03 INFO - "repo_path": "releases/mozilla-beta", 15:33:03 INFO - "stage_platform": "linux64-pgo", 15:33:03 INFO - "builduid": "669d808f320948cc9396d3650a0d431f", 15:33:03 INFO - "revision": "0daf679f5dd1" 15:33:03 INFO - }, 15:33:03 INFO - "sourcestamp": { 15:33:03 INFO - "repository": "", 15:33:03 INFO - "hasPatch": false, 15:33:03 INFO - "project": "", 15:33:03 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 15:33:03 INFO - "changes": [ 15:33:03 INFO - { 15:33:03 INFO - "category": null, 15:33:03 INFO - "files": [ 15:33:03 INFO - { 15:33:03 INFO - "url": null, 15:33:03 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.tar.bz2" 15:33:03 INFO - } 15:33:03 INFO - ], 15:33:03 INFO - "repository": "", 15:33:03 INFO - "rev": "0daf679f5dd1", 15:33:03 INFO - "who": "sendchange", 15:33:03 INFO - "when": 1454542348, 15:33:03 INFO - "number": 7559232, 15:33:03 INFO - "comments": "Backed out 2 changesets (bug 1059469) for osx build bustage in WorkerPrivate.cpp a=backout", 15:33:03 INFO - "project": "", 15:33:03 INFO - "at": "Wed 03 Feb 2016 15:32:28", 15:33:03 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 15:33:03 INFO - "revlink": "", 15:33:03 INFO - "properties": [ 15:33:03 INFO - [ 15:33:03 INFO - "buildid", 15:33:03 INFO - "20160203130427", 15:33:03 INFO - "Change" 15:33:03 INFO - ], 15:33:03 INFO - [ 15:33:03 INFO - "builduid", 15:33:03 INFO - "669d808f320948cc9396d3650a0d431f", 15:33:03 INFO - "Change" 15:33:03 INFO - ], 15:33:03 INFO - [ 15:33:03 INFO - "pgo_build", 15:33:03 INFO - "True", 15:33:03 INFO - "Change" 15:33:03 INFO - ] 15:33:03 INFO - ], 15:33:03 INFO - "revision": "0daf679f5dd1" 15:33:03 INFO - } 15:33:03 INFO - ], 15:33:03 INFO - "revision": "0daf679f5dd1" 15:33:03 INFO - } 15:33:03 INFO - } 15:33:03 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.tar.bz2. 15:33:03 INFO - Running post-action listener: _resource_record_post_action 15:33:03 INFO - ##### 15:33:03 INFO - ##### Running download-and-extract step. 15:33:03 INFO - ##### 15:33:03 INFO - Running pre-action listener: _resource_record_pre_action 15:33:03 INFO - Running main action method: download_and_extract 15:33:03 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/test_packages.json 15:33:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:33:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:33:03 INFO - Downloaded 1270 bytes. 15:33:03 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:33:03 INFO - Using the following test package requirements: 15:33:03 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 15:33:03 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 15:33:03 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:33:03 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 15:33:03 INFO - u'jsshell-linux-x86_64.zip'], 15:33:03 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 15:33:03 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:33:03 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 15:33:03 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 15:33:03 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 15:33:03 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 15:33:03 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 15:33:03 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 15:33:03 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:33:03 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 15:33:03 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 15:33:03 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:33:03 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.common.tests.zip 15:33:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 15:33:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:33:03 INFO - Downloaded 21582194 bytes. 15:33:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:33:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 15:33:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:33:04 INFO - Return code: 0 15:33:04 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:04 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.common.tests.zip 15:33:04 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 15:33:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:33:05 INFO - Downloaded 21582194 bytes. 15:33:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:33:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 15:33:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:33:06 INFO - Return code: 0 15:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:06 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 15:33:06 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 15:33:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:33:09 INFO - Downloaded 11132038 bytes. 15:33:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 15:33:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 15:33:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:33:10 INFO - Return code: 0 15:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:10 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.tar.bz2 15:33:10 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 15:33:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:33:10 INFO - Downloaded 57942317 bytes. 15:33:10 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.tar.bz2 15:33:10 INFO - mkdir: /builds/slave/test-pgo/properties 15:33:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:33:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:33:10 INFO - Contents: 15:33:10 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.tar.bz2 15:33:10 INFO - Running post-action listener: _resource_record_post_action 15:33:10 INFO - Running post-action listener: set_extra_try_arguments 15:33:10 INFO - ##### 15:33:10 INFO - ##### Running populate-webroot step. 15:33:10 INFO - ##### 15:33:10 INFO - Running pre-action listener: _resource_record_pre_action 15:33:10 INFO - Running main action method: populate_webroot 15:33:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:33:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:33:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:33:10 INFO - '--tppagecycles', 15:33:10 INFO - '7'], 15:33:10 INFO - 'tests': ['tsvgm']}}, 15:33:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:33:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:33:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:33:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:33:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:33:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:33:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:10 INFO - 'talos_options': ['--e10s'], 15:33:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:10 INFO - 'tests': ['damp', 'tps']}, 15:33:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:10 INFO - 'talos_options': ['--e10s'], 15:33:10 INFO - 'tests': ['damp', 'tps']}, 15:33:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:33:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:33:10 INFO - 'other': {'tests': ['a11yr', 15:33:10 INFO - 'ts_paint', 15:33:10 INFO - 'tpaint', 15:33:10 INFO - 'sessionrestore', 15:33:10 INFO - 'sessionrestore_no_auto_restore']}, 15:33:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:33:10 INFO - 'tests': ['a11yr', 15:33:10 INFO - 'ts_paint', 15:33:10 INFO - 'tpaint', 15:33:10 INFO - 'sessionrestore', 15:33:10 INFO - 'sessionrestore_no_auto_restore']}, 15:33:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:33:10 INFO - 'tests': ['a11yr', 15:33:10 INFO - 'ts_paint', 15:33:10 INFO - 'tpaint', 15:33:10 INFO - 'sessionrestore', 15:33:10 INFO - 'sessionrestore_no_auto_restore']}, 15:33:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:33:10 INFO - 'tests': ['a11yr', 15:33:10 INFO - 'ts_paint', 15:33:10 INFO - 'tpaint', 15:33:10 INFO - 'sessionrestore', 15:33:10 INFO - 'sessionrestore_no_auto_restore']}, 15:33:10 INFO - 'other_l64': {'tests': ['a11yr', 15:33:10 INFO - 'ts_paint', 15:33:10 INFO - 'tpaint', 15:33:10 INFO - 'sessionrestore', 15:33:10 INFO - 'sessionrestore_no_auto_restore']}, 15:33:10 INFO - 'other_nol64': {'tests': ['a11yr', 15:33:10 INFO - 'ts_paint', 15:33:10 INFO - 'tpaint', 15:33:10 INFO - 'sessionrestore', 15:33:10 INFO - 'sessionrestore_no_auto_restore']}, 15:33:10 INFO - 'svgr': {'tests': ['tsvgx', 15:33:10 INFO - 'tsvgr_opacity', 15:33:10 INFO - 'tart', 15:33:10 INFO - 'tscrollx', 15:33:10 INFO - 'cart']}, 15:33:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:33:10 INFO - 'tests': ['tsvgx', 15:33:10 INFO - 'tsvgr_opacity', 15:33:10 INFO - 'tart', 15:33:10 INFO - 'tscrollx', 15:33:10 INFO - 'cart']}, 15:33:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:10 INFO - 'tests': ['tp5o']}, 15:33:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:10 INFO - 'talos_options': ['--e10s'], 15:33:10 INFO - 'tests': ['tp5o']}, 15:33:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:10 INFO - 'talos_options': ['--xperf_path', 15:33:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:10 INFO - 'tests': ['tp5n']}, 15:33:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:10 INFO - 'talos_options': ['--e10s', 15:33:10 INFO - '--xperf_path', 15:33:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:10 INFO - 'tests': ['tp5n']}}, 15:33:10 INFO - 'talos.zip': {'path': '', 15:33:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:33:10 INFO - Running post-action listener: _resource_record_post_action 15:33:10 INFO - ##### 15:33:10 INFO - ##### Running create-virtualenv step. 15:33:10 INFO - ##### 15:33:10 INFO - Running pre-action listener: _resource_record_pre_action 15:33:10 INFO - Running main action method: create_virtualenv 15:33:10 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:33:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 15:33:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:33:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:33:11 INFO - Using real prefix '/usr' 15:33:11 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:33:11 INFO - Installing distribute.............................................................................................................................................................................................done. 15:33:13 INFO - Installing pip.................done. 15:33:13 INFO - Return code: 0 15:33:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d0da44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a350>, '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 0x272b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272b6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:33:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:33:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:33:13 INFO - Using env: {'DISPLAY': ':0', 15:33:13 INFO - 'HOME': '/home/cltbld', 15:33:13 INFO - 'LANG': 'en_US.UTF-8', 15:33:13 INFO - 'LANGUAGE': 'en_US:en', 15:33:13 INFO - 'LOGNAME': 'cltbld', 15:33:13 INFO - 'MAIL': '/var/mail/cltbld', 15:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:13 INFO - 'MOZ_NO_REMOTE': '1', 15:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:13 INFO - 'NO_EM_RESTART': '1', 15:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:13 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:13 INFO - 'SHELL': '/bin/bash', 15:33:13 INFO - 'SHLVL': '1', 15:33:13 INFO - 'TERM': 'linux', 15:33:13 INFO - 'TMOUT': '86400', 15:33:13 INFO - 'USER': 'cltbld', 15:33:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 15:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:13 INFO - '_': '/tools/buildbot/bin/python'} 15:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:33:13 INFO - Cleaning up... 15:33:13 INFO - Return code: 0 15:33:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d0da44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a350>, '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 0x272b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272b6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:33:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:33:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:33:13 INFO - Using env: {'DISPLAY': ':0', 15:33:13 INFO - 'HOME': '/home/cltbld', 15:33:13 INFO - 'LANG': 'en_US.UTF-8', 15:33:13 INFO - 'LANGUAGE': 'en_US:en', 15:33:13 INFO - 'LOGNAME': 'cltbld', 15:33:13 INFO - 'MAIL': '/var/mail/cltbld', 15:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:13 INFO - 'MOZ_NO_REMOTE': '1', 15:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:13 INFO - 'NO_EM_RESTART': '1', 15:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:13 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:13 INFO - 'SHELL': '/bin/bash', 15:33:13 INFO - 'SHLVL': '1', 15:33:13 INFO - 'TERM': 'linux', 15:33:13 INFO - 'TMOUT': '86400', 15:33:13 INFO - 'USER': 'cltbld', 15:33:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 15:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:13 INFO - '_': '/tools/buildbot/bin/python'} 15:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:13 INFO - Downloading/unpacking psutil>=0.7.1 15:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:33:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:15 INFO - Installing collected packages: psutil 15:33:15 INFO - Running setup.py install for psutil 15:33:15 INFO - building 'psutil._psutil_linux' extension 15:33:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:33:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:33:16 INFO - building 'psutil._psutil_posix' extension 15:33:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:33:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:33:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:16 INFO - Successfully installed psutil 15:33:16 INFO - Cleaning up... 15:33:16 INFO - Return code: 0 15:33:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d0da44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a350>, '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 0x272b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272b6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:33:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:33:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:33:16 INFO - Using env: {'DISPLAY': ':0', 15:33:16 INFO - 'HOME': '/home/cltbld', 15:33:16 INFO - 'LANG': 'en_US.UTF-8', 15:33:16 INFO - 'LANGUAGE': 'en_US:en', 15:33:16 INFO - 'LOGNAME': 'cltbld', 15:33:16 INFO - 'MAIL': '/var/mail/cltbld', 15:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:16 INFO - 'MOZ_NO_REMOTE': '1', 15:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:16 INFO - 'NO_EM_RESTART': '1', 15:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:16 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:16 INFO - 'SHELL': '/bin/bash', 15:33:16 INFO - 'SHLVL': '1', 15:33:16 INFO - 'TERM': 'linux', 15:33:16 INFO - 'TMOUT': '86400', 15:33:16 INFO - 'USER': 'cltbld', 15:33:16 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 15:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:16 INFO - '_': '/tools/buildbot/bin/python'} 15:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:33:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:33:18 INFO - Installing collected packages: mozsystemmonitor 15:33:18 INFO - Running setup.py install for mozsystemmonitor 15:33:18 INFO - Successfully installed mozsystemmonitor 15:33:18 INFO - Cleaning up... 15:33:18 INFO - Return code: 0 15:33:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:33: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')]} 15:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33: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')]} 15:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d0da44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a350>, '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 0x272b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272b6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:33:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:33:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:33:18 INFO - Using env: {'DISPLAY': ':0', 15:33:18 INFO - 'HOME': '/home/cltbld', 15:33:18 INFO - 'LANG': 'en_US.UTF-8', 15:33:18 INFO - 'LANGUAGE': 'en_US:en', 15:33:18 INFO - 'LOGNAME': 'cltbld', 15:33:18 INFO - 'MAIL': '/var/mail/cltbld', 15:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:18 INFO - 'MOZ_NO_REMOTE': '1', 15:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:18 INFO - 'NO_EM_RESTART': '1', 15:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:18 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:18 INFO - 'SHELL': '/bin/bash', 15:33:18 INFO - 'SHLVL': '1', 15:33:18 INFO - 'TERM': 'linux', 15:33:18 INFO - 'TMOUT': '86400', 15:33:18 INFO - 'USER': 'cltbld', 15:33:18 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 15:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:18 INFO - '_': '/tools/buildbot/bin/python'} 15:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:18 INFO - Downloading/unpacking blobuploader==1.2.4 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:20 INFO - Downloading blobuploader-1.2.4.tar.gz 15:33:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:33:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:33:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:21 INFO - Downloading docopt-0.6.1.tar.gz 15:33:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:33:21 INFO - Installing collected packages: blobuploader, requests, docopt 15:33:21 INFO - Running setup.py install for blobuploader 15:33:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:33:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:33:21 INFO - Running setup.py install for requests 15:33:21 INFO - Running setup.py install for docopt 15:33:21 INFO - Successfully installed blobuploader requests docopt 15:33:21 INFO - Cleaning up... 15:33:21 INFO - Return code: 0 15:33:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d0da44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a350>, '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 0x272b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272b6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:33:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:33:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:33:21 INFO - Using env: {'DISPLAY': ':0', 15:33:21 INFO - 'HOME': '/home/cltbld', 15:33:21 INFO - 'LANG': 'en_US.UTF-8', 15:33:21 INFO - 'LANGUAGE': 'en_US:en', 15:33:21 INFO - 'LOGNAME': 'cltbld', 15:33:21 INFO - 'MAIL': '/var/mail/cltbld', 15:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:21 INFO - 'MOZ_NO_REMOTE': '1', 15:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:21 INFO - 'NO_EM_RESTART': '1', 15:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:21 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:21 INFO - 'SHELL': '/bin/bash', 15:33:21 INFO - 'SHLVL': '1', 15:33:21 INFO - 'TERM': 'linux', 15:33:21 INFO - 'TMOUT': '86400', 15:33:21 INFO - 'USER': 'cltbld', 15:33:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 15:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:21 INFO - '_': '/tools/buildbot/bin/python'} 15:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:33:22 INFO - Running setup.py (path:/tmp/pip-lwqFxS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:33:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:33:22 INFO - Running setup.py (path:/tmp/pip-CgLg9U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:33:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:33:22 INFO - Running setup.py (path:/tmp/pip-KsPVuu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:33:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:33:22 INFO - Running setup.py (path:/tmp/pip-qgDp2I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:33:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:33:22 INFO - Running setup.py (path:/tmp/pip-_ihUlD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:33:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:33:22 INFO - Running setup.py (path:/tmp/pip-Svdd0Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:33:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:33:22 INFO - Running setup.py (path:/tmp/pip-Kvdx4S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:33:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:33:22 INFO - Running setup.py (path:/tmp/pip-C5kEpv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:33:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:33:22 INFO - Running setup.py (path:/tmp/pip-_1Wsig-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:33:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:33:22 INFO - Running setup.py (path:/tmp/pip-qwJ9vQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:33:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:33:22 INFO - Running setup.py (path:/tmp/pip-VPZ2AJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:33:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:33:22 INFO - Running setup.py (path:/tmp/pip-lhIxRy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:33:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:33:22 INFO - Running setup.py (path:/tmp/pip-1tdYB_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:33:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:33:23 INFO - Running setup.py (path:/tmp/pip-QIQjIV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:33:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:33:23 INFO - Running setup.py (path:/tmp/pip-2Vv9e_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:33:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:33:23 INFO - Running setup.py (path:/tmp/pip-cEbgZ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:33:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:33:23 INFO - Running setup.py (path:/tmp/pip-YsbmET-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:33:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:33:23 INFO - Running setup.py install for manifestparser 15:33:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:33:23 INFO - Running setup.py install for mozcrash 15:33:23 INFO - Running setup.py install for mozdebug 15:33:23 INFO - Running setup.py install for mozdevice 15:33:23 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:33:23 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:33:23 INFO - Running setup.py install for mozfile 15:33:23 INFO - Running setup.py install for mozhttpd 15:33:23 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:33:23 INFO - Running setup.py install for mozinfo 15:33:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:33:24 INFO - Running setup.py install for mozInstall 15:33:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:33:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:33:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:33:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:33:24 INFO - Running setup.py install for mozleak 15:33:24 INFO - Running setup.py install for mozlog 15:33:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:33:24 INFO - Running setup.py install for moznetwork 15:33:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:33:24 INFO - Running setup.py install for mozprocess 15:33:24 INFO - Running setup.py install for mozprofile 15:33:24 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:33:24 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:33:24 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:33:24 INFO - Running setup.py install for mozrunner 15:33:24 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:33:24 INFO - Running setup.py install for mozscreenshot 15:33:24 INFO - Running setup.py install for moztest 15:33:24 INFO - Running setup.py install for mozversion 15:33:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:33:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:33:25 INFO - Cleaning up... 15:33:25 INFO - Return code: 0 15:33:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d0da44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a350>, '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 0x272b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272b6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:33:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:33:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:33:25 INFO - Using env: {'DISPLAY': ':0', 15:33:25 INFO - 'HOME': '/home/cltbld', 15:33:25 INFO - 'LANG': 'en_US.UTF-8', 15:33:25 INFO - 'LANGUAGE': 'en_US:en', 15:33:25 INFO - 'LOGNAME': 'cltbld', 15:33:25 INFO - 'MAIL': '/var/mail/cltbld', 15:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:25 INFO - 'MOZ_NO_REMOTE': '1', 15:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:25 INFO - 'NO_EM_RESTART': '1', 15:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:25 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:25 INFO - 'SHELL': '/bin/bash', 15:33:25 INFO - 'SHLVL': '1', 15:33:25 INFO - 'TERM': 'linux', 15:33:25 INFO - 'TMOUT': '86400', 15:33:25 INFO - 'USER': 'cltbld', 15:33:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 15:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:25 INFO - '_': '/tools/buildbot/bin/python'} 15:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:33:25 INFO - Running setup.py (path:/tmp/pip-CNMJLC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 15:33:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:33:25 INFO - Running setup.py (path:/tmp/pip-TcunSn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:33:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:33:25 INFO - Running setup.py (path:/tmp/pip-eksE_c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:33:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:33:25 INFO - Running setup.py (path:/tmp/pip-Z43A3f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:33:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:33:25 INFO - Running setup.py (path:/tmp/pip-ItPUz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 15:33:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:33:25 INFO - Running setup.py (path:/tmp/pip-5enYbg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 15:33:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:33:25 INFO - Running setup.py (path:/tmp/pip-t3HnSy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 15:33:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:33:25 INFO - Running setup.py (path:/tmp/pip-nS48I1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 15:33:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:33:25 INFO - Running setup.py (path:/tmp/pip-m4rEGN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 15:33:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:33:25 INFO - Running setup.py (path:/tmp/pip-wyuMRh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:33:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:33:26 INFO - Running setup.py (path:/tmp/pip-RJ46sF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 15:33:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:33:26 INFO - Running setup.py (path:/tmp/pip-ErDhWt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 15:33:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:33:26 INFO - Running setup.py (path:/tmp/pip-wHAVRh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 15:33:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:33:26 INFO - Running setup.py (path:/tmp/pip-YyC3_t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 15:33:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:33:26 INFO - Running setup.py (path:/tmp/pip-bKG28_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 15:33:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:33:26 INFO - Running setup.py (path:/tmp/pip-ZXUCia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 15:33:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:33:26 INFO - Running setup.py (path:/tmp/pip-VBzrND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:33:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:28 INFO - Downloading blessings-1.6.tar.gz 15:33:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:33:28 INFO - Installing collected packages: blessings 15:33:28 INFO - Running setup.py install for blessings 15:33:28 INFO - Successfully installed blessings 15:33:28 INFO - Cleaning up... 15:33:28 INFO - Return code: 0 15:33:28 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:33:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:33:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:33:28 INFO - Reading from file tmpfile_stdout 15:33:28 INFO - Current package versions: 15:33:28 INFO - argparse == 1.2.1 15:33:28 INFO - blessings == 1.6 15:33:28 INFO - blobuploader == 1.2.4 15:33:28 INFO - docopt == 0.6.1 15:33:28 INFO - manifestparser == 1.1 15:33:28 INFO - mozInstall == 1.12 15:33:28 INFO - mozcrash == 0.16 15:33:28 INFO - mozdebug == 0.1 15:33:28 INFO - mozdevice == 0.47 15:33:28 INFO - mozfile == 1.2 15:33:28 INFO - mozhttpd == 0.7 15:33:28 INFO - mozinfo == 0.9 15:33:28 INFO - mozleak == 0.1 15:33:28 INFO - mozlog == 3.1 15:33:28 INFO - moznetwork == 0.27 15:33:28 INFO - mozprocess == 0.22 15:33:28 INFO - mozprofile == 0.27 15:33:28 INFO - mozrunner == 6.11 15:33:28 INFO - mozscreenshot == 0.1 15:33:28 INFO - mozsystemmonitor == 0.0 15:33:28 INFO - moztest == 0.7 15:33:28 INFO - mozversion == 1.4 15:33:28 INFO - psutil == 3.1.1 15:33:28 INFO - requests == 1.2.3 15:33:28 INFO - wsgiref == 0.1.2 15:33:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d0da44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a350>, '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 0x272b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272b6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:33:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 15:33:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:33:28 INFO - Using env: {'DISPLAY': ':0', 15:33:28 INFO - 'HOME': '/home/cltbld', 15:33:28 INFO - 'LANG': 'en_US.UTF-8', 15:33:28 INFO - 'LANGUAGE': 'en_US:en', 15:33:28 INFO - 'LOGNAME': 'cltbld', 15:33:28 INFO - 'MAIL': '/var/mail/cltbld', 15:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:28 INFO - 'MOZ_NO_REMOTE': '1', 15:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:28 INFO - 'NO_EM_RESTART': '1', 15:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:28 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:28 INFO - 'SHELL': '/bin/bash', 15:33:28 INFO - 'SHLVL': '1', 15:33:28 INFO - 'TERM': 'linux', 15:33:28 INFO - 'TMOUT': '86400', 15:33:28 INFO - 'USER': 'cltbld', 15:33:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 15:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:28 INFO - '_': '/tools/buildbot/bin/python'} 15:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 15:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 15:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 15:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 15:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 15:33: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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:33: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:33:28 INFO - Cleaning up... 15:33:28 INFO - Return code: 0 15:33:28 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d0da44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a350>, '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 0x272b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272b6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:33:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 15:33:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:33:28 INFO - Using env: {'DISPLAY': ':0', 15:33:28 INFO - 'HOME': '/home/cltbld', 15:33:28 INFO - 'LANG': 'en_US.UTF-8', 15:33:28 INFO - 'LANGUAGE': 'en_US:en', 15:33:28 INFO - 'LOGNAME': 'cltbld', 15:33:28 INFO - 'MAIL': '/var/mail/cltbld', 15:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:28 INFO - 'MOZ_NO_REMOTE': '1', 15:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:28 INFO - 'NO_EM_RESTART': '1', 15:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:28 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:28 INFO - 'SHELL': '/bin/bash', 15:33:28 INFO - 'SHLVL': '1', 15:33:28 INFO - 'TERM': 'linux', 15:33:28 INFO - 'TMOUT': '86400', 15:33:28 INFO - 'USER': 'cltbld', 15:33:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 15:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:28 INFO - '_': '/tools/buildbot/bin/python'} 15:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:29 INFO - Downloading/unpacking jsonschema 15:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:33:30 INFO - Downloading/unpacking functools32 (from jsonschema) 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:31 INFO - Downloading functools32-3.2.3-2.tar.gz 15:33:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:33:31 INFO - warning: no files found matching '*.txt' 15:33:31 INFO - no previously-included directories found matching 'build' 15:33:31 INFO - no previously-included directories found matching 'dist' 15:33:31 INFO - no previously-included directories found matching '.git*' 15:33:31 INFO - Installing collected packages: jsonschema, functools32 15:33:31 INFO - Running setup.py install for functools32 15:33:31 INFO - warning: no files found matching '*.txt' 15:33:31 INFO - no previously-included directories found matching 'build' 15:33:31 INFO - no previously-included directories found matching 'dist' 15:33:31 INFO - no previously-included directories found matching '.git*' 15:33:31 INFO - Successfully installed jsonschema functools32 15:33:31 INFO - Cleaning up... 15:33:31 INFO - Return code: 0 15:33:31 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d0da44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a350>, '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 0x272b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272b6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:33:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 15:33:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:33:31 INFO - Using env: {'DISPLAY': ':0', 15:33:31 INFO - 'HOME': '/home/cltbld', 15:33:31 INFO - 'LANG': 'en_US.UTF-8', 15:33:31 INFO - 'LANGUAGE': 'en_US:en', 15:33:31 INFO - 'LOGNAME': 'cltbld', 15:33:31 INFO - 'MAIL': '/var/mail/cltbld', 15:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:31 INFO - 'MOZ_NO_REMOTE': '1', 15:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:31 INFO - 'NO_EM_RESTART': '1', 15:33:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:31 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:31 INFO - 'SHELL': '/bin/bash', 15:33:31 INFO - 'SHLVL': '1', 15:33:31 INFO - 'TERM': 'linux', 15:33:31 INFO - 'TMOUT': '86400', 15:33:31 INFO - 'USER': 'cltbld', 15:33:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 15:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:31 INFO - '_': '/tools/buildbot/bin/python'} 15:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:31 INFO - Downloading/unpacking flake8 15:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:33:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:33:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:33:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:33:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:33:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:33:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:33:34 INFO - no previously-included directories found matching 'docs/_build' 15:33:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:33:34 INFO - Running setup.py install for pep8 15:33:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:33:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:33:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:33:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:33:34 INFO - no previously-included directories found matching 'docs/_build' 15:33:34 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:33:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:33:34 INFO - Cleaning up... 15:33:34 INFO - Return code: 0 15:33:34 INFO - Running post-action listener: _resource_record_post_action 15:33:34 INFO - Running post-action listener: _start_resource_monitoring 15:33:34 INFO - Starting resource monitoring. 15:33:34 INFO - ##### 15:33:34 INFO - ##### Running install step. 15:33:34 INFO - ##### 15:33:34 INFO - Running pre-action listener: _resource_record_pre_action 15:33:34 INFO - Running main action method: install 15:33:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:33:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:33:34 INFO - Reading from file tmpfile_stdout 15:33:34 INFO - Detecting whether we're running mozinstall >=1.0... 15:33:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:33:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:33:34 INFO - Reading from file tmpfile_stdout 15:33:34 INFO - Output received: 15:33:34 INFO - Usage: mozinstall [options] installer 15:33:34 INFO - Options: 15:33:34 INFO - -h, --help show this help message and exit 15:33:34 INFO - -d DEST, --destination=DEST 15:33:34 INFO - Directory to install application into. [default: 15:33:34 INFO - "/builds/slave/test-pgo"] 15:33:34 INFO - --app=APP Application being installed. [default: firefox] 15:33:34 INFO - mkdir: /builds/slave/test-pgo/build/application 15:33:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:33:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:33:49 INFO - Reading from file tmpfile_stdout 15:33:49 INFO - Output received: 15:33:49 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:33:49 INFO - Running post-action listener: _resource_record_post_action 15:33:49 INFO - ##### 15:33:49 INFO - ##### Running run-tests step. 15:33:49 INFO - ##### 15:33:49 INFO - Running pre-action listener: _resource_record_pre_action 15:33:49 INFO - Running main action method: run_tests 15:33:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:33:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:33:49 INFO - Python 2.7.3 15:33:49 INFO - Return code: 0 15:33:49 INFO - grabbing minidump binary from tooltool 15:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:49 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 0x272a350>, '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 0x272b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272b6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:33:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 15:33:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:33:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:33:49 INFO - Return code: 0 15:33:49 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:33:49 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:33:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:33:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:33:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:33:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:33:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:33:50 INFO - Return code: 0 15:33:50 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/1454533467/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:33:50 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/1454533467/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost 15:33:50 INFO - Using env: {'DISPLAY': ':0', 15:33:50 INFO - 'HOME': '/home/cltbld', 15:33:50 INFO - 'LANG': 'en_US.UTF-8', 15:33:50 INFO - 'LANGUAGE': 'en_US:en', 15:33:50 INFO - 'LOGNAME': 'cltbld', 15:33:50 INFO - 'MAIL': '/var/mail/cltbld', 15:33:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:33:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:50 INFO - 'MOZ_NO_REMOTE': '1', 15:33:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:33:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:50 INFO - 'NO_EM_RESTART': '1', 15:33:50 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:50 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:33:50 INFO - 'SHELL': '/bin/bash', 15:33:50 INFO - 'SHLVL': '1', 15:33:50 INFO - 'TERM': 'linux', 15:33:50 INFO - 'TMOUT': '86400', 15:33:50 INFO - 'USER': 'cltbld', 15:33:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317', 15:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:50 INFO - '_': '/tools/buildbot/bin/python'} 15:33:50 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/1454533467/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] with output_timeout 3600 15:33:50 INFO - mozversion INFO | application_buildid: 20160203130427 15:33:50 INFO - mozversion INFO | application_changeset: 0daf679f5dd1502f584a9338143ce66887ac9acb 15:33:50 INFO - mozversion INFO | application_display_name: Nightly 15:33:50 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:33:50 INFO - mozversion INFO | application_name: Firefox 15:33:50 INFO - mozversion INFO | application_remotingname: firefox 15:33:50 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:33:50 INFO - mozversion INFO | application_vendor: Mozilla 15:33:50 INFO - mozversion INFO | application_version: 45.0 15:33:50 INFO - mozversion INFO | platform_buildid: 20160203130427 15:33:50 INFO - mozversion INFO | platform_changeset: 0daf679f5dd1502f584a9338143ce66887ac9acb 15:33:50 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:33:50 INFO - mozversion INFO | platform_version: 45.0 15:33:50 INFO - 2016-02-03 15:33:50,528 DEBUG : using testdate: 1454542430 15:33:50 INFO - 2016-02-03 15:33:50,528 DEBUG : actual date: 1454542430 15:33:50 INFO - 2016-02-03 15:33:50,536 INFO : starting webserver on 'localhost:39369' 15:33:50 INFO - 2016-02-03 15:33:50,537 INFO : Starting test suite talos-linux64-ix-041 15:33:50 INFO - 2016-02-03 15:33:50,537 INFO : Starting test dromaeo_css 15:33:50 INFO - 2016-02-03 15:33:50,537 DEBUG : operating with platform_type : linux_ 15:33:50 INFO - 2016-02-03 15:33:50,538 INFO : Initialising browser for dromaeo_css test... 15:33:50 INFO - 2016-02-03 15:33:50,554 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWGsxCe/profile http://localhost:39369/getInfo.html 15:33:54 INFO - 2016-02-03 15:33:54,578 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:33:54 INFO - 2016-02-03 15:33:54,579 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:33:54 INFO - 2016-02-03 15:33:54,579 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:33:54 INFO - 2016-02-03 15:33:54,579 DEBUG : BROWSER_OUTPUT: __metrics 15:33:54 INFO - 2016-02-03 15:33:54,841 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:33:55 INFO - 2016-02-03 15:33:55,774 INFO : Browser initialized. 15:33:55 INFO - 2016-02-03 15:33:55,774 INFO : Running cycle 1/1 for dromaeo_css test... 15:33:55 INFO - 2016-02-03 15:33:55,775 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWGsxCe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:34:07 INFO - 2016-02-03 15:34:07,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 135077888 15:34:07 INFO - 2016-02-03 15:34:07,493 DEBUG : BROWSER_OUTPUT: 15:34:58 INFO - 2016-02-03 15:34:58,332 DEBUG : BROWSER_OUTPUT: 1454542498329 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:37:06 INFO - 2016-02-03 15:37:06,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39369/tests/dromaeo/cssquery-ext.html) 15:37:07 INFO - 2016-02-03 15:37:07,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 234811392 15:37:07 INFO - 2016-02-03 15:37:07,644 DEBUG : BROWSER_OUTPUT: 15:40:09 INFO - 2016-02-03 15:40:09,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/dromaeo/cssquery-ext.html (next: http://localhost:39369/tests/dromaeo/cssquery-jquery.html) 15:40:10 INFO - 2016-02-03 15:40:10,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 212697088 15:40:10 INFO - 2016-02-03 15:40:10,282 DEBUG : BROWSER_OUTPUT: 15:43:11 INFO - 2016-02-03 15:43:11,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39369/tests/dromaeo/cssquery-mootools.html) 15:43:12 INFO - 2016-02-03 15:43:12,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 213069824 15:43:12 INFO - 2016-02-03 15:43:12,539 DEBUG : BROWSER_OUTPUT: 15:46:14 INFO - 2016-02-03 15:46:14,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39369/tests/dromaeo/cssquery-prototype.html) 15:46:14 INFO - 2016-02-03 15:46:14,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 203878400 15:46:14 INFO - 2016-02-03 15:46:14,836 DEBUG : BROWSER_OUTPUT: 15:49:17 INFO - 2016-02-03 15:49:17,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39369/tests/dromaeo/cssquery-yui.html) 15:49:17 INFO - 2016-02-03 15:49:17,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 198549504 15:49:17 INFO - 2016-02-03 15:49:17,801 DEBUG : BROWSER_OUTPUT: 15:52:19 INFO - 2016-02-03 15:52:19,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/dromaeo/cssquery-yui.html (next: http://localhost:39369/tests/dromaeo/cssquery-dojo.html) 15:52:20 INFO - 2016-02-03 15:52:20,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 217096192 15:52:20 INFO - 2016-02-03 15:52:20,236 DEBUG : BROWSER_OUTPUT: 15:52:20 INFO - 2016-02-03 15:52:20,237 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:52:20 INFO - 2016-02-03 15:52:20,238 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:52:20 INFO - 2016-02-03 15:52:20,238 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:52:20 INFO - 2016-02-03 15:52:20,238 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:52:20 INFO - 2016-02-03 15:52:20,239 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3300.702936735694;3350.2629421527254;3388.9661103388958;3391.4404123319655;3407.3526030054295;5488.807891723791;5547.0570003099465;5548.528375088117;5551.056320425528;5563.443655634434;5534.169874518814;5586.050371436855;5594.24477695511;5599.41206173351;5605.047141985862;4844.709317440947;5039.59683225342;5096.694198348093;5180.948575139228;5183.3779946406485;4986.526280003394;5043.1678773002595;5048.570871475929;5055.216441451581;5056.646034777567;5027.824026159085;5083.0596339677095;5102.260172275037;5103.795848166069;5118.820841270556;5076.8730781730565;5159.251908473288;5176.974115129438;5186.403563590197;5208.453112423179;4844.56398924095;4882.072406242803;5094.032133894548;5101.795928162869;5145.434002259748;5222.791088356499;5321.281626980385;5323.041852466555;5336.092864213093;5337.11937530307;5913.319968203668;5936.347001829795;5941.22764040672;5974.790882319141;5975.745093530364;5767.221425107598;5849.268841394825;5873.060310350324;5996.2504686914135;6011.368806275322;5608.46719561641;5632.464915832989;5633.521150702195;5634.408387119375;5662.886742265132;6108.144859719643;6111;6111.480524155408;6116.3577824328695;6119.173911521976;5623.493885550321;5688.146777983336;5714.457126572969;5854.385289544622;5924.555658325643;5946.494547963472;6045.516358691382;6045.758169673164;6048.516118710492;6055.7274922628585;5985.491233245136;5999.340072592011;6022.69886505673;6028.457438830526;6044.24446944132;5704.686242256716;5778.422157784272;5931.13998470228;6038.064100064497;6065.090236464477;4537.3647689323525;4540.614047805973;4542.841000564964;4543.568361005699;4570.8171673133365;3992.9800350998057;4078.469798926121;4098.877033688994;4103.322951712994;4122.154958233555;5483.259759932438;5506.146547285177;5564.248826408383;5589.133684278943;5590.077637189899;5892.499137573354;5912.320083190402;5923.555733320019;5929.703514824241;5930.140129681172;5384.488473595002;5422.674639521641;5596.720163991866;5607.523360514402;5613.326400831927;5067.189249720027;5119.6160287978555;5139.408967968731;5140.280360749498;5172.689638621695;6112.052631842072;6164.7842325518395;6203.844903877349;6204.534659900525;6205.844853878599;5695.174199741097;5802.390748971297;5802.767889284381;5978.103284507359;5986.461218490357;6101.7995677850195;6141.477974372228;6141.785037523665;6147.44672979434;6158.661273629814;5850.824475265749;5889.411058894077;5901.704914754159;5903.911441328298;5929.970350148222;5742.36833948257;5862.325832529314;5949.137375080676;5973.342932277359;6081.939180608138;5823.563232757476;5827.358990510956;5831.271091113611;5840.503557197686;5856.472917437451;5763.250777399079;5811.041178205549;5821.330546987151;5822.912656310244;5835.67903765297;5475.178723191394;5525.723713814374;5606.971965140148;5686.545076393962;5708.315002199763;5805.970970145122;5811.883762324645;5813.215215945962;5829.766809327749;5830.271216097988;5664.85837854057;5727.284089488814;5727.627704199213;5734.627249228787;5738.1679656450415 15:52:20 INFO - 2016-02-03 15:52:20,241 DEBUG : BROWSER_OUTPUT: |1;ext.html;582.8426324892279;615.8152554233732;619.6994457688023;621.5928566788754;632.8481164520515;31981.52027719586;39569.40645890314;39818.800905995464;39964.60035399645;40051;45224.77387613057;45964.540354596444;46018;46125.538744612546;46186.53813461864;7977;8102.270795628392;8102.513849169069;8949.642014319435;9125.315601329894;10541.525631346607;10710.357378557272;10810.29733067352;10815.35107893525;10830.40432776197;10521.368717876952;10624.09695175911;10635.627753028646;10640.62757803477;10646.361218326925;10496.317739346956;10583.047525722644;10600.151987840954;10605.045545900868;10607.3105248159;10310.896891031069;10416.739581510446;10439.478026098664;10444.321119127308;10447.634332798316;42616.78691606553;42696.78651606722;42952.78523607362;43035;43037.35443968343;3901.609839016104;3994.7403418777685;4221.936670949938;4365.301551751736;4379.388431635862;32226.838865805756;32266;32441.513377299358;32597.674023259937;33442.3311533768;4285.785710714452;4320.503142138663;4341.435613370273;4357.629601483878;4386.670999675037;292073;292187;293740;295375;295532.52233738906;61287.38712612906;61488.69255653693;61565;61565;61635.383646163864;66251;66252.33747662461;66254;66458.66770666212;66492.667536662;16548.503544893672;16906.74639880403;16910.915445422695;17061.061641609584;17106.05916674595;12872.549460769016;12907.096503244871;12978.415971281314;12991.610251692464;13000.67498312531;19844.702329465068;20195.394138175878;20233.17901388882;20277.087531061137;20278;8198.918010819934;8380.120087390736;8443.324534037261;8510.063892971768;8566.78583035429;1043.2801367056707;1090.0571006079683;1147.9655610331704;1156.8316000839213;1215.2222577550374;29473;30414.239644009078;30484.695153048186;30917.84541077325;31095.378092438026;1061.5117046158698;1155.9364234967159;1168.2581560709011;1234.4259919137464;1273.2933222061845;13333.133346332457;14366.56900292993;14468.855311446961;14486.130832150106;15335.846641533442;266755;269771;270101;271172;272068;49504;50926.74536627367;51398.74300628473;51661;51720.741396292775;1342.147736187528;1452.7167202395642;1470.8823294136657;1484.5472130999933;1486.7026594681106;27342.316442089108;28534.42931141324;28947;29744;29984.550231746976;44488.11023779442;44820.10359792851;44862.87842803956;46008.309875351224;47264;332774;335748;336000;339102;341336;31879.521807173376;32289.677103229606;32294.83852580722;32359.676403236608;32376.676233237366;43066;43232.56767432411;43598;44397.77801110974;44404.333934990354;36298;36451;37451.625483744814;37451.625483744814;37646.811765941;36781.63218367889;37355.626443735215;37473.81263093667;37791.811040944616;37844.05389865275;36750.26499469942;36937.630623694495;36972.44541331936;37093.81453092717;37300.440493393166;32663.510047348835;33487.16282092967;33635.663643364234;34045.829770850985;34356.14109647279;25917.452818484206;26026.73973260319;26120.8693956529;26202;26601.600975984988 15:52:20 INFO - 2016-02-03 15:52:20,242 DEBUG : BROWSER_OUTPUT: |2;jquery.html;385.8765195137555;389.1341764573822;391.5634068014164;391.9216156768647;392.1412107484608;14481.275936203201;17707.380241691542;17859;19421.32025379114;19422.640415170943;12066.215695979778;12313.261204327746;12336.629901102959;17599;17948.461546153605;5065.062963351773;5170.3795544534705;5178.404483484391;5187.8443646690475;5192.92210616841;4094.263032654121;4197.496300443951;5236.581073514109;5694.943050569504;5863.677497737623;5762.366139724627;5767.740451679684;5802.448767367115;5818.1854540364175;5837.24115864937;6015.067664511986;6323.177986861679;6323.525735569828;6325.0828629848875;6326.778562750282;5520.254765606672;5656.462636049569;5661.716914154317;5677.829665110054;5678.5741069419955;21400;21448.89275553628;21457.67813482799;22116.447088822908;22359.10563577455;2344.976550234493;2417.697787776528;2430.3073624017247;2519.634652975327;2534.9493010139877;10452.059314661641;10482.528286227061;10497.317674351143;10603.310784798963;10674.893251067546;1886.6886963650982;1912.225548652798;1944.7763507196712;1954.3843689237988;1963.6367272054572;66333.66833165851;69267.65366173137;69986.95019574762;71188.28811711869;71305.2869471309;10857;10929.508172132273;10956.945215274032;10983.340999540053;11019.173561982883;14601.85398146005;14617.488387906586;14640.414383424544;14676.486322978644;14846.925765371105;8026.077001144827;8049.074356448966;8073.878891816627;8119.066307374609;8136.389770767216;7329.963350183215;7335.926640733524;7387.261273872569;7412.925870741331;7487.213842546563;4833.10587541306;4856.198727210041;4868.075065737498;4875.317455556225;4891.461939186686;1772.114187965188;1834.385480863899;1893.4130419569976;1935.1872213670292;1939.9515012124527;913.8857642794651;968.1577027985697;1018.8166130096654;1053.4100903494068;1059.9682009539727;14184;16737.665246694996;17171.484855454357;17441.389551365643;17563;985.522021819417;993.2004736187439;1013.1185868294631;1047.701405099543;1087.9619213327496;7700.345470634947;10072.496375181358;10162.796744065077;10167.796644067077;10171.186305095574;580331;606839;608574;625792;640475;83717;84676.57661711652;84740.57629711935;86040.56979715062;88172.5591372039;1189.74420499593;1200.1239095460362;1202.561065211209;1203.6750077479032;1206.6862615719801;15964.760528592313;16010.199490025685;16021.198940053184;16196.595085122966;16342.836571634132;36524;37659.43510847395;37678.434823478216;37758.43362349622;38144.237115258096;49643.75178124086;49941.75029124831;50355.24467133069;50886.491135088174;52306.738466307426;10014.799704005733;10580.735481612714;10632.521536531029;10635.415052172204;10636.84044739314;17098.743518847477;17864.91067544654;17988.91005544964;18293.81706182921;18313.816861831212;13796.379162937892;13805.585832425044;13932.58202253934;14062.226577537924;14087.788683169556;13761.793573096611;14900.925495372454;15111.395544178109;15434.84565154379;15832.762508562151;11179;13373.53192638253;13822.308884555932;13875.306234688427;14375.353109110325;9838.75403114928;9890.653827116017;9945.204383649147;10100.141487973311;10112.848307275544;10068.39589624625;10164.0344167304;11630.6510804676;13356.265405402795;13683.315834208448 15:52:20 INFO - 2016-02-03 15:52:20,243 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1559.0256089943784;1560.8829337799662;1766.7261574455963;1788.8121747216542;1818.908654807116;7686.4235182361335;7777.961110194448;7793.1817159198245;7795.727149549767;7812.3750099992;6739.2923743006895;6895.344942230493;6896.517243792937;7538.698452061924;7844.686212551491;2352.3178278299274;2368.8223383246327;2385.451346190377;2394.6048901931163;2396.724376696685;2394.3654931443093;2412.1436889904007;2445.510897820434;2447.1801946347996;2447.5227330670527;2069.037897377719;2108.704781330615;2323.9767602324014;2360.3037104054347;2363.5745565798147;2306.7808558186944;2331.6852224949585;2348.0607756897207;2372.833901626887;2374.786269235777;2406.193925035115;2413.722421921484;2425.1875621666763;2429.4047958250167;2430.7447717989535;7806.297433231037;7851.960740196319;7862.371010319218;7868.645910934022;7879;4727.598154156901;4820.493848145964;4835.1296766582;4835.323054772335;4835.347228124228;3273.885414010522;3276.541284220211;3328.8169150696704;3391.7286617070577;3406.0633325835347;1042.2027149230844;2062.597793430282;2106.2312256026594;2123.522207503315;2145.839062070351;10794.5682172713;10910.181736369805;10925.07136893365;10939.45302734868;10940.288881222696;4241.448611680462;4283.721558098714;4426.203283408953;4433.401490798701;4447.266201076851;8724.956375218084;8751.606177722018;8753.080926502753;8765.561721913879;8769.736907892773;4766.380370551806;4785.234362502053;4803.159447096744;4811.591014763784;4813.253945638362;4306.1172459645695;4354.042110735633;4355.06366131277;4357.825686972549;4364.236258654722;3636.2727454509204;3656.6526180012856;3681.1533347330264;3681.7790932544135;3707.9814600926825;1082.5886163257912;1092.4046394714899;1138.7210133517342;1151.1999160583314;1155.7168493718925;1208.3293771956473;1210.5278941212935;1242.67069226655;1394.7280280345235;1456.271864067966;7446.180920098785;7449.329560339595;7525.3227209551405;7538.3592394645975;7545.622718864144;680.7106979533777;685.2701872505766;685.6160550091964;689.1041645860362;832.8049249327235;5896.174535565025;6002.579819412686;6004.249468816398;6006.249218847644;6013.909791353133;9101.81796364069;9173.449593024307;9411.29415293842;9503.66737164196;9534.28492863038;9339.626414943326;9341.20599749029;9342.90657093434;9437.622495100119;9449.244060475145;7382.5570465772225;7424.220456852061;7444.85110297791;7511.211322811136;7514.5491270525035;7283.672234749343;7306.525075870051;7308.378787802883;7316.195218526064;7325.670344834602;8238.340932725248;8292.12932642088;8570.871436928326;8580.0561938188;8593.398462107592;8496.957515212385;8538.871916921127;8574.871376929226;8579.399442038997;8691.95654021726;6681.131452911285;6927.68825402848;6930.930690693029;6947.444204463732;6957.234704182637;7486.513376630502;7532.7740167795055;7539.0576177977755;7540.245975402416;7548.924510754822;6525.673716314071;6929.792106236821;7115.288471152843;7141.607211603204;7251.093613298338;6609.834754131185;6685.197776266879;7072.611006394698;7143.607101609254;7181.748638797826;7107.502474826712;7118.323759242864;7118.786436406916;7131.42948564124;7152.284771522806;6769.458443324621;6789.626570538668;6811.489138314547;6821.522493425413;6860.794176174722;6760.898586521304;6830.351116643911;6831.897521537082;6835.008923706134;6841.760538381132 15:52:20 INFO - 2016-02-03 15:52:20,244 DEBUG : BROWSER_OUTPUT: |4;prototype.html;364.81212175729496;368.092651613772;368.48596208289456;371.52630396244774;372.6683251905803;6062.363451837554;6063.060225665029;6094.1468194452755;6110.205673262481;6142.631442113477;5918.52651787857;5950.196723442334;6005.039193729004;6053;6114.785982490614;4758.095961767271;4762.333273341735;4773.665843390964;4778.713277203362;4799.112164249616;4576.679632425731;4782.354382158416;4788.856334309959;4791.880202994918;4797.40032495938;4615.169269531483;4657.184992626294;4695.741734204617;4705.411823522059;4709.882252943687;4693.436787585511;4694.389729335182;4717.504662010474;4727.976360118195;4736.668433209677;4162.1259535497275;4162.458880345566;4165.895852603679;4166.104287578185;4176.248275310443;5765.769369225226;5829.213056237396;5864.354920958691;5874.647521148702;5880.8235752927485;5466.972665136649;5471.644343117685;5515.641483303572;5516.393196748354;5526.723663816793;6511.837204069889;6515.120458738104;6516.674166291714;6518.543701940866;6520.608763474159;4615.753746488463;4620.653450991155;4622.653301002405;4624.699394539344;4640.535946405366;6563.113979612739;6791.558548694319;6810.455163586901;6814.897776533356;6818.897716534256;4441.71128876622;4443.400140980926;4446;4450.2434586120435;4466.709663871838;4484.596386325181;4488.192125417456;4490.371348011281;4493.168763778712;4499.68502204849;5272.868178295574;5291.550218231493;5294.047071527085;5295.4969277918535;5302.3637163540625;6361.840953976188;6445.387688169616;6525.641089740015;6530.67346632676;6593.604383736991;1641.9014859108254;1648.2994727240875;1652.0335603671747;1652.3720986025473;1658.6516831465528;1085.2999815119204;1110.8722496912958;1115.8214685650257;1132.7168207948014;1133.3313345126414;6381.872362552723;6383.425491705769;6396.488280937514;6396.488280937514;6405.167328247298;6563.50773691975;6789.524733268722;6791.4906382021545;6791.626460544718;6795.150606174228;6264.342244064399;6326.936730632727;6451.870962580722;6464.773732919325;6468.256150542654;3652.8721494747556;3696.704263658901;3700.870469533553;3700.9444858327147;3702.61122582125;6915.446764258847;7050.118735158106;7064.293570642997;7075.646217689095;7086.964565177141;6950.165980082423;7010.193827709879;7023.403010744144;7024.5082844200415;7028.297170282931;7102.5028248022145;7102.68037938294;7106.467014973794;7112.715491380287;7114.110736157981;6705.1283333166375;6813.8977915330315;6820.147481564804;6822.283660215804;6845.691943862438;6764.28974957642;6767.86464270702;6769.932300677127;6771.052052712525;6775.119234499483;7055.753048643272;7085;7085.468589855885;7092.219855815959;7122.786316410516;4593.44878614555;4596.333531637827;4616.053708989716;4620.5379462053525;4717.528247175393;6819.454443644596;6824.078749368771;6830.385265326145;6831.487638427038;6833.658317084027;6655.2013758347375;6663.26704062543;6670.132882725215;6673.632950187786;6674.26583075871;6505.8698826024165;6639.800805975829;6647.102641143577;6647.235567909753;6647.534672573067;6496.837579060372;6527.314631963575;6534.640594767334;6536.281009089092;6537.5096867736065;6661.800145995628;6668.366505182;6669.0996715444735;6669.166354205724;6674.733010679518;6277.2781130170615;6383.648899310582;6498.642574658439;6514.51141164424;6519.4132528072705 15:52:20 INFO - 2016-02-03 15:52:20,244 DEBUG : BROWSER_OUTPUT: |5;yui.html;810.6392655268404;838.0990435282073;875.0418291970291;907.201662536967;960.812641534901;15147.772783408243;15402.460913868017;15413.845861541382;15440.07359558426;15444.536663900088;13911.930440347784;14773.11361318319;14779.113253204789;14788.334524946376;14810.629734256621;757.3486801350834;761.8590560746279;763.3702195688579;915.7802127489388;928.9163975242227;765.3571000359697;898.4564338575166;921.4102974096584;921.8110287391069;924.4776701163854;953.6328513522309;955.6034245787989;960.7213907966682;961.4952150121208;961.9470929098896;955.5986485676033;956.741679746468;956.9138777509988;957.0716405087054;957.6121670723368;710.2364957670474;712.081414974682;712.3090602115991;713.7965679781238;718.9101362329709;12757.170783899017;12769.48922043117;12791.296478693668;12858.614241572768;12874.806877896839;13148.474061037547;13339.933300333436;13367.131136476099;13922.02545821793;13931.233782141979;10608.257421980465;11083.833742493869;11151.665450036511;11314.151438642053;11398.031167350786;4069.776162311072;4103.9179216415505;4105.158442519306;4167;4180.749155050677;48606.51393486055;49133.754331228476;49401.75299123481;49912.251316230286;50453;11099.722506937229;11161.609343672932;11217.607383741693;11291.661250162344;11458;20291.8985405072;20385.79614203839;20432.693509597368;20444.48888777763;20467.4883127923;8450.87323690145;8668.306535477273;8733.606987685569;8780.341474389446;8848.247898928663;4954.925676114861;4978.77595508203;4987.476314986947;5018.548330650259;5028.64799464034;3340.5824271966003;3358.6809253120914;3363.360961417323;3379.6113446953914;3382.3573521030926;543.4864053469433;572.6106247751569;572.653544605516;602.7197353230769;602.8342205893414;727.5307426709743;758.7951253161615;763.8701420758484;765.7013764631798;780.2236774409499;8522.914770852212;8917.152870477294;9006.63973441055;9030.63877444908;9080.273578113734;654.3718030690591;722.5700708078684;773.9148693643695;796.609661265987;797.079373323812;4211.978940105279;4354.216241076573;4377.124575084996;4388.407564978751;4427.608257454598;57235.42764572301;57383.713081434325;59042.70478647665;59456.70271648614;59482;51734.22398664023;52896;52979;54518.182227266625;54706;49164.262536061986;49780;49841.25238121431;50068;50140;8930.106989301017;9073.274138068806;9126.726198213799;9174.633014679604;9286.442813431217;36833.81583092068;37242.25515489621;37656.623433765315;39043.219135616564;39173.804130979166;45611;46864.297035543816;47111.293330600754;47367.28949065698;47599.762001189774;11801.114916381133;11957.880421196025;12219.816702749287;12225.327606981702;12445.37773111359;12361.196522226386;12514.436850341574;12627;12798.488060477477;13214.207147571176;11267.830982535432;11296.322220666787;11336.546538138711;11345.602903898323;11595.884041159481;10821.134309255083;11185;11240.943795280971;11244.943775281072;11470.426478675867;11137.387443690675;11201.831972520582;11272.887271127513;11350.318980861175;11686.883131168579;9850.950745246228;9861.605535778488;9989.60041598357;10184.643537476153;10314.278000540191;9764.365316254421;9824.5087745611;9871.901280987098;9923.503824808875;10097.293189476666 15:52:20 INFO - 2016-02-03 15:52:20,245 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:52:20 INFO - 2016-02-03 15:52:20,245 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:52:20 INFO - 2016-02-03 15:52:20,245 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,786 15:52:20 INFO - 2016-02-03 15:52:20,245 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:52:20 INFO - 2016-02-03 15:52:20,245 DEBUG : BROWSER_OUTPUT: __startTimestamp1454543540237__endTimestamp 15:52:20 INFO - 2016-02-03 15:52:20,245 DEBUG : BROWSER_OUTPUT: 15:52:20 INFO - 2016-02-03 15:52:20,246 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:52:20 INFO - 2016-02-03 15:52:20,246 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:52:20 INFO - 2016-02-03 15:52:20,246 DEBUG : BROWSER_OUTPUT: 15:52:20 INFO - 2016-02-03 15:52:20,246 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5514.75 Median:5695.17 stddev:607.63 (10.7%) stddev-sans-first:584.14 15:52:20 INFO - 2016-02-03 15:52:20,246 DEBUG : BROWSER_OUTPUT: Values: 3300.7 3350.3 3389.0 3391.4 3407.4 5488.8 5547.1 5548.5 5551.1 5563.4 5534.2 5586.1 5594.2 5599.4 5605.0 4844.7 5039.6 5096.7 5180.9 5183.4 4986.5 5043.2 5048.6 5055.2 5056.6 5027.8 5083.1 5102.3 5103.8 5118.8 5076.9 5159.3 5177.0 5186.4 5208.5 4844.6 4882.1 5094.0 5101.8 5145.4 5222.8 5321.3 5323.0 5336.1 5337.1 5913.3 5936.3 5941.2 5974.8 5975.7 5767.2 5849.3 5873.1 5996.3 6011.4 5608.5 5632.5 5633.5 5634.4 5662.9 6108.1 6111.0 6111.5 6116.4 6119.2 5623.5 5688.1 5714.5 5854.4 5924.6 5946.5 6045.5 6045.8 6048.5 6055.7 5985.5 5999.3 6022.7 6028.5 6044.2 5704.7 5778.4 5931.1 6038.1 6065.1 4537.4 4540.6 4542.8 4543.6 4570.8 3993.0 4078.5 4098.9 4103.3 4122.2 5483.3 5506.1 5564.2 5589.1 5590.1 5892.5 5912.3 5923.6 5929.7 5930.1 5384.5 5422.7 5596.7 5607.5 5613.3 5067.2 5119.6 5139.4 5140.3 5172.7 6112.1 6164.8 6203.8 6204.5 6205.8 5695.2 5802.4 5802.8 5978.1 5986.5 6101.8 6141.5 6141.8 6147.4 6158.7 5850.8 5889.4 5901.7 5903.9 5930.0 5742.4 5862.3 5949.1 5973.3 6081.9 5823.6 5827.4 5831.3 5840.5 5856.5 5763.3 5811.0 5821.3 5822.9 5835.7 5475.2 5525.7 5607.0 5686.5 5708.3 5806.0 5811.9 5813.2 5829.8 5830.3 5664.9 5727.3 5727.6 5734.6 5738.2 15:52:20 INFO - 2016-02-03 15:52:20,246 DEBUG : BROWSER_OUTPUT: 15:52:20 INFO - 2016-02-03 15:52:20,246 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47999.71 Median:182718.76 stddev:78667.98 (43.1%) stddev-sans-first:78808.10 15:52:20 INFO - 2016-02-03 15:52:20,248 DEBUG : BROWSER_OUTPUT: Values: 582.8 615.8 619.7 621.6 632.8 31981.5 39569.4 39818.8 39964.6 40051.0 45224.8 45964.5 46018.0 46125.5 46186.5 7977.0 8102.3 8102.5 8949.6 9125.3 10541.5 10710.4 10810.3 10815.4 10830.4 10521.4 10624.1 10635.6 10640.6 10646.4 10496.3 10583.0 10600.2 10605.0 10607.3 10310.9 10416.7 10439.5 10444.3 10447.6 42616.8 42696.8 42952.8 43035.0 43037.4 3901.6 3994.7 4221.9 4365.3 4379.4 32226.8 32266.0 32441.5 32597.7 33442.3 4285.8 4320.5 4341.4 4357.6 4386.7 292073.0 292187.0 293740.0 295375.0 295532.5 61287.4 61488.7 61565.0 61565.0 61635.4 66251.0 66252.3 66254.0 66458.7 66492.7 16548.5 16906.7 16910.9 17061.1 17106.1 12872.5 12907.1 12978.4 12991.6 13000.7 19844.7 20195.4 20233.2 20277.1 20278.0 8198.9 8380.1 8443.3 8510.1 8566.8 1043.3 1090.1 1148.0 1156.8 1215.2 29473.0 30414.2 30484.7 30917.8 31095.4 1061.5 1155.9 1168.3 1234.4 1273.3 13333.1 14366.6 14468.9 14486.1 15335.8 266755.0 269771.0 270101.0 271172.0 272068.0 49504.0 50926.7 51398.7 51661.0 51720.7 1342.1 1452.7 1470.9 1484.5 1486.7 27342.3 28534.4 28947.0 29744.0 29984.6 44488.1 44820.1 44862.9 46008.3 47264.0 332774.0 335748.0 336000.0 339102.0 341336.0 31879.5 32289.7 32294.8 32359.7 32376.7 43066.0 43232.6 43598.0 44397.8 44404.3 36298.0 36451.0 37451.6 37451.6 37646.8 36781.6 37355.6 37473.8 37791.8 37844.1 36750.3 36937.6 36972.4 37093.8 37300.4 32663.5 33487.2 33635.7 34045.8 34356.1 25917.5 26026.7 26120.9 26202.0 26601.6 15:52:20 INFO - 2016-02-03 15:52:20,248 DEBUG : BROWSER_OUTPUT: 15:52:20 INFO - 2016-02-03 15:52:20,248 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31631.47 Median:1959.01 stddev:100171.89 (5113.4%) stddev-sans-first:100425.42 15:52:20 INFO - 2016-02-03 15:52:20,248 DEBUG : BROWSER_OUTPUT: Values: 385.9 389.1 391.6 391.9 392.1 14481.3 17707.4 17859.0 19421.3 19422.6 12066.2 12313.3 12336.6 17599.0 17948.5 5065.1 5170.4 5178.4 5187.8 5192.9 4094.3 4197.5 5236.6 5694.9 5863.7 5762.4 5767.7 5802.4 5818.2 5837.2 6015.1 6323.2 6323.5 6325.1 6326.8 5520.3 5656.5 5661.7 5677.8 5678.6 21400.0 21448.9 21457.7 22116.4 22359.1 2345.0 2417.7 2430.3 2519.6 2534.9 10452.1 10482.5 10497.3 10603.3 10674.9 1886.7 1912.2 1944.8 1954.4 1963.6 66333.7 69267.7 69987.0 71188.3 71305.3 10857.0 10929.5 10956.9 10983.3 11019.2 14601.9 14617.5 14640.4 14676.5 14846.9 8026.1 8049.1 8073.9 8119.1 8136.4 7330.0 7335.9 7387.3 7412.9 7487.2 4833.1 4856.2 4868.1 4875.3 4891.5 1772.1 1834.4 1893.4 1935.2 1940.0 913.9 968.2 1018.8 1053.4 1060.0 14184.0 16737.7 17171.5 17441.4 17563.0 985.5 993.2 1013.1 1047.7 1088.0 7700.3 10072.5 10162.8 10167.8 10171.2 580331.0 606839.0 608574.0 625792.0 640475.0 83717.0 84676.6 84740.6 86040.6 88172.6 1189.7 1200.1 1202.6 1203.7 1206.7 15964.8 16010.2 16021.2 16196.6 16342.8 36524.0 37659.4 37678.4 37758.4 38144.2 49643.8 49941.8 50355.2 50886.5 52306.7 10014.8 10580.7 10632.5 10635.4 10636.8 17098.7 17864.9 17988.9 18293.8 18313.8 13796.4 13805.6 13932.6 14062.2 14087.8 13761.8 14900.9 15111.4 15434.8 15832.8 11179.0 13373.5 13822.3 13875.3 14375.4 9838.8 9890.7 9945.2 10100.1 10112.8 10068.4 10164.0 11630.7 13356.3 13683.3 15:52:20 INFO - 2016-02-03 15:52:20,248 DEBUG : BROWSER_OUTPUT: 15:52:20 INFO - 2016-02-03 15:52:20,248 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5540.69 Median:6765.18 stddev:2784.66 (41.2%) stddev-sans-first:2776.39 15:52:20 INFO - 2016-02-03 15:52:20,248 DEBUG : BROWSER_OUTPUT: Values: 1559.0 1560.9 1766.7 1788.8 1818.9 7686.4 7778.0 7793.2 7795.7 7812.4 6739.3 6895.3 6896.5 7538.7 7844.7 2352.3 2368.8 2385.5 2394.6 2396.7 2394.4 2412.1 2445.5 2447.2 2447.5 2069.0 2108.7 2324.0 2360.3 2363.6 2306.8 2331.7 2348.1 2372.8 2374.8 2406.2 2413.7 2425.2 2429.4 2430.7 7806.3 7852.0 7862.4 7868.6 7879.0 4727.6 4820.5 4835.1 4835.3 4835.3 3273.9 3276.5 3328.8 3391.7 3406.1 1042.2 2062.6 2106.2 2123.5 2145.8 10794.6 10910.2 10925.1 10939.5 10940.3 4241.4 4283.7 4426.2 4433.4 4447.3 8725.0 8751.6 8753.1 8765.6 8769.7 4766.4 4785.2 4803.2 4811.6 4813.3 4306.1 4354.0 4355.1 4357.8 4364.2 3636.3 3656.7 3681.2 3681.8 3708.0 1082.6 1092.4 1138.7 1151.2 1155.7 1208.3 1210.5 1242.7 1394.7 1456.3 7446.2 7449.3 7525.3 7538.4 7545.6 680.7 685.3 685.6 689.1 832.8 5896.2 6002.6 6004.2 6006.2 6013.9 9101.8 9173.4 9411.3 9503.7 9534.3 9339.6 9341.2 9342.9 9437.6 9449.2 7382.6 7424.2 7444.9 7511.2 7514.5 7283.7 7306.5 7308.4 7316.2 7325.7 8238.3 8292.1 8570.9 8580.1 8593.4 8497.0 8538.9 8574.9 8579.4 8692.0 6681.1 6927.7 6930.9 6947.4 6957.2 7486.5 7532.8 7539.1 7540.2 7548.9 6525.7 6929.8 7115.3 7141.6 7251.1 6609.8 6685.2 7072.6 7143.6 7181.7 7107.5 7118.3 7118.8 7131.4 7152.3 6769.5 6789.6 6811.5 6821.5 6860.8 6760.9 6830.4 6831.9 6835.0 6841.8 15:52:20 INFO - 2016-02-03 15:52:20,248 DEBUG : BROWSER_OUTPUT: 15:52:20 INFO - 2016-02-03 15:52:20,248 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5491.60 Median:6270.81 stddev:1669.45 (26.6%) stddev-sans-first:1629.18 15:52:20 INFO - 2016-02-03 15:52:20,249 DEBUG : BROWSER_OUTPUT: Values: 364.8 368.1 368.5 371.5 372.7 6062.4 6063.1 6094.1 6110.2 6142.6 5918.5 5950.2 6005.0 6053.0 6114.8 4758.1 4762.3 4773.7 4778.7 4799.1 4576.7 4782.4 4788.9 4791.9 4797.4 4615.2 4657.2 4695.7 4705.4 4709.9 4693.4 4694.4 4717.5 4728.0 4736.7 4162.1 4162.5 4165.9 4166.1 4176.2 5765.8 5829.2 5864.4 5874.6 5880.8 5467.0 5471.6 5515.6 5516.4 5526.7 6511.8 6515.1 6516.7 6518.5 6520.6 4615.8 4620.7 4622.7 4624.7 4640.5 6563.1 6791.6 6810.5 6814.9 6818.9 4441.7 4443.4 4446.0 4450.2 4466.7 4484.6 4488.2 4490.4 4493.2 4499.7 5272.9 5291.6 5294.0 5295.5 5302.4 6361.8 6445.4 6525.6 6530.7 6593.6 1641.9 1648.3 1652.0 1652.4 1658.7 1085.3 1110.9 1115.8 1132.7 1133.3 6381.9 6383.4 6396.5 6396.5 6405.2 6563.5 6789.5 6791.5 6791.6 6795.2 6264.3 6326.9 6451.9 6464.8 6468.3 3652.9 3696.7 3700.9 3700.9 3702.6 6915.4 7050.1 7064.3 7075.6 7087.0 6950.2 7010.2 7023.4 7024.5 7028.3 7102.5 7102.7 7106.5 7112.7 7114.1 6705.1 6813.9 6820.1 6822.3 6845.7 6764.3 6767.9 6769.9 6771.1 6775.1 7055.8 7085.0 7085.5 7092.2 7122.8 4593.4 4596.3 4616.1 4620.5 4717.5 6819.5 6824.1 6830.4 6831.5 6833.7 6655.2 6663.3 6670.1 6673.6 6674.3 6505.9 6639.8 6647.1 6647.2 6647.5 6496.8 6527.3 6534.6 6536.3 6537.5 6661.8 6668.4 6669.1 6669.2 6674.7 6277.3 6383.6 6498.6 6514.5 6519.4 15:52:20 INFO - 2016-02-03 15:52:20,250 DEBUG : BROWSER_OUTPUT: 15:52:20 INFO - 2016-02-03 15:52:20,250 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14575.32 Median:49283.01 stddev:16607.42 (33.7%) stddev-sans-first:16621.83 15:52:20 INFO - 2016-02-03 15:52:20,250 DEBUG : BROWSER_OUTPUT: Values: 810.6 838.1 875.0 907.2 960.8 15147.8 15402.5 15413.8 15440.1 15444.5 13911.9 14773.1 14779.1 14788.3 14810.6 757.3 761.9 763.4 915.8 928.9 765.4 898.5 921.4 921.8 924.5 953.6 955.6 960.7 961.5 961.9 955.6 956.7 956.9 957.1 957.6 710.2 712.1 712.3 713.8 718.9 12757.2 12769.5 12791.3 12858.6 12874.8 13148.5 13339.9 13367.1 13922.0 13931.2 10608.3 11083.8 11151.7 11314.2 11398.0 4069.8 4103.9 4105.2 4167.0 4180.7 48606.5 49133.8 49401.8 49912.3 50453.0 11099.7 11161.6 11217.6 11291.7 11458.0 20291.9 20385.8 20432.7 20444.5 20467.5 8450.9 8668.3 8733.6 8780.3 8848.2 4954.9 4978.8 4987.5 5018.5 5028.6 3340.6 3358.7 3363.4 3379.6 3382.4 543.5 572.6 572.7 602.7 602.8 727.5 758.8 763.9 765.7 780.2 8522.9 8917.2 9006.6 9030.6 9080.3 654.4 722.6 773.9 796.6 797.1 4212.0 4354.2 4377.1 4388.4 4427.6 57235.4 57383.7 59042.7 59456.7 59482.0 51734.2 52896.0 52979.0 54518.2 54706.0 49164.3 49780.0 49841.3 50068.0 50140.0 8930.1 9073.3 9126.7 9174.6 9286.4 36833.8 37242.3 37656.6 39043.2 39173.8 45611.0 46864.3 47111.3 47367.3 47599.8 11801.1 11957.9 12219.8 12225.3 12445.4 12361.2 12514.4 12627.0 12798.5 13214.2 11267.8 11296.3 11336.5 11345.6 11595.9 10821.1 11185.0 11240.9 11244.9 11470.4 11137.4 11201.8 11272.9 11350.3 11686.9 9851.0 9861.6 9989.6 10184.6 10314.3 9764.4 9824.5 9871.9 9923.5 10097.3 15:52:20 INFO - 2016-02-03 15:52:20,250 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:52:20 INFO - 2016-02-03 15:52:20,250 DEBUG : BROWSER_OUTPUT: 15:52:20 INFO - 2016-02-03 15:52:20,794 INFO : Browser exited with error code: 0 15:52:20 INFO - 2016-02-03 15:52:20,812 INFO : Completed test dromaeo_css (00:18:30) 15:52:20 INFO - 2016-02-03 15:52:20,812 INFO : Starting test kraken 15:52:20 INFO - 2016-02-03 15:52:20,812 DEBUG : operating with platform_type : linux_ 15:52:20 INFO - 2016-02-03 15:52:20,812 INFO : Initialising browser for kraken test... 15:52:20 INFO - 2016-02-03 15:52:20,818 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp60IZ7r/profile http://localhost:39369/getInfo.html 15:52:24 INFO - 2016-02-03 15:52:24,681 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:52:24 INFO - 2016-02-03 15:52:24,681 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:52:24 INFO - 2016-02-03 15:52:24,681 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:52:24 INFO - 2016-02-03 15:52:24,681 DEBUG : BROWSER_OUTPUT: __metrics 15:52:24 INFO - 2016-02-03 15:52:24,826 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:52:25 INFO - 2016-02-03 15:52:25,887 INFO : Browser initialized. 15:52:25 INFO - 2016-02-03 15:52:25,887 INFO : Running cycle 1/1 for kraken test... 15:52:25 INFO - 2016-02-03 15:52:25,888 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp60IZ7r/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:52:37 INFO - 2016-02-03 15:52:37,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 134524928 15:52:37 INFO - 2016-02-03 15:52:37,670 DEBUG : BROWSER_OUTPUT: 15:52:40 INFO - 2016-02-03 15:52:40,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39369/tests/kraken/driver.html?testName=audio-beat-detection) 15:52:40 INFO - 2016-02-03 15:52:40,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 166248448 15:52:40 INFO - 2016-02-03 15:52:40,701 DEBUG : BROWSER_OUTPUT: 15:52:43 INFO - 2016-02-03 15:52:43,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39369/tests/kraken/driver.html?testName=audio-dft) 15:52:43 INFO - 2016-02-03 15:52:43,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 164319232 15:52:43 INFO - 2016-02-03 15:52:43,833 DEBUG : BROWSER_OUTPUT: 15:52:46 INFO - 2016-02-03 15:52:46,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39369/tests/kraken/driver.html?testName=audio-fft) 15:52:47 INFO - 2016-02-03 15:52:47,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 161243136 15:52:47 INFO - 2016-02-03 15:52:47,176 DEBUG : BROWSER_OUTPUT: 15:52:49 INFO - 2016-02-03 15:52:49,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39369/tests/kraken/driver.html?testName=audio-oscillator) 15:52:49 INFO - 2016-02-03 15:52:49,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 160157696 15:52:49 INFO - 2016-02-03 15:52:49,707 DEBUG : BROWSER_OUTPUT: 15:52:51 INFO - 2016-02-03 15:52:51,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:52:52 INFO - 2016-02-03 15:52:52,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 158679040 15:52:52 INFO - 2016-02-03 15:52:52,438 DEBUG : BROWSER_OUTPUT: 15:52:55 INFO - 2016-02-03 15:52:55,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39369/tests/kraken/driver.html?testName=imaging-darkroom) 15:52:55 INFO - 2016-02-03 15:52:55,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 160063488 15:52:55 INFO - 2016-02-03 15:52:55,878 DEBUG : BROWSER_OUTPUT: 15:52:59 INFO - 2016-02-03 15:52:59,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39369/tests/kraken/driver.html?testName=imaging-desaturate) 15:52:59 INFO - 2016-02-03 15:52:59,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 159264768 15:52:59 INFO - 2016-02-03 15:52:59,755 DEBUG : BROWSER_OUTPUT: 15:53:02 INFO - 2016-02-03 15:53:02,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39369/tests/kraken/driver.html?testName=json-parse-financial) 15:53:03 INFO - 2016-02-03 15:53:03,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 161710080 15:53:03 INFO - 2016-02-03 15:53:03,032 DEBUG : BROWSER_OUTPUT: 15:53:04 INFO - 2016-02-03 15:53:04,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:53:05 INFO - 2016-02-03 15:53:05,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 168476672 15:53:05 INFO - 2016-02-03 15:53:05,151 DEBUG : BROWSER_OUTPUT: 15:53:06 INFO - 2016-02-03 15:53:06,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39369/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:53:07 INFO - 2016-02-03 15:53:07,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 166543360 15:53:07 INFO - 2016-02-03 15:53:07,473 DEBUG : BROWSER_OUTPUT: 15:53:09 INFO - 2016-02-03 15:53:09,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:53:10 INFO - 2016-02-03 15:53:10,073 DEBUG : BROWSER_OUTPUT: RSS: Main: 171540480 15:53:10 INFO - 2016-02-03 15:53:10,073 DEBUG : BROWSER_OUTPUT: 15:53:12 INFO - 2016-02-03 15:53:12,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:53:12 INFO - 2016-02-03 15:53:12,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 178130944 15:53:12 INFO - 2016-02-03 15:53:12,986 DEBUG : BROWSER_OUTPUT: 15:53:15 INFO - 2016-02-03 15:53:15,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:53:16 INFO - 2016-02-03 15:53:16,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 175644672 15:53:16 INFO - 2016-02-03 15:53:16,026 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39369/tests/kraken/driver.html?testName=ai-astar) 15:53:17 INFO - 2016-02-03 15:53:17,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 236171264 15:53:17 INFO - 2016-02-03 15:53:17,898 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,901 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;103;109;109;109;100;108;111;110 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;123;153;161;122;150;148;122;162;130 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;161;160;160;160;160;161;161;160 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;73;156;71;70;71;72;164;70 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;144;91;92;93;147;92;93;136 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;109;108;109;109;109;109 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;147;146;145;145;146;145;146;146 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;95;96;95;95;96;95 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;56;58;56;56;57;57;58;59;54 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;65;63;64;64;64;64;64;64;63 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;81;90;81;82;81;88;82;82 15:53:17 INFO - 2016-02-03 15:53:17,902 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;111;111;115;117;125;115;112;119;113;119 15:53:17 INFO - 2016-02-03 15:53:17,903 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;145;144;142;142;134;142;144;141;133 15:53:17 INFO - 2016-02-03 15:53:17,903 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;62;63;63;63;63;65;62;65;64 15:53:17 INFO - 2016-02-03 15:53:17,903 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:53:17 INFO - 2016-02-03 15:53:17,903 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:53:17 INFO - 2016-02-03 15:53:17,903 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,877 15:53:17 INFO - 2016-02-03 15:53:17,903 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:53:17 INFO - 2016-02-03 15:53:17,903 DEBUG : BROWSER_OUTPUT: __startTimestamp1454543597900__endTimestamp 15:53:17 INFO - 2016-02-03 15:53:17,903 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,904 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:53:17 INFO - 2016-02-03 15:53:17,904 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:53:17 INFO - 2016-02-03 15:53:17,904 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,904 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.90 Median:109.00 stddev:3.57 (3.3%) stddev-sans-first:3.77 15:53:17 INFO - 2016-02-03 15:53:17,905 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 103.0 109.0 109.0 109.0 100.0 108.0 111.0 110.0 15:53:17 INFO - 2016-02-03 15:53:17,905 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,905 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.90 Median:149.00 stddev:16.07 (10.8%) stddev-sans-first:16.89 15:53:17 INFO - 2016-02-03 15:53:17,905 DEBUG : BROWSER_OUTPUT: Values: 148.0 123.0 153.0 161.0 122.0 150.0 148.0 122.0 162.0 130.0 15:53:17 INFO - 2016-02-03 15:53:17,905 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,905 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 15:53:17 INFO - 2016-02-03 15:53:17,905 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 161.0 160.0 160.0 160.0 160.0 161.0 161.0 160.0 15:53:17 INFO - 2016-02-03 15:53:17,905 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,905 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.90 Median:71.00 stddev:37.53 (52.9%) stddev-sans-first:39.24 15:53:17 INFO - 2016-02-03 15:53:17,906 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 73.0 156.0 71.0 70.0 71.0 72.0 164.0 70.0 15:53:17 INFO - 2016-02-03 15:53:17,906 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,906 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:92.00 stddev:24.33 (26.4%) stddev-sans-first:25.17 15:53:17 INFO - 2016-02-03 15:53:17,907 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 144.0 91.0 92.0 93.0 147.0 92.0 93.0 136.0 15:53:17 INFO - 2016-02-03 15:53:17,907 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,907 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:53:17 INFO - 2016-02-03 15:53:17,908 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 109.0 108.0 109.0 109.0 109.0 109.0 15:53:17 INFO - 2016-02-03 15:53:17,908 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,908 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 15:53:17 INFO - 2016-02-03 15:53:17,908 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 147.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 15:53:17 INFO - 2016-02-03 15:53:17,908 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,909 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:53:17 INFO - 2016-02-03 15:53:17,909 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 15:53:17 INFO - 2016-02-03 15:53:17,909 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,909 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.51 (2.6%) stddev-sans-first:1.48 15:53:17 INFO - 2016-02-03 15:53:17,910 DEBUG : BROWSER_OUTPUT: Values: 55.0 56.0 58.0 56.0 56.0 57.0 57.0 58.0 59.0 54.0 15:53:17 INFO - 2016-02-03 15:53:17,910 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,910 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 15:53:17 INFO - 2016-02-03 15:53:17,910 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 63.0 64.0 64.0 64.0 64.0 64.0 64.0 63.0 15:53:17 INFO - 2016-02-03 15:53:17,910 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,911 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.00 stddev:3.18 (3.9%) stddev-sans-first:3.35 15:53:17 INFO - 2016-02-03 15:53:17,911 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 81.0 90.0 81.0 82.0 81.0 88.0 82.0 82.0 15:53:17 INFO - 2016-02-03 15:53:17,911 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,911 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:116.00 stddev:4.42 (3.8%) stddev-sans-first:4.35 15:53:17 INFO - 2016-02-03 15:53:17,912 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 115.0 117.0 125.0 115.0 112.0 119.0 113.0 119.0 15:53:17 INFO - 2016-02-03 15:53:17,912 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,912 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.20 Median:143.00 stddev:4.29 (3.0%) stddev-sans-first:4.32 15:53:17 INFO - 2016-02-03 15:53:17,912 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 144.0 142.0 142.0 134.0 142.0 144.0 141.0 133.0 15:53:17 INFO - 2016-02-03 15:53:17,912 DEBUG : BROWSER_OUTPUT: 15:53:17 INFO - 2016-02-03 15:53:17,913 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:1.06 (1.7%) stddev-sans-first:1.12 15:53:17 INFO - 2016-02-03 15:53:17,913 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 63.0 63.0 63.0 63.0 65.0 62.0 65.0 64.0 15:53:17 INFO - 2016-02-03 15:53:17,913 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:53:17 INFO - 2016-02-03 15:53:17,913 DEBUG : BROWSER_OUTPUT: 15:53:18 INFO - 2016-02-03 15:53:18,626 INFO : Browser exited with error code: 0 15:53:18 INFO - 2016-02-03 15:53:18,673 INFO : Completed test kraken (00:00:57) 15:53:18 INFO - 2016-02-03 15:53:18,673 INFO : Starting test v8_7 15:53:18 INFO - 2016-02-03 15:53:18,674 DEBUG : operating with platform_type : linux_ 15:53:18 INFO - 2016-02-03 15:53:18,674 INFO : Initialising browser for v8_7 test... 15:53:18 INFO - 2016-02-03 15:53:18,680 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQdT7iZ/profile http://localhost:39369/getInfo.html 15:53:22 INFO - 2016-02-03 15:53:22,489 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:53:22 INFO - 2016-02-03 15:53:22,489 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:53:22 INFO - 2016-02-03 15:53:22,490 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:53:22 INFO - 2016-02-03 15:53:22,490 DEBUG : BROWSER_OUTPUT: __metrics 15:53:22 INFO - 2016-02-03 15:53:22,675 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:53:23 INFO - 2016-02-03 15:53:23,651 INFO : Browser initialized. 15:53:23 INFO - 2016-02-03 15:53:23,651 INFO : Running cycle 1/1 for v8_7 test... 15:53:23 INFO - 2016-02-03 15:53:23,652 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQdT7iZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:53:35 INFO - 2016-02-03 15:53:35,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 133914624 15:53:35 INFO - 2016-02-03 15:53:35,438 DEBUG : BROWSER_OUTPUT: 15:53:56 INFO - 2016-02-03 15:53:56,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39369/tests/v8_7/run.html (next: http://localhost:39369/tests/v8_7/run.html) 15:53:57 INFO - 2016-02-03 15:53:57,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 422031360 15:53:57 INFO - 2016-02-03 15:53:57,002 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2016-02-03 15:53:57,003 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:53:57 INFO - 2016-02-03 15:53:57,003 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:53:57 INFO - 2016-02-03 15:53:57,003 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:53:57 INFO - 2016-02-03 15:53:57,003 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:53:57 INFO - 2016-02-03 15:53:57,003 DEBUG : BROWSER_OUTPUT: |0;Richards;171.96904557179707 15:53:57 INFO - 2016-02-03 15:53:57,004 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.0843776106934 15:53:57 INFO - 2016-02-03 15:53:57,004 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 15:53:57 INFO - 2016-02-03 15:53:57,004 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5154.639175257732 15:53:57 INFO - 2016-02-03 15:53:57,004 DEBUG : BROWSER_OUTPUT: |4;RayTrace;941.6195856873823 15:53:57 INFO - 2016-02-03 15:53:57,004 DEBUG : BROWSER_OUTPUT: |5;Earley;554.6311702717693 15:53:57 INFO - 2016-02-03 15:53:57,004 DEBUG : BROWSER_OUTPUT: |6;Boyer;10806.451612903225 15:53:57 INFO - 2016-02-03 15:53:57,004 DEBUG : BROWSER_OUTPUT: |7;RegExp;24463.414634146342 15:53:57 INFO - 2016-02-03 15:53:57,005 DEBUG : BROWSER_OUTPUT: |8;Splay;524.8560962846677 15:53:57 INFO - 2016-02-03 15:53:57,005 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 15:53:57 INFO - 2016-02-03 15:53:57,005 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:53:57 INFO - 2016-02-03 15:53:57,006 DEBUG : BROWSER_OUTPUT: __startTimestamp1454543637002__endTimestamp 15:53:57 INFO - 2016-02-03 15:53:57,006 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2016-02-03 15:53:57,006 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:53:57 INFO - 2016-02-03 15:53:57,006 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:53:57 INFO - 2016-02-03 15:53:57,007 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2016-02-03 15:53:57,007 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:171.97 Median:171.97 stddev:0.00 (0.0%) 15:53:57 INFO - 2016-02-03 15:53:57,007 DEBUG : BROWSER_OUTPUT: Values: 172.0 15:53:57 INFO - 2016-02-03 15:53:57,007 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2016-02-03 15:53:57,007 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 15:53:57 INFO - 2016-02-03 15:53:57,007 DEBUG : BROWSER_OUTPUT: Values: 167.1 15:53:57 INFO - 2016-02-03 15:53:57,007 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2016-02-03 15:53:57,008 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 15:53:57 INFO - 2016-02-03 15:53:57,008 DEBUG : BROWSER_OUTPUT: Values: 279.2 15:53:57 INFO - 2016-02-03 15:53:57,008 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2016-02-03 15:53:57,008 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 15:53:57 INFO - 2016-02-03 15:53:57,008 DEBUG : BROWSER_OUTPUT: Values: 5154.6 15:53:57 INFO - 2016-02-03 15:53:57,008 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2016-02-03 15:53:57,008 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:941.62 Median:941.62 stddev:0.00 (0.0%) 15:53:57 INFO - 2016-02-03 15:53:57,009 DEBUG : BROWSER_OUTPUT: Values: 941.6 15:53:57 INFO - 2016-02-03 15:53:57,009 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2016-02-03 15:53:57,009 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:554.63 Median:554.63 stddev:0.00 (0.0%) 15:53:57 INFO - 2016-02-03 15:53:57,009 DEBUG : BROWSER_OUTPUT: Values: 554.6 15:53:57 INFO - 2016-02-03 15:53:57,009 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2016-02-03 15:53:57,009 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10806.45 Median:10806.45 stddev:0.00 (0.0%) 15:53:57 INFO - 2016-02-03 15:53:57,009 DEBUG : BROWSER_OUTPUT: Values: 10806.5 15:53:57 INFO - 2016-02-03 15:53:57,009 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2016-02-03 15:53:57,010 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24463.41 Median:24463.41 stddev:0.00 (0.0%) 15:53:57 INFO - 2016-02-03 15:53:57,010 DEBUG : BROWSER_OUTPUT: Values: 24463.4 15:53:57 INFO - 2016-02-03 15:53:57,010 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2016-02-03 15:53:57,010 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:524.86 Median:524.86 stddev:0.00 (0.0%) 15:53:57 INFO - 2016-02-03 15:53:57,010 DEBUG : BROWSER_OUTPUT: Values: 524.9 15:53:57 INFO - 2016-02-03 15:53:57,010 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2016-02-03 15:53:57,010 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 15:53:57 INFO - 2016-02-03 15:53:57,011 DEBUG : BROWSER_OUTPUT: Values: 4830.9 15:53:57 INFO - 2016-02-03 15:53:57,011 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:53:57 INFO - 2016-02-03 15:53:57,011 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2016-02-03 15:53:57,666 INFO : Browser exited with error code: 0 15:53:57 INFO - 2016-02-03 15:53:57,682 INFO : Completed test v8_7 (00:00:39) 15:53:58 INFO - 2016-02-03 15:53:58,062 INFO : Completed test suite (00:20:07) 15:53:58 INFO - 2016-02-03 15:53:58,062 DEBUG : Working with test: dromaeo_css 15:53:58 INFO - 2016-02-03 15:53:58,062 DEBUG : Generating results file: dromaeo_css 15:53:58 INFO - 2016-02-03 15:53:58,063 DEBUG : Working with test: kraken 15:53:58 INFO - 2016-02-03 15:53:58,064 DEBUG : Generating results file: kraken 15:53:58 INFO - 2016-02-03 15:53:58,064 INFO : javascript benchmark 15:53:58 INFO - 2016-02-03 15:53:58,064 DEBUG : Working with test: v8_7 15:53:58 INFO - 2016-02-03 15:53:58,064 DEBUG : Generating results file: v8_7 15:53:58 INFO - 2016-02-03 15:53:58,064 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:53:58 INFO - 2016-02-03 15:53:58,119 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 15:53:58 INFO - 2016-02-03 15:53:58,120 DEBUG : process_Request line: dromaeo_css 7332.57 graph.html#tests=[[72,53,35]] 15:53:58 INFO - 2016-02-03 15:53:58,120 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:53:58 INFO - 2016-02-03 15:53:58,146 DEBUG : process_Request line: kraken 1480.40 graph.html#tests=[[232,53,35]] 15:53:58 INFO - 2016-02-03 15:53:58,146 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:53:58 INFO - 2016-02-03 15:53:58,176 DEBUG : process_Request line: v8_7 23086.20 graph.html#tests=[[230,53,35]] 15:53:58 INFO - 2016-02-03 15:53:58,177 INFO : javascript benchmark 15:53:58 INFO - 2016-02-03 15:53:58,181 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3300.702936735694, 3350.2629421527254, 3388.9661103388958, 3391.4404123319655, 3407.3526030054295, 5488.807891723791, 5547.0570003099465, 5548.528375088117, 5551.056320425528, 5563.443655634434, 5534.169874518814, 5586.050371436855, 5594.24477695511, 5599.41206173351, 5605.047141985862, 4844.709317440947, 5039.59683225342, 5096.694198348093, 5180.948575139228, 5183.3779946406485, 4986.526280003394, 5043.1678773002595, 5048.570871475929, 5055.216441451581, 5056.646034777567, 5027.824026159085, 5083.0596339677095, 5102.260172275037, 5103.795848166069, 5118.820841270556, 5076.8730781730565, 5159.251908473288, 5176.974115129438, 5186.403563590197, 5208.453112423179, 4844.56398924095, 4882.072406242803, 5094.032133894548, 5101.795928162869, 5145.434002259748, 5222.791088356499, 5321.281626980385, 5323.041852466555, 5336.092864213093, 5337.11937530307, 5913.319968203668, 5936.347001829795, 5941.22764040672, 5974.790882319141, 5975.745093530364, 5767.221425107598, 5849.268841394825, 5873.060310350324, 5996.2504686914135, 6011.368806275322, 5608.46719561641, 5632.464915832989, 5633.521150702195, 5634.408387119375, 5662.886742265132, 6108.144859719643, 6111.0, 6111.480524155408, 6116.3577824328695, 6119.173911521976, 5623.493885550321, 5688.146777983336, 5714.457126572969, 5854.385289544622, 5924.555658325643, 5946.494547963472, 6045.516358691382, 6045.758169673164, 6048.516118710492, 6055.7274922628585, 5985.491233245136, 5999.340072592011, 6022.69886505673, 6028.457438830526, 6044.24446944132, 5704.686242256716, 5778.422157784272, 5931.13998470228, 6038.064100064497, 6065.090236464477, 4537.3647689323525, 4540.614047805973, 4542.841000564964, 4543.568361005699, 4570.8171673133365, 3992.9800350998057, 4078.469798926121, 4098.877033688994, 4103.322951712994, 4122.154958233555, 5483.259759932438, 5506.146547285177, 5564.248826408383, 5589.133684278943, 5590.077637189899, 5892.499137573354, 5912.320083190402, 5923.555733320019, 5929.703514824241, 5930.140129681172, 5384.488473595002, 5422.674639521641, 5596.720163991866, 5607.523360514402, 5613.326400831927, 5067.189249720027, 5119.6160287978555, 5139.408967968731, 5140.280360749498, 5172.689638621695, 6112.052631842072, 6164.7842325518395, 6203.844903877349, 6204.534659900525, 6205.844853878599, 5695.174199741097, 5802.390748971297, 5802.767889284381, 5978.103284507359, 5986.461218490357, 6101.7995677850195, 6141.477974372228, 6141.785037523665, 6147.44672979434, 6158.661273629814, 5850.824475265749, 5889.411058894077, 5901.704914754159, 5903.911441328298, 5929.970350148222, 5742.36833948257, 5862.325832529314, 5949.137375080676, 5973.342932277359, 6081.939180608138, 5823.563232757476, 5827.358990510956, 5831.271091113611, 5840.503557197686, 5856.472917437451, 5763.250777399079, 5811.041178205549, 5821.330546987151, 5822.912656310244, 5835.67903765297, 5475.178723191394, 5525.723713814374, 5606.971965140148, 5686.545076393962, 5708.315002199763, 5805.970970145122, 5811.883762324645, 5813.215215945962, 5829.766809327749, 5830.271216097988, 5664.85837854057, 5727.284089488814, 5727.627704199213, 5734.627249228787, 5738.1679656450415], "unit": "ms", "name": "dojo.html", "value": 5476.027764052148}, {"lowerIsBetter": false, "replicates": [582.8426324892279, 615.8152554233732, 619.6994457688023, 621.5928566788754, 632.8481164520515, 31981.52027719586, 39569.40645890314, 39818.800905995464, 39964.60035399645, 40051.0, 45224.77387613057, 45964.540354596444, 46018.0, 46125.538744612546, 46186.53813461864, 7977.0, 8102.270795628392, 8102.513849169069, 8949.642014319435, 9125.315601329894, 10541.525631346607, 10710.357378557272, 10810.29733067352, 10815.35107893525, 10830.40432776197, 10521.368717876952, 10624.09695175911, 10635.627753028646, 10640.62757803477, 10646.361218326925, 10496.317739346956, 10583.047525722644, 10600.151987840954, 10605.045545900868, 10607.3105248159, 10310.896891031069, 10416.739581510446, 10439.478026098664, 10444.321119127308, 10447.634332798316, 42616.78691606553, 42696.78651606722, 42952.78523607362, 43035.0, 43037.35443968343, 3901.609839016104, 3994.7403418777685, 4221.936670949938, 4365.301551751736, 4379.388431635862, 32226.838865805756, 32266.0, 32441.513377299358, 32597.674023259937, 33442.3311533768, 4285.785710714452, 4320.503142138663, 4341.435613370273, 4357.629601483878, 4386.670999675037, 292073.0, 292187.0, 293740.0, 295375.0, 295532.52233738906, 61287.38712612906, 61488.69255653693, 61565.0, 61565.0, 61635.383646163864, 66251.0, 66252.33747662461, 66254.0, 66458.66770666212, 66492.667536662, 16548.503544893672, 16906.74639880403, 16910.915445422695, 17061.061641609584, 17106.05916674595, 12872.549460769016, 12907.096503244871, 12978.415971281314, 12991.610251692464, 13000.67498312531, 19844.702329465068, 20195.394138175878, 20233.17901388882, 20277.087531061137, 20278.0, 8198.918010819934, 8380.120087390736, 8443.324534037261, 8510.063892971768, 8566.78583035429, 1043.2801367056707, 1090.0571006079683, 1147.9655610331704, 1156.8316000839213, 1215.2222577550374, 29473.0, 30414.239644009078, 30484.695153048186, 30917.84541077325, 31095.378092438026, 1061.5117046158698, 1155.9364234967159, 1168.2581560709011, 1234.4259919137464, 1273.2933222061845, 13333.133346332457, 14366.56900292993, 14468.855311446961, 14486.130832150106, 15335.846641533442, 266755.0, 269771.0, 270101.0, 271172.0, 272068.0, 49504.0, 50926.74536627367, 51398.74300628473, 51661.0, 51720.741396292775, 1342.147736187528, 1452.7167202395642, 1470.8823294136657, 1484.5472130999933, 1486.7026594681106, 27342.316442089108, 28534.42931141324, 28947.0, 29744.0, 29984.550231746976, 44488.11023779442, 44820.10359792851, 44862.87842803956, 46008.309875351224, 47264.0, 332774.0, 335748.0, 336000.0, 339102.0, 341336.0, 31879.521807173376, 32289.677103229606, 32294.83852580722, 32359.676403236608, 32376.676233237366, 43066.0, 43232.56767432411, 43598.0, 44397.77801110974, 44404.333934990354, 36298.0, 36451.0, 37451.625483744814, 37451.625483744814, 37646.811765941, 36781.63218367889, 37355.626443735215, 37473.81263093667, 37791.811040944616, 37844.05389865275, 36750.26499469942, 36937.630623694495, 36972.44541331936, 37093.81453092717, 37300.440493393166, 32663.510047348835, 33487.16282092967, 33635.663643364234, 34045.829770850985, 34356.14109647279, 25917.452818484206, 26026.73973260319, 26120.8693956529, 26202.0, 26601.600975984988], "unit": "ms", "name": "ext.html", "value": 19738.083880395883}, {"lowerIsBetter": false, "replicates": [385.8765195137555, 389.1341764573822, 391.5634068014164, 391.9216156768647, 392.1412107484608, 14481.275936203201, 17707.380241691542, 17859.0, 19421.32025379114, 19422.640415170943, 12066.215695979778, 12313.261204327746, 12336.629901102959, 17599.0, 17948.461546153605, 5065.062963351773, 5170.3795544534705, 5178.404483484391, 5187.8443646690475, 5192.92210616841, 4094.263032654121, 4197.496300443951, 5236.581073514109, 5694.943050569504, 5863.677497737623, 5762.366139724627, 5767.740451679684, 5802.448767367115, 5818.1854540364175, 5837.24115864937, 6015.067664511986, 6323.177986861679, 6323.525735569828, 6325.0828629848875, 6326.778562750282, 5520.254765606672, 5656.462636049569, 5661.716914154317, 5677.829665110054, 5678.5741069419955, 21400.0, 21448.89275553628, 21457.67813482799, 22116.447088822908, 22359.10563577455, 2344.976550234493, 2417.697787776528, 2430.3073624017247, 2519.634652975327, 2534.9493010139877, 10452.059314661641, 10482.528286227061, 10497.317674351143, 10603.310784798963, 10674.893251067546, 1886.6886963650982, 1912.225548652798, 1944.7763507196712, 1954.3843689237988, 1963.6367272054572, 66333.66833165851, 69267.65366173137, 69986.95019574762, 71188.28811711869, 71305.2869471309, 10857.0, 10929.508172132273, 10956.945215274032, 10983.340999540053, 11019.173561982883, 14601.85398146005, 14617.488387906586, 14640.414383424544, 14676.486322978644, 14846.925765371105, 8026.077001144827, 8049.074356448966, 8073.878891816627, 8119.066307374609, 8136.389770767216, 7329.963350183215, 7335.926640733524, 7387.261273872569, 7412.925870741331, 7487.213842546563, 4833.10587541306, 4856.198727210041, 4868.075065737498, 4875.317455556225, 4891.461939186686, 1772.114187965188, 1834.385480863899, 1893.4130419569976, 1935.1872213670292, 1939.9515012124527, 913.8857642794651, 968.1577027985697, 1018.8166130096654, 1053.4100903494068, 1059.9682009539727, 14184.0, 16737.665246694996, 17171.484855454357, 17441.389551365643, 17563.0, 985.522021819417, 993.2004736187439, 1013.1185868294631, 1047.701405099543, 1087.9619213327496, 7700.345470634947, 10072.496375181358, 10162.796744065077, 10167.796644067077, 10171.186305095574, 580331.0, 606839.0, 608574.0, 625792.0, 640475.0, 83717.0, 84676.57661711652, 84740.57629711935, 86040.56979715062, 88172.5591372039, 1189.74420499593, 1200.1239095460362, 1202.561065211209, 1203.6750077479032, 1206.6862615719801, 15964.760528592313, 16010.199490025685, 16021.198940053184, 16196.595085122966, 16342.836571634132, 36524.0, 37659.43510847395, 37678.434823478216, 37758.43362349622, 38144.237115258096, 49643.75178124086, 49941.75029124831, 50355.24467133069, 50886.491135088174, 52306.738466307426, 10014.799704005733, 10580.735481612714, 10632.521536531029, 10635.415052172204, 10636.84044739314, 17098.743518847477, 17864.91067544654, 17988.91005544964, 18293.81706182921, 18313.816861831212, 13796.379162937892, 13805.585832425044, 13932.58202253934, 14062.226577537924, 14087.788683169556, 13761.793573096611, 14900.925495372454, 15111.395544178109, 15434.84565154379, 15832.762508562151, 11179.0, 13373.53192638253, 13822.308884555932, 13875.306234688427, 14375.353109110325, 9838.75403114928, 9890.653827116017, 9945.204383649147, 10100.141487973311, 10112.848307275544, 10068.39589624625, 10164.0344167304, 11630.6510804676, 13356.265405402795, 13683.315834208448], "unit": "ms", "name": "jquery.html", "value": 9284.814316168862}, {"lowerIsBetter": false, "replicates": [1559.0256089943784, 1560.8829337799662, 1766.7261574455963, 1788.8121747216542, 1818.908654807116, 7686.4235182361335, 7777.961110194448, 7793.1817159198245, 7795.727149549767, 7812.3750099992, 6739.2923743006895, 6895.344942230493, 6896.517243792937, 7538.698452061924, 7844.686212551491, 2352.3178278299274, 2368.8223383246327, 2385.451346190377, 2394.6048901931163, 2396.724376696685, 2394.3654931443093, 2412.1436889904007, 2445.510897820434, 2447.1801946347996, 2447.5227330670527, 2069.037897377719, 2108.704781330615, 2323.9767602324014, 2360.3037104054347, 2363.5745565798147, 2306.7808558186944, 2331.6852224949585, 2348.0607756897207, 2372.833901626887, 2374.786269235777, 2406.193925035115, 2413.722421921484, 2425.1875621666763, 2429.4047958250167, 2430.7447717989535, 7806.297433231037, 7851.960740196319, 7862.371010319218, 7868.645910934022, 7879.0, 4727.598154156901, 4820.493848145964, 4835.1296766582, 4835.323054772335, 4835.347228124228, 3273.885414010522, 3276.541284220211, 3328.8169150696704, 3391.7286617070577, 3406.0633325835347, 1042.2027149230844, 2062.597793430282, 2106.2312256026594, 2123.522207503315, 2145.839062070351, 10794.5682172713, 10910.181736369805, 10925.07136893365, 10939.45302734868, 10940.288881222696, 4241.448611680462, 4283.721558098714, 4426.203283408953, 4433.401490798701, 4447.266201076851, 8724.956375218084, 8751.606177722018, 8753.080926502753, 8765.561721913879, 8769.736907892773, 4766.380370551806, 4785.234362502053, 4803.159447096744, 4811.591014763784, 4813.253945638362, 4306.1172459645695, 4354.042110735633, 4355.06366131277, 4357.825686972549, 4364.236258654722, 3636.2727454509204, 3656.6526180012856, 3681.1533347330264, 3681.7790932544135, 3707.9814600926825, 1082.5886163257912, 1092.4046394714899, 1138.7210133517342, 1151.1999160583314, 1155.7168493718925, 1208.3293771956473, 1210.5278941212935, 1242.67069226655, 1394.7280280345235, 1456.271864067966, 7446.180920098785, 7449.329560339595, 7525.3227209551405, 7538.3592394645975, 7545.622718864144, 680.7106979533777, 685.2701872505766, 685.6160550091964, 689.1041645860362, 832.8049249327235, 5896.174535565025, 6002.579819412686, 6004.249468816398, 6006.249218847644, 6013.909791353133, 9101.81796364069, 9173.449593024307, 9411.29415293842, 9503.66737164196, 9534.28492863038, 9339.626414943326, 9341.20599749029, 9342.90657093434, 9437.622495100119, 9449.244060475145, 7382.5570465772225, 7424.220456852061, 7444.85110297791, 7511.211322811136, 7514.5491270525035, 7283.672234749343, 7306.525075870051, 7308.378787802883, 7316.195218526064, 7325.670344834602, 8238.340932725248, 8292.12932642088, 8570.871436928326, 8580.0561938188, 8593.398462107592, 8496.957515212385, 8538.871916921127, 8574.871376929226, 8579.399442038997, 8691.95654021726, 6681.131452911285, 6927.68825402848, 6930.930690693029, 6947.444204463732, 6957.234704182637, 7486.513376630502, 7532.7740167795055, 7539.0576177977755, 7540.245975402416, 7548.924510754822, 6525.673716314071, 6929.792106236821, 7115.288471152843, 7141.607211603204, 7251.093613298338, 6609.834754131185, 6685.197776266879, 7072.611006394698, 7143.607101609254, 7181.748638797826, 7107.502474826712, 7118.323759242864, 7118.786436406916, 7131.42948564124, 7152.284771522806, 6769.458443324621, 6789.626570538668, 6811.489138314547, 6821.522493425413, 6860.794176174722, 6760.898586521304, 6830.351116643911, 6831.897521537082, 6835.008923706134, 6841.760538381132], "unit": "ms", "name": "mootools.html", "value": 4600.245723264335}, {"lowerIsBetter": false, "replicates": [364.81212175729496, 368.092651613772, 368.48596208289456, 371.52630396244774, 372.6683251905803, 6062.363451837554, 6063.060225665029, 6094.1468194452755, 6110.205673262481, 6142.631442113477, 5918.52651787857, 5950.196723442334, 6005.039193729004, 6053.0, 6114.785982490614, 4758.095961767271, 4762.333273341735, 4773.665843390964, 4778.713277203362, 4799.112164249616, 4576.679632425731, 4782.354382158416, 4788.856334309959, 4791.880202994918, 4797.40032495938, 4615.169269531483, 4657.184992626294, 4695.741734204617, 4705.411823522059, 4709.882252943687, 4693.436787585511, 4694.389729335182, 4717.504662010474, 4727.976360118195, 4736.668433209677, 4162.1259535497275, 4162.458880345566, 4165.895852603679, 4166.104287578185, 4176.248275310443, 5765.769369225226, 5829.213056237396, 5864.354920958691, 5874.647521148702, 5880.8235752927485, 5466.972665136649, 5471.644343117685, 5515.641483303572, 5516.393196748354, 5526.723663816793, 6511.837204069889, 6515.120458738104, 6516.674166291714, 6518.543701940866, 6520.608763474159, 4615.753746488463, 4620.653450991155, 4622.653301002405, 4624.699394539344, 4640.535946405366, 6563.113979612739, 6791.558548694319, 6810.455163586901, 6814.897776533356, 6818.897716534256, 4441.71128876622, 4443.400140980926, 4446.0, 4450.2434586120435, 4466.709663871838, 4484.596386325181, 4488.192125417456, 4490.371348011281, 4493.168763778712, 4499.68502204849, 5272.868178295574, 5291.550218231493, 5294.047071527085, 5295.4969277918535, 5302.3637163540625, 6361.840953976188, 6445.387688169616, 6525.641089740015, 6530.67346632676, 6593.604383736991, 1641.9014859108254, 1648.2994727240875, 1652.0335603671747, 1652.3720986025473, 1658.6516831465528, 1085.2999815119204, 1110.8722496912958, 1115.8214685650257, 1132.7168207948014, 1133.3313345126414, 6381.872362552723, 6383.425491705769, 6396.488280937514, 6396.488280937514, 6405.167328247298, 6563.50773691975, 6789.524733268722, 6791.4906382021545, 6791.626460544718, 6795.150606174228, 6264.342244064399, 6326.936730632727, 6451.870962580722, 6464.773732919325, 6468.256150542654, 3652.8721494747556, 3696.704263658901, 3700.870469533553, 3700.9444858327147, 3702.61122582125, 6915.446764258847, 7050.118735158106, 7064.293570642997, 7075.646217689095, 7086.964565177141, 6950.165980082423, 7010.193827709879, 7023.403010744144, 7024.5082844200415, 7028.297170282931, 7102.5028248022145, 7102.68037938294, 7106.467014973794, 7112.715491380287, 7114.110736157981, 6705.1283333166375, 6813.8977915330315, 6820.147481564804, 6822.283660215804, 6845.691943862438, 6764.28974957642, 6767.86464270702, 6769.932300677127, 6771.052052712525, 6775.119234499483, 7055.753048643272, 7085.0, 7085.468589855885, 7092.219855815959, 7122.786316410516, 4593.44878614555, 4596.333531637827, 4616.053708989716, 4620.5379462053525, 4717.528247175393, 6819.454443644596, 6824.078749368771, 6830.385265326145, 6831.487638427038, 6833.658317084027, 6655.2013758347375, 6663.26704062543, 6670.132882725215, 6673.632950187786, 6674.26583075871, 6505.8698826024165, 6639.800805975829, 6647.102641143577, 6647.235567909753, 6647.534672573067, 6496.837579060372, 6527.314631963575, 6534.640594767334, 6536.281009089092, 6537.5096867736065, 6661.800145995628, 6668.366505182, 6669.0996715444735, 6669.166354205724, 6674.733010679518, 6277.2781130170615, 6383.648899310582, 6498.642574658439, 6514.51141164424, 6519.4132528072705], "unit": "ms", "name": "prototype.html", "value": 4956.523222922257}, {"lowerIsBetter": false, "replicates": [810.6392655268404, 838.0990435282073, 875.0418291970291, 907.201662536967, 960.812641534901, 15147.772783408243, 15402.460913868017, 15413.845861541382, 15440.07359558426, 15444.536663900088, 13911.930440347784, 14773.11361318319, 14779.113253204789, 14788.334524946376, 14810.629734256621, 757.3486801350834, 761.8590560746279, 763.3702195688579, 915.7802127489388, 928.9163975242227, 765.3571000359697, 898.4564338575166, 921.4102974096584, 921.8110287391069, 924.4776701163854, 953.6328513522309, 955.6034245787989, 960.7213907966682, 961.4952150121208, 961.9470929098896, 955.5986485676033, 956.741679746468, 956.9138777509988, 957.0716405087054, 957.6121670723368, 710.2364957670474, 712.081414974682, 712.3090602115991, 713.7965679781238, 718.9101362329709, 12757.170783899017, 12769.48922043117, 12791.296478693668, 12858.614241572768, 12874.806877896839, 13148.474061037547, 13339.933300333436, 13367.131136476099, 13922.02545821793, 13931.233782141979, 10608.257421980465, 11083.833742493869, 11151.665450036511, 11314.151438642053, 11398.031167350786, 4069.776162311072, 4103.9179216415505, 4105.158442519306, 4167.0, 4180.749155050677, 48606.51393486055, 49133.754331228476, 49401.75299123481, 49912.251316230286, 50453.0, 11099.722506937229, 11161.609343672932, 11217.607383741693, 11291.661250162344, 11458.0, 20291.8985405072, 20385.79614203839, 20432.693509597368, 20444.48888777763, 20467.4883127923, 8450.87323690145, 8668.306535477273, 8733.606987685569, 8780.341474389446, 8848.247898928663, 4954.925676114861, 4978.77595508203, 4987.476314986947, 5018.548330650259, 5028.64799464034, 3340.5824271966003, 3358.6809253120914, 3363.360961417323, 3379.6113446953914, 3382.3573521030926, 543.4864053469433, 572.6106247751569, 572.653544605516, 602.7197353230769, 602.8342205893414, 727.5307426709743, 758.7951253161615, 763.8701420758484, 765.7013764631798, 780.2236774409499, 8522.914770852212, 8917.152870477294, 9006.63973441055, 9030.63877444908, 9080.273578113734, 654.3718030690591, 722.5700708078684, 773.9148693643695, 796.609661265987, 797.079373323812, 4211.978940105279, 4354.216241076573, 4377.124575084996, 4388.407564978751, 4427.608257454598, 57235.42764572301, 57383.713081434325, 59042.70478647665, 59456.70271648614, 59482.0, 51734.22398664023, 52896.0, 52979.0, 54518.182227266625, 54706.0, 49164.262536061986, 49780.0, 49841.25238121431, 50068.0, 50140.0, 8930.106989301017, 9073.274138068806, 9126.726198213799, 9174.633014679604, 9286.442813431217, 36833.81583092068, 37242.25515489621, 37656.623433765315, 39043.219135616564, 39173.804130979166, 45611.0, 46864.297035543816, 47111.293330600754, 47367.28949065698, 47599.762001189774, 11801.114916381133, 11957.880421196025, 12219.816702749287, 12225.327606981702, 12445.37773111359, 12361.196522226386, 12514.436850341574, 12627.0, 12798.488060477477, 13214.207147571176, 11267.830982535432, 11296.322220666787, 11336.546538138711, 11345.602903898323, 11595.884041159481, 10821.134309255083, 11185.0, 11240.943795280971, 11244.943775281072, 11470.426478675867, 11137.387443690675, 11201.831972520582, 11272.887271127513, 11350.318980861175, 11686.883131168579, 9850.950745246228, 9861.605535778488, 9989.60041598357, 10184.643537476153, 10314.278000540191, 9764.365316254421, 9824.5087745611, 9871.901280987098, 9923.503824808875, 10097.293189476666], "unit": "ms", "name": "yui.html", "value": 6792.008478816633}], "name": "dromaeo_css", "value": 7332.574560205066}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 103.0, 109.0, 109.0, 109.0, 100.0, 108.0, 111.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [148.0, 123.0, 153.0, 161.0, 122.0, 150.0, 148.0, 122.0, 162.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.9}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 73.0, 156.0, 71.0, 70.0, 71.0, 72.0, 164.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 144.0, 91.0, 92.0, 93.0, 147.0, 92.0, 93.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 147.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 58.0, 56.0, 56.0, 57.0, 57.0, 58.0, 59.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.8}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 81.0, 90.0, 81.0, 82.0, 81.0, 88.0, 82.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 115.0, 117.0, 125.0, 115.0, 112.0, 119.0, 113.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.7}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 144.0, 142.0, 142.0, 134.0, 142.0, 144.0, 141.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.2}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 65.0, 62.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.3}], "name": "kraken", "value": 1480.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.96904557179707], "unit": "score", "name": "Richards", "value": 205.28113000000002}, {"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "DeltaBlue", "value": 395.71623000000017}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [941.6195856873823], "unit": "score", "name": "RayTrace", "value": 785.8683179999997}, {"lowerIsBetter": false, "replicates": [554.6311702717693], "unit": "score", "name": "Earley", "value": 1201.6327890000002}, {"lowerIsBetter": false, "replicates": [10806.451612903225], "unit": "score", "name": "Boyer", "value": 61.67269552238811}, {"lowerIsBetter": false, "replicates": [24463.414634146342], "unit": "score", "name": "RegExp", "value": 37.23866899302096}, {"lowerIsBetter": false, "replicates": [524.8560962846677], "unit": "score", "name": "Splay", "value": 155.26351046859418}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23086.198365128923}]} 15:53:58 INFO - RETURN: dromaeo_css: 7332.57 15:53:58 INFO - RETURN: kraken: 1480.40 15:53:58 INFO - RETURN: v8_7: 23086.20 15:53:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23086.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1480.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7332.57"}}} 15:53:58 INFO - Return code: 0 15:53:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:53:58 INFO - # TBPL SUCCESS # 15:53:58 INFO - Running post-action listener: _resource_record_post_action 15:53:58 INFO - Running post-run listener: _resource_record_post_run 15:53:59 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510697472; Read time: 132; Write time: 486452 15:53:59 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 248741888; Read time: 0; Write time: 330352 15:53:59 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 4096; Write bytes: 261955584; Read time: 132; Write time: 156100 15:53:59 INFO - Running post-run listener: _upload_blobber_files 15:53:59 INFO - Blob upload gear active. 15:53:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:53:59 INFO - Copying logs to upload dir... 15:53:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.018209 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-02-03 15:53:59.088328) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-03 15:53:59.091783) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009949 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454533467/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-03 15:53:59.143143) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 15:53:59.143464) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1454542038.884054-1352297317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004686 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 15:53:59.192864) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-03 15:53:59.193139) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-03 15:53:59.193420) ========= ========= Total master_lag: 0.44 =========