builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1448376998.99 results: success (0) buildid: 20151124053006 builduid: 9260c4173afb4a0f9598b21aa9610ed1 revision: 2c7500d7c6de994c6263912a0a558b3b9c3308c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:38.993649) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:38.994127) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:38.994461) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008538 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.017688) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.018000) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.031474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.031786) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.081171) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.081496) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.081915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.082287) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 06:56:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-11-24 06:56:40 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157898 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.256677) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.256993) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022244 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.316842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.317270) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2c7500d7c6de994c6263912a0a558b3b9c3308c2 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2c7500d7c6de994c6263912a0a558b3b9c3308c2 --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=d16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 06:56:40,142 truncating revision to first 12 chars 2015-11-24 06:56:40,142 Setting DEBUG logging. 2015-11-24 06:56:40,142 attempt 1/10 2015-11-24 06:56:40,142 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2c7500d7c6de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 06:56:40,403 unpacking tar archive at: fx-team-2c7500d7c6de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549252 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.886393) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.886754) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.898269) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.898677) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 06:56:39.899243) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-24 06:56:39.899604) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=d16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:56:40 INFO - MultiFileLogger online at 20151124 06:56:40 in /builds/slave/test-pgo 06:56:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:56:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:56:40 INFO - {'append_to_log': False, 06:56:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:56:40 INFO - 'blob_upload_branch': 'Fx-Team', 06:56:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:56:40 INFO - 'branch': 'Fx-Team', 06:56:40 INFO - 'buildbot_json_path': 'buildprops.json', 06:56:40 INFO - 'config_files': ('talos/linux_config.py',), 06:56:40 INFO - 'default_actions': ('clobber', 06:56:40 INFO - 'read-buildbot-config', 06:56:40 INFO - 'download-and-extract', 06:56:40 INFO - 'populate-webroot', 06:56:40 INFO - 'create-virtualenv', 06:56:40 INFO - 'install', 06:56:40 INFO - 'run-tests'), 06:56:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:56:40 INFO - 'download_minidump_stackwalk': True, 06:56:40 INFO - 'download_symbols': 'ondemand', 06:56:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:56:40 INFO - 'tooltool.py': '/tools/tooltool.py', 06:56:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:56:40 INFO - '/tools/misc-python/virtualenv.py')}, 06:56:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:56:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:56:40 INFO - 'installer_path': 'installer.exe', 06:56:40 INFO - 'log_level': 'info', 06:56:40 INFO - 'log_name': 'talos', 06:56:40 INFO - 'log_to_console': True, 06:56:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:56:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:56:40 INFO - 'opt_config_files': (), 06:56:40 INFO - 'pip_index': False, 06:56:40 INFO - 'sps_profile': False, 06:56:40 INFO - 'sps_profile_interval': 0, 06:56:40 INFO - 'suite': 'dromaeojs', 06:56:40 INFO - 'system_bits': '64', 06:56:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:56:40 INFO - 'title': 'talos-linux64-ix-034', 06:56:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:56:40 INFO - 'use_talos_json': True, 06:56:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:56:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:56:40 INFO - 'work_dir': 'build'} 06:56:40 INFO - ##### 06:56:40 INFO - ##### Running clobber step. 06:56:40 INFO - ##### 06:56:40 INFO - Running pre-action listener: _resource_record_pre_action 06:56:40 INFO - Running main action method: clobber 06:56:40 INFO - rmtree: /builds/slave/test-pgo/build 06:56:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:56:41 INFO - Running post-action listener: _resource_record_post_action 06:56:41 INFO - ##### 06:56:41 INFO - ##### Running read-buildbot-config step. 06:56:41 INFO - ##### 06:56:41 INFO - Running pre-action listener: _resource_record_pre_action 06:56:41 INFO - Running main action method: read_buildbot_config 06:56:41 INFO - Using buildbot properties: 06:56:41 INFO - { 06:56:41 INFO - "properties": { 06:56:41 INFO - "buildnumber": 512, 06:56:41 INFO - "product": "firefox", 06:56:41 INFO - "script_repo_revision": "production", 06:56:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:56:41 INFO - "repository": "", 06:56:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:56:41 INFO - "buildid": "20151124053006", 06:56:41 INFO - "slavename": "talos-linux64-ix-034", 06:56:41 INFO - "pgo_build": "True", 06:56:41 INFO - "basedir": "/builds/slave/test-pgo", 06:56:41 INFO - "project": "", 06:56:41 INFO - "platform": "ubuntu64_hw", 06:56:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:56:41 INFO - "slavebuilddir": "test", 06:56:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:56:41 INFO - "branch": "fx-team", 06:56:41 INFO - "repo_path": "integration/fx-team", 06:56:41 INFO - "stage_platform": "linux64-pgo", 06:56:41 INFO - "builduid": "9260c4173afb4a0f9598b21aa9610ed1", 06:56:41 INFO - "revision": "2c7500d7c6de994c6263912a0a558b3b9c3308c2" 06:56:41 INFO - }, 06:56:41 INFO - "sourcestamp": { 06:56:41 INFO - "repository": "", 06:56:41 INFO - "hasPatch": false, 06:56:41 INFO - "project": "", 06:56:41 INFO - "branch": "fx-team-linux64-pgo-talos", 06:56:41 INFO - "changes": [ 06:56:41 INFO - { 06:56:41 INFO - "category": null, 06:56:41 INFO - "files": [ 06:56:41 INFO - { 06:56:41 INFO - "url": null, 06:56:41 INFO - "name": "https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:56:41 INFO - } 06:56:41 INFO - ], 06:56:41 INFO - "repository": "", 06:56:41 INFO - "rev": "2c7500d7c6de994c6263912a0a558b3b9c3308c2", 06:56:41 INFO - "who": "sendchange", 06:56:41 INFO - "when": 1448376957, 06:56:41 INFO - "number": 6700302, 06:56:41 INFO - "comments": "", 06:56:41 INFO - "project": "", 06:56:41 INFO - "at": "Tue 24 Nov 2015 06:55:57", 06:56:41 INFO - "branch": "fx-team-linux64-pgo-talos", 06:56:41 INFO - "revlink": "", 06:56:41 INFO - "properties": [ 06:56:41 INFO - [ 06:56:41 INFO - "buildid", 06:56:41 INFO - "20151124053006", 06:56:41 INFO - "Change" 06:56:41 INFO - ], 06:56:41 INFO - [ 06:56:41 INFO - "builduid", 06:56:41 INFO - "9260c4173afb4a0f9598b21aa9610ed1", 06:56:41 INFO - "Change" 06:56:41 INFO - ], 06:56:41 INFO - [ 06:56:41 INFO - "pgo_build", 06:56:41 INFO - "True", 06:56:41 INFO - "Change" 06:56:41 INFO - ] 06:56:41 INFO - ], 06:56:41 INFO - "revision": "2c7500d7c6de994c6263912a0a558b3b9c3308c2" 06:56:41 INFO - } 06:56:41 INFO - ], 06:56:41 INFO - "revision": "2c7500d7c6de994c6263912a0a558b3b9c3308c2" 06:56:41 INFO - } 06:56:41 INFO - } 06:56:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:56:41 INFO - Running post-action listener: _resource_record_post_action 06:56:41 INFO - ##### 06:56:41 INFO - ##### Running download-and-extract step. 06:56:41 INFO - ##### 06:56:41 INFO - Running pre-action listener: _resource_record_pre_action 06:56:41 INFO - Running main action method: download_and_extract 06:56:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:41 INFO - https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:56:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/test_packages.json 06:56:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/test_packages.json 06:56:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:56:44 INFO - Downloaded 1302 bytes. 06:56:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:56:44 INFO - Using the following test package requirements: 06:56:44 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:56:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:56:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:44 INFO - u'jsshell-linux-x86_64.zip'], 06:56:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:56:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:56:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:56:44 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:56:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:56:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:56:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:56:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:44 INFO - https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:56:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:56:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:56:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:56:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:56:46 INFO - Downloaded 22527654 bytes. 06:56:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:56:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:56:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:56:47 INFO - Return code: 0 06:56:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:47 INFO - https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:56:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:56:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:56:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:56:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:56:55 INFO - Downloaded 22527654 bytes. 06:56:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:56:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:56:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:56:56 INFO - Return code: 0 06:56:56 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')]} 06:56:56 INFO - https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:56:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:56:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:56:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:56:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:56:58 INFO - Downloaded 11130997 bytes. 06:56:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 06:56:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:56:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:56:58 INFO - Return code: 0 06:56:58 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')]} 06:56:58 INFO - https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:56:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:56:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:56:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:56:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:57:01 INFO - Downloaded 57569231 bytes. 06:57:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:57:01 INFO - mkdir: /builds/slave/test-pgo/properties 06:57:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:57:01 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:57:01 INFO - Contents: 06:57:01 INFO - build_url:https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:57:01 INFO - Running post-action listener: _resource_record_post_action 06:57:01 INFO - Running post-action listener: set_extra_try_arguments 06:57:01 INFO - ##### 06:57:01 INFO - ##### Running populate-webroot step. 06:57:01 INFO - ##### 06:57:01 INFO - Running pre-action listener: _resource_record_pre_action 06:57:01 INFO - Running main action method: populate_webroot 06:57:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:57:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:57:01 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:57:01 INFO - '../fennec_ids.txt'], 06:57:01 INFO - 'tests': ['tcheck2']}, 06:57:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:57:01 INFO - '--tppagecycles', 06:57:01 INFO - '7'], 06:57:01 INFO - 'tests': ['tsvgm']}}, 06:57:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:57:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:57:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:57:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:57:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:57:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:57:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:01 INFO - 'talos_options': ['--e10s'], 06:57:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:01 INFO - 'tests': ['damp', 'tps']}, 06:57:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:01 INFO - 'talos_options': ['--e10s'], 06:57:01 INFO - 'tests': ['damp', 'tps']}, 06:57:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:57:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:57:01 INFO - 'other': {'tests': ['a11yr', 06:57:01 INFO - 'ts_paint', 06:57:01 INFO - 'tpaint', 06:57:01 INFO - 'sessionrestore', 06:57:01 INFO - 'sessionrestore_no_auto_restore']}, 06:57:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:57:01 INFO - 'tests': ['a11yr', 06:57:01 INFO - 'ts_paint', 06:57:01 INFO - 'tpaint', 06:57:01 INFO - 'sessionrestore', 06:57:01 INFO - 'sessionrestore_no_auto_restore']}, 06:57:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:57:01 INFO - 'tests': ['a11yr', 06:57:01 INFO - 'ts_paint', 06:57:01 INFO - 'tpaint', 06:57:01 INFO - 'sessionrestore', 06:57:01 INFO - 'sessionrestore_no_auto_restore']}, 06:57:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:57:01 INFO - 'tests': ['a11yr', 06:57:01 INFO - 'ts_paint', 06:57:01 INFO - 'tpaint', 06:57:01 INFO - 'sessionrestore', 06:57:01 INFO - 'sessionrestore_no_auto_restore']}, 06:57:01 INFO - 'other_l64': {'tests': ['a11yr', 06:57:01 INFO - 'ts_paint', 06:57:01 INFO - 'tpaint', 06:57:01 INFO - 'sessionrestore', 06:57:01 INFO - 'sessionrestore_no_auto_restore']}, 06:57:01 INFO - 'other_nol64': {'tests': ['a11yr', 06:57:01 INFO - 'ts_paint', 06:57:01 INFO - 'tpaint', 06:57:01 INFO - 'sessionrestore', 06:57:01 INFO - 'sessionrestore_no_auto_restore']}, 06:57:01 INFO - 'svgr': {'tests': ['tsvgx', 06:57:01 INFO - 'tsvgr_opacity', 06:57:01 INFO - 'tart', 06:57:01 INFO - 'tscrollx', 06:57:01 INFO - 'cart']}, 06:57:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:57:01 INFO - 'tests': ['tsvgx', 06:57:01 INFO - 'tsvgr_opacity', 06:57:01 INFO - 'tart', 06:57:01 INFO - 'tscrollx', 06:57:01 INFO - 'cart']}, 06:57:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:01 INFO - 'tests': ['tp5o']}, 06:57:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:01 INFO - 'talos_options': ['--e10s'], 06:57:01 INFO - 'tests': ['tp5o']}, 06:57:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:01 INFO - 'talos_options': ['--xperf_path', 06:57:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:01 INFO - 'tests': ['tp5n']}, 06:57:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:01 INFO - 'talos_options': ['--e10s', 06:57:01 INFO - '--xperf_path', 06:57:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:01 INFO - 'tests': ['tp5n']}}, 06:57:01 INFO - 'talos.zip': {'path': '', 06:57:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:57:01 INFO - Running post-action listener: _resource_record_post_action 06:57:01 INFO - ##### 06:57:01 INFO - ##### Running create-virtualenv step. 06:57:01 INFO - ##### 06:57:01 INFO - Running pre-action listener: _resource_record_pre_action 06:57:01 INFO - Running main action method: create_virtualenv 06:57:01 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:57:01 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 06:57:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:57:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:57:01 INFO - Using real prefix '/usr' 06:57:01 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:57:01 INFO - Installing distribute.............................................................................................................................................................................................done. 06:57:03 INFO - Installing pip.................done. 06:57:03 INFO - Return code: 0 06:57:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:57: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')]} 06:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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')]} 06:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42f0b9fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba4a90>, '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 0x1bf6f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72e0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', '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 06:57:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:57:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:57:03 INFO - Using env: {'DISPLAY': ':0', 06:57:03 INFO - 'HOME': '/home/cltbld', 06:57:03 INFO - 'LANG': 'en_US.UTF-8', 06:57:03 INFO - 'LANGUAGE': 'en_US:en', 06:57:03 INFO - 'LOGNAME': 'cltbld', 06:57:03 INFO - 'MAIL': '/var/mail/cltbld', 06:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:03 INFO - 'MOZ_NO_REMOTE': '1', 06:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:03 INFO - 'NO_EM_RESTART': '1', 06:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:03 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:03 INFO - 'SHELL': '/bin/bash', 06:57:03 INFO - 'SHLVL': '1', 06:57:03 INFO - 'TERM': 'linux', 06:57:03 INFO - 'TMOUT': '86400', 06:57:03 INFO - 'USER': 'cltbld', 06:57:03 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', 06:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:03 INFO - '_': '/tools/buildbot/bin/python'} 06:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:04 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 06:57:04 INFO - Cleaning up... 06:57:04 INFO - Return code: 0 06:57:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:57: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')]} 06:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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')]} 06:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42f0b9fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba4a90>, '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 0x1bf6f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72e0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', '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 06:57:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:57:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:57:04 INFO - Using env: {'DISPLAY': ':0', 06:57:04 INFO - 'HOME': '/home/cltbld', 06:57:04 INFO - 'LANG': 'en_US.UTF-8', 06:57:04 INFO - 'LANGUAGE': 'en_US:en', 06:57:04 INFO - 'LOGNAME': 'cltbld', 06:57:04 INFO - 'MAIL': '/var/mail/cltbld', 06:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:04 INFO - 'MOZ_NO_REMOTE': '1', 06:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:04 INFO - 'NO_EM_RESTART': '1', 06:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:04 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:04 INFO - 'SHELL': '/bin/bash', 06:57:04 INFO - 'SHLVL': '1', 06:57:04 INFO - 'TERM': 'linux', 06:57:04 INFO - 'TMOUT': '86400', 06:57:04 INFO - 'USER': 'cltbld', 06:57:04 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', 06:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:04 INFO - '_': '/tools/buildbot/bin/python'} 06:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:04 INFO - Downloading/unpacking psutil>=0.7.1 06:57:04 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 06:57:04 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 06:57:04 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 06:57:04 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 06:57:04 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 06:57:04 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 06:57:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:57:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:57:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:57:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:06 INFO - Installing collected packages: psutil 06:57:06 INFO - Running setup.py install for psutil 06:57:06 INFO - building 'psutil._psutil_linux' extension 06:57:06 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 06:57:06 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 06:57:06 INFO - building 'psutil._psutil_posix' extension 06:57:06 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 06:57:06 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 06:57:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:06 INFO - Successfully installed psutil 06:57:06 INFO - Cleaning up... 06:57:06 INFO - Return code: 0 06:57:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f42f0b9fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba4a90>, '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 0x1bf6f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72e0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', '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 06:57:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 06:57:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --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 06:57:06 INFO - Using env: {'DISPLAY': ':0', 06:57:06 INFO - 'HOME': '/home/cltbld', 06:57:06 INFO - 'LANG': 'en_US.UTF-8', 06:57:06 INFO - 'LANGUAGE': 'en_US:en', 06:57:06 INFO - 'LOGNAME': 'cltbld', 06:57:06 INFO - 'MAIL': '/var/mail/cltbld', 06:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:06 INFO - 'MOZ_NO_REMOTE': '1', 06:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:06 INFO - 'NO_EM_RESTART': '1', 06:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:06 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:06 INFO - 'SHELL': '/bin/bash', 06:57:06 INFO - 'SHLVL': '1', 06:57:06 INFO - 'TERM': 'linux', 06:57:06 INFO - 'TMOUT': '86400', 06:57:06 INFO - 'USER': 'cltbld', 06:57:06 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', 06:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:06 INFO - '_': '/tools/buildbot/bin/python'} 06:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:57:06 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 06:57:06 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 06:57:06 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 06:57:06 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 06:57:06 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 06:57:06 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 06:57:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:57:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:57:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:57:08 INFO - Installing collected packages: mozsystemmonitor 06:57:08 INFO - Running setup.py install for mozsystemmonitor 06:57:08 INFO - Successfully installed mozsystemmonitor 06:57:08 INFO - Cleaning up... 06:57:08 INFO - Return code: 0 06:57:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42f0b9fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba4a90>, '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 0x1bf6f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72e0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', '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 06:57:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:57:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:57:08 INFO - Using env: {'DISPLAY': ':0', 06:57:08 INFO - 'HOME': '/home/cltbld', 06:57:08 INFO - 'LANG': 'en_US.UTF-8', 06:57:08 INFO - 'LANGUAGE': 'en_US:en', 06:57:08 INFO - 'LOGNAME': 'cltbld', 06:57:08 INFO - 'MAIL': '/var/mail/cltbld', 06:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:08 INFO - 'MOZ_NO_REMOTE': '1', 06:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:08 INFO - 'NO_EM_RESTART': '1', 06:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:08 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:08 INFO - 'SHELL': '/bin/bash', 06:57:08 INFO - 'SHLVL': '1', 06:57:08 INFO - 'TERM': 'linux', 06:57:08 INFO - 'TMOUT': '86400', 06:57:08 INFO - 'USER': 'cltbld', 06:57:08 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', 06:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:08 INFO - '_': '/tools/buildbot/bin/python'} 06:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:08 INFO - Downloading/unpacking blobuploader==1.2.4 06:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:10 INFO - Downloading blobuploader-1.2.4.tar.gz 06:57:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:57:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:57:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:57:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:57:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:11 INFO - Downloading docopt-0.6.1.tar.gz 06:57:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:57:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:57:11 INFO - Installing collected packages: blobuploader, requests, docopt 06:57:11 INFO - Running setup.py install for blobuploader 06:57:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:57:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:57:11 INFO - Running setup.py install for requests 06:57:11 INFO - Running setup.py install for docopt 06:57:11 INFO - Successfully installed blobuploader requests docopt 06:57:11 INFO - Cleaning up... 06:57:11 INFO - Return code: 0 06:57:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42f0b9fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba4a90>, '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 0x1bf6f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72e0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', '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 06:57:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:57:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:57:11 INFO - Using env: {'DISPLAY': ':0', 06:57:11 INFO - 'HOME': '/home/cltbld', 06:57:11 INFO - 'LANG': 'en_US.UTF-8', 06:57:11 INFO - 'LANGUAGE': 'en_US:en', 06:57:11 INFO - 'LOGNAME': 'cltbld', 06:57:11 INFO - 'MAIL': '/var/mail/cltbld', 06:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:11 INFO - 'MOZ_NO_REMOTE': '1', 06:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:11 INFO - 'NO_EM_RESTART': '1', 06:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:11 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:11 INFO - 'SHELL': '/bin/bash', 06:57:11 INFO - 'SHLVL': '1', 06:57:11 INFO - 'TERM': 'linux', 06:57:11 INFO - 'TMOUT': '86400', 06:57:11 INFO - 'USER': 'cltbld', 06:57:11 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', 06:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:11 INFO - '_': '/tools/buildbot/bin/python'} 06:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:57:12 INFO - Running setup.py (path:/tmp/pip-srwMsq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:57:12 INFO - Running setup.py (path:/tmp/pip-JoQ_tj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:57:12 INFO - Running setup.py (path:/tmp/pip-8qSgcP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:57:12 INFO - Running setup.py (path:/tmp/pip-iip_3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:57:12 INFO - Running setup.py (path:/tmp/pip-JvQcol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:57:12 INFO - Running setup.py (path:/tmp/pip-ycqdza-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:57:12 INFO - Running setup.py (path:/tmp/pip-_jLU2e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:57:12 INFO - Running setup.py (path:/tmp/pip-8cttxc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:57:12 INFO - Running setup.py (path:/tmp/pip-gteK68-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:57:12 INFO - Running setup.py (path:/tmp/pip-_nP31i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:57:12 INFO - Running setup.py (path:/tmp/pip-2iLsFz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:57:12 INFO - Running setup.py (path:/tmp/pip-VYBcIY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:57:12 INFO - Running setup.py (path:/tmp/pip-ztNDEE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:57:13 INFO - Running setup.py (path:/tmp/pip-IHzKvn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:57:13 INFO - Running setup.py (path:/tmp/pip-6zs3J0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:57:13 INFO - Running setup.py (path:/tmp/pip-aVCGpI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:57:13 INFO - Running setup.py (path:/tmp/pip-30RLTq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:57:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:57:13 INFO - Running setup.py install for manifestparser 06:57:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:57:13 INFO - Running setup.py install for mozcrash 06:57:13 INFO - Running setup.py install for mozdebug 06:57:13 INFO - Running setup.py install for mozdevice 06:57:13 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:57:13 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:57:13 INFO - Running setup.py install for mozfile 06:57:13 INFO - Running setup.py install for mozhttpd 06:57:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:57:13 INFO - Running setup.py install for mozinfo 06:57:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:57:14 INFO - Running setup.py install for mozInstall 06:57:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:57:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:57:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:57:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:57:14 INFO - Running setup.py install for mozleak 06:57:14 INFO - Running setup.py install for mozlog 06:57:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:57:14 INFO - Running setup.py install for moznetwork 06:57:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:57:14 INFO - Running setup.py install for mozprocess 06:57:14 INFO - Running setup.py install for mozprofile 06:57:14 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:57:14 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:57:14 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:57:14 INFO - Running setup.py install for mozrunner 06:57:14 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:57:14 INFO - Running setup.py install for mozscreenshot 06:57:14 INFO - Running setup.py install for moztest 06:57:14 INFO - Running setup.py install for mozversion 06:57:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:57:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:57:15 INFO - Cleaning up... 06:57:15 INFO - Return code: 0 06:57:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f42f0b9fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba4a90>, '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 0x1bf6f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72e0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', '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 06:57:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 06:57:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 06:57:15 INFO - Using env: {'DISPLAY': ':0', 06:57:15 INFO - 'HOME': '/home/cltbld', 06:57:15 INFO - 'LANG': 'en_US.UTF-8', 06:57:15 INFO - 'LANGUAGE': 'en_US:en', 06:57:15 INFO - 'LOGNAME': 'cltbld', 06:57:15 INFO - 'MAIL': '/var/mail/cltbld', 06:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:15 INFO - 'MOZ_NO_REMOTE': '1', 06:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:15 INFO - 'NO_EM_RESTART': '1', 06:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:15 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:15 INFO - 'SHELL': '/bin/bash', 06:57:15 INFO - 'SHLVL': '1', 06:57:15 INFO - 'TERM': 'linux', 06:57:15 INFO - 'TMOUT': '86400', 06:57:15 INFO - 'USER': 'cltbld', 06:57:15 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', 06:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:15 INFO - '_': '/tools/buildbot/bin/python'} 06:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:57:15 INFO - Running setup.py (path:/tmp/pip-12GU1I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:57:15 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)) 06:57:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:57:15 INFO - Running setup.py (path:/tmp/pip-dXd63v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:57:15 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)) 06:57:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:57:15 INFO - Running setup.py (path:/tmp/pip-3gAzQ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:57:15 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)) 06:57:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:57:15 INFO - Running setup.py (path:/tmp/pip-iLe0aN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:57:15 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)) 06:57:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:57:15 INFO - Running setup.py (path:/tmp/pip-9x7hmd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:57:15 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)) 06:57:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:57:15 INFO - Running setup.py (path:/tmp/pip-nWHzZN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:57:15 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)) 06:57:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:57:15 INFO - Running setup.py (path:/tmp/pip-PqWJGk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:57:15 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)) 06:57:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:57:15 INFO - Running setup.py (path:/tmp/pip-JJwe_Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:57:15 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)) 06:57:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:57:15 INFO - Running setup.py (path:/tmp/pip-5P2xc3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:57:15 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)) 06:57:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:57:15 INFO - Running setup.py (path:/tmp/pip-t4i13C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:57:16 INFO - Running setup.py (path:/tmp/pip-8cwyAP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:57:16 INFO - Running setup.py (path:/tmp/pip-rKBesB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:57:16 INFO - Running setup.py (path:/tmp/pip-BVAwgi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:57:16 INFO - Running setup.py (path:/tmp/pip-DZCm9X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:57:16 INFO - Running setup.py (path:/tmp/pip-XMf4VL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:57:16 INFO - Running setup.py (path:/tmp/pip-I4r9eE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:57:16 INFO - Running setup.py (path:/tmp/pip-DCYZdM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:57:16 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)) 06:57:16 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)) 06:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:57:16 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)) 06:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:57:16 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)) 06:57:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57:18 INFO - Downloading blessings-1.5.1.tar.gz 06:57:18 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 06:57:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:57:18 INFO - Installing collected packages: blessings 06:57:18 INFO - Running setup.py install for blessings 06:57:18 INFO - Successfully installed blessings 06:57:18 INFO - Cleaning up... 06:57:18 INFO - Return code: 0 06:57:18 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:57:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:57:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:57:18 INFO - Reading from file tmpfile_stdout 06:57:18 INFO - Current package versions: 06:57:18 INFO - argparse == 1.2.1 06:57:18 INFO - blessings == 1.5.1 06:57:18 INFO - blobuploader == 1.2.4 06:57:18 INFO - docopt == 0.6.1 06:57:18 INFO - manifestparser == 1.1 06:57:18 INFO - mozInstall == 1.12 06:57:18 INFO - mozcrash == 0.16 06:57:18 INFO - mozdebug == 0.1 06:57:18 INFO - mozdevice == 0.47 06:57:18 INFO - mozfile == 1.2 06:57:18 INFO - mozhttpd == 0.7 06:57:18 INFO - mozinfo == 0.9 06:57:18 INFO - mozleak == 0.1 06:57:18 INFO - mozlog == 3.1 06:57:18 INFO - moznetwork == 0.27 06:57:18 INFO - mozprocess == 0.22 06:57:18 INFO - mozprofile == 0.27 06:57:18 INFO - mozrunner == 6.11 06:57:18 INFO - mozscreenshot == 0.1 06:57:18 INFO - mozsystemmonitor == 0.0 06:57:18 INFO - moztest == 0.7 06:57:18 INFO - mozversion == 1.4 06:57:18 INFO - psutil == 3.1.1 06:57:18 INFO - requests == 1.2.3 06:57:18 INFO - wsgiref == 0.1.2 06:57:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:57: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')]} 06:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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')]} 06:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f42f0b9fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba4a90>, '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 0x1bf6f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72e0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', '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 06:57:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 06:57:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:57:18 INFO - Using env: {'DISPLAY': ':0', 06:57:18 INFO - 'HOME': '/home/cltbld', 06:57:18 INFO - 'LANG': 'en_US.UTF-8', 06:57:18 INFO - 'LANGUAGE': 'en_US:en', 06:57:18 INFO - 'LOGNAME': 'cltbld', 06:57:18 INFO - 'MAIL': '/var/mail/cltbld', 06:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:18 INFO - 'MOZ_NO_REMOTE': '1', 06:57:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:18 INFO - 'NO_EM_RESTART': '1', 06:57:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:18 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:18 INFO - 'SHELL': '/bin/bash', 06:57:18 INFO - 'SHLVL': '1', 06:57:18 INFO - 'TERM': 'linux', 06:57:18 INFO - 'TMOUT': '86400', 06:57:18 INFO - 'USER': 'cltbld', 06:57:18 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', 06:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:18 INFO - '_': '/tools/buildbot/bin/python'} 06:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:19 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)) 06:57:19 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)) 06:57:19 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)) 06:57:19 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)) 06:57:19 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)) 06:57:19 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)) 06:57:19 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)) 06:57:19 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)) 06:57:19 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)) 06:57:19 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)) 06:57:19 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)) 06:57:19 INFO - Cleaning up... 06:57:19 INFO - Return code: 0 06:57:19 INFO - Running post-action listener: _resource_record_post_action 06:57:19 INFO - Running post-action listener: _start_resource_monitoring 06:57:19 INFO - Starting resource monitoring. 06:57:19 INFO - ##### 06:57:19 INFO - ##### Running install step. 06:57:19 INFO - ##### 06:57:19 INFO - Running pre-action listener: _resource_record_pre_action 06:57:19 INFO - Running main action method: install 06:57:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:57:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:57:19 INFO - Reading from file tmpfile_stdout 06:57:19 INFO - Detecting whether we're running mozinstall >=1.0... 06:57:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:57:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:57:19 INFO - Reading from file tmpfile_stdout 06:57:19 INFO - Output received: 06:57:19 INFO - Usage: mozinstall [options] installer 06:57:19 INFO - Options: 06:57:19 INFO - -h, --help show this help message and exit 06:57:19 INFO - -d DEST, --destination=DEST 06:57:19 INFO - Directory to install application into. [default: 06:57:19 INFO - "/builds/slave/test-pgo"] 06:57:19 INFO - --app=APP Application being installed. [default: firefox] 06:57:19 INFO - mkdir: /builds/slave/test-pgo/build/application 06:57:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:57:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:57:33 INFO - Reading from file tmpfile_stdout 06:57:33 INFO - Output received: 06:57:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:57:33 INFO - Running post-action listener: _resource_record_post_action 06:57:33 INFO - ##### 06:57:33 INFO - ##### Running run-tests step. 06:57:33 INFO - ##### 06:57:33 INFO - Running pre-action listener: _resource_record_pre_action 06:57:33 INFO - Running main action method: run_tests 06:57:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:57:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:57:33 INFO - Python 2.7.3 06:57:33 INFO - Return code: 0 06:57:33 INFO - grabbing minidump binary from tooltool 06:57:33 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')]} 06:57:33 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 0x1ba4a90>, '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 0x1bf6f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:57:33 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 06:57:33 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 06:57:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:57:33 INFO - Return code: 0 06:57:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:57:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:57:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:57:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:57:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:57:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:57:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost 06:57:33 INFO - Using env: {'DISPLAY': ':0', 06:57:33 INFO - 'HOME': '/home/cltbld', 06:57:33 INFO - 'LANG': 'en_US.UTF-8', 06:57:33 INFO - 'LANGUAGE': 'en_US:en', 06:57:33 INFO - 'LOGNAME': 'cltbld', 06:57:33 INFO - 'MAIL': '/var/mail/cltbld', 06:57:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:57:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:33 INFO - 'MOZ_NO_REMOTE': '1', 06:57:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:33 INFO - 'NO_EM_RESTART': '1', 06:57:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:33 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:57:33 INFO - 'SHELL': '/bin/bash', 06:57:33 INFO - 'SHLVL': '1', 06:57:33 INFO - 'TERM': 'linux', 06:57:33 INFO - 'TMOUT': '86400', 06:57:33 INFO - 'USER': 'cltbld', 06:57:33 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532', 06:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:33 INFO - '_': '/tools/buildbot/bin/python'} 06:57:33 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] with output_timeout 3600 06:57:34 INFO - mozversion INFO | application_buildid: 20151124053006 06:57:34 INFO - mozversion INFO | application_changeset: 2c7500d7c6de994c6263912a0a558b3b9c3308c2 06:57:34 INFO - mozversion INFO | application_display_name: Nightly 06:57:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:57:34 INFO - mozversion INFO | application_name: Firefox 06:57:34 INFO - mozversion INFO | application_remotingname: firefox 06:57:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:57:34 INFO - mozversion INFO | application_vendor: Mozilla 06:57:34 INFO - mozversion INFO | application_version: 45.0a1 06:57:34 INFO - mozversion INFO | platform_buildid: 20151124053006 06:57:34 INFO - mozversion INFO | platform_changeset: 2c7500d7c6de994c6263912a0a558b3b9c3308c2 06:57:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:57:34 INFO - mozversion INFO | platform_version: 45.0a1 06:57:34 INFO - 2015-11-24 06:57:34,088 DEBUG : using testdate: 1448377054 06:57:34 INFO - 2015-11-24 06:57:34,088 DEBUG : actual date: 1448377054 06:57:34 INFO - 2015-11-24 06:57:34,135 INFO : starting webserver on 'localhost:60147' 06:57:34 INFO - 2015-11-24 06:57:34,136 INFO : Starting test suite talos-linux64-ix-034 06:57:34 INFO - 2015-11-24 06:57:34,136 INFO : Starting test dromaeo_css 06:57:34 INFO - 2015-11-24 06:57:34,136 DEBUG : operating with platform_type : linux_ 06:57:34 INFO - 2015-11-24 06:57:34,137 INFO : Initialising browser for dromaeo_css test... 06:57:34 INFO - 2015-11-24 06:57:34,154 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRF68Wt/profile http://localhost:60147/getInfo.html 06:57:38 INFO - 2015-11-24 06:57:38,661 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:57:38 INFO - 2015-11-24 06:57:38,661 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:57:38 INFO - 2015-11-24 06:57:38,661 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:57:38 INFO - 2015-11-24 06:57:38,661 DEBUG : BROWSER_OUTPUT: __metrics 06:57:38 INFO - 2015-11-24 06:57:38,737 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:57:40 INFO - 2015-11-24 06:57:40,025 INFO : Browser initialized. 06:57:40 INFO - 2015-11-24 06:57:40,026 INFO : Running cycle 1/1 for dromaeo_css test... 06:57:40 INFO - 2015-11-24 06:57:40,026 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRF68Wt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:57:51 INFO - 2015-11-24 06:57:51,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 140173312 06:57:51 INFO - 2015-11-24 06:57:51,826 DEBUG : BROWSER_OUTPUT: 06:58:43 INFO - 2015-11-24 06:58:43,511 DEBUG : BROWSER_OUTPUT: 1448377123510 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] 07:00:52 INFO - 2015-11-24 07:00:52,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60147/tests/dromaeo/cssquery-ext.html) 07:00:53 INFO - 2015-11-24 07:00:53,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 260440064 07:00:53 INFO - 2015-11-24 07:00:53,563 DEBUG : BROWSER_OUTPUT: 07:03:56 INFO - 2015-11-24 07:03:56,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/dromaeo/cssquery-ext.html (next: http://localhost:60147/tests/dromaeo/cssquery-jquery.html) 07:03:56 INFO - 2015-11-24 07:03:56,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 226095104 07:03:56 INFO - 2015-11-24 07:03:56,569 DEBUG : BROWSER_OUTPUT: 07:06:58 INFO - 2015-11-24 07:06:58,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60147/tests/dromaeo/cssquery-mootools.html) 07:06:59 INFO - 2015-11-24 07:06:59,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 227176448 07:06:59 INFO - 2015-11-24 07:06:59,097 DEBUG : BROWSER_OUTPUT: 07:10:00 INFO - 2015-11-24 07:10:00,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60147/tests/dromaeo/cssquery-prototype.html) 07:10:01 INFO - 2015-11-24 07:10:01,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 203939840 07:10:01 INFO - 2015-11-24 07:10:01,527 DEBUG : BROWSER_OUTPUT: 07:13:03 INFO - 2015-11-24 07:13:03,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60147/tests/dromaeo/cssquery-yui.html) 07:13:04 INFO - 2015-11-24 07:13:04,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 209145856 07:13:04 INFO - 2015-11-24 07:13:04,599 DEBUG : BROWSER_OUTPUT: 07:16:07 INFO - 2015-11-24 07:16:07,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/dromaeo/cssquery-yui.html (next: http://localhost:60147/tests/dromaeo/cssquery-dojo.html) 07:16:07 INFO - 2015-11-24 07:16:07,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 249065472 07:16:07 INFO - 2015-11-24 07:16:07,408 DEBUG : BROWSER_OUTPUT: 07:16:07 INFO - 2015-11-24 07:16:07,408 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:16:07 INFO - 2015-11-24 07:16:07,408 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:16:07 INFO - 2015-11-24 07:16:07,408 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:16:07 INFO - 2015-11-24 07:16:07,408 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:16:07 INFO - 2015-11-24 07:16:07,409 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3185.6177258728953;3247.6589958054387;3292.3744488547172;3296.522004309377;3316.7678262521617;5357.062514060043;5467.097928841747;5496;5509.11854103343;5509.146082357236;5446.836594902159;5482.424345443731;5542.667439953606;5553.16702494626;5629;4950.950490495094;5018.924716129261;5029.572486338666;5098.082345177866;5151.0728068947765;4874.7562621868765;5120.487951204887;5130.666506677073;5172.896542069175;5199.844004679866;4947.6784009039475;5008.7996480140755;5021.57316628087;5029.371328583927;5078.746062696869;5033.018561380532;5050.595952323805;5052.69683818972;5054.963732434842;5096.439391666913;5027.597792176617;5027.849164525033;5029.094762942669;5029.245613158019;5053.317802096743;5255.816046438395;5359.651622644555;5361.571074314045;5374.328208973879;5398.973005134949;5858.355580886099;6030.487408570277;6033.42682445167;6047.455728984369;6064.484518815906;6037.818865434044;6070.271567411939;6070.96964515179;6072;6077.878442431171;5433;5528.889422211573;5530.336359636829;5574.721263936787;5733.713314334266;6073.074145102274;6074.086662701235;6075.866057717283;6086.847828804227;6092.482139018233;5769.884602308014;5875.941240587625;5888.793892213752;5893.469587737124;5898.14476900847;5888.735006924699;5985.281766188085;5986.940130598726;5993;5994.0409534474275;5913.615614985012;5916.437938395846;5916.437938395846;5919.112133179971;5959.374265702038;6005.3394126646035;6038.849028774316;6046.425589568984;6048;6048.304444988883;4497.797599108048;4535.750533720611;4579.358889755437;4633.096546173464;4636.582707556337;4046.008727861693;4052.8378864845076;4089.1003979124544;4107.774072426046;4136.8138433770555;5527.39198688144;5565.109582466866;5571.220029195916;5576.581756368289;5622.269105016404;5814.476697097197;5882.764689412461;5919.1713160157615;5944.970275148597;5978.312494063239;5562.9443705563235;5568.832935011957;5569.387367389584;5595.776168953196;5596.664200148004;5123.769430375642;5129.179331306973;5130.640855140105;5133.178691409356;5174.715390653475;6085.9695701521205;6136.079588061826;6142.662153581596;6163.3836616338;6171.290301615282;5955.940440595538;6045.093236014633;6057.121717351048;6060.363661815446;6100.206973093647;6149.508039356931;6173;6174.598651087665;6175.6912154393;6177.81466556004;5766.452187042224;5808.82573522795;5881.7647294109465;5884.35272120075;5885.440883116097;5910.202122713551;5962.19510366095;5995.340512543704;5998.850028749316;6042.848928776816;5828.979928512408;5831.125331200354;5833.9416605835095;5838.766449342149;5843.474087332161;5627.859303517281;5730.598858079894;5798.797042103675;5837.328707198726;5842.970785146047;5712.828615141552;5803.129530570448;5803.65178089316;5807.564432667651;5852.619579727304;5768.913466298093;5796.855078623068;5799.2750906136735;5800.767969281182;5852.268466441695;5517.062099443024;5625.493705566519;5633.155026745857;5663.9716801415725;5702.743376547983 07:16:07 INFO - 2015-11-24 07:16:07,411 DEBUG : BROWSER_OUTPUT: |1;ext.html;568.8606291458592;585.6017907822679;592.3454582686131;607.6748939317466;608.5952841360493;30906.84546577267;31999.36001279973;32014.839925800366;40283.59716402835;41153;44244.55755442445;44288.3356749649;44631.55368446314;44634.553654463525;44828;8727.999999999984;8893.555322233895;8894.599743011548;8896.0659130791;8897.421667591585;7617;7795.454318197729;10412.895871041306;10684.03843654071;10697.19771017173;10389.168866490663;10482.633107841228;10486.161107111451;10493.422861742602;10494.68515944523;7585.203553626845;7761.22387761225;10374.585016599327;10465.110465610433;10492.160627149848;10403.47982600867;10727.463626818628;10730;10735.624253151102;10743.194260430499;40015.39976900349;40200.195996079914;40462.797686011385;40497.392539111934;40598.79700601478;3361.647027062172;3402.1324562236473;3566.2154326048226;3992.940105898414;3997.040710229553;29928.551071733942;30346;30634.54048189279;30642.23394415135;31378;3820.6752426043818;3838;3855.0169706724605;3961.835798970232;3967.6230758077936;276016;278479;279019;280015;280089;54516.18225726617;55129.72435137879;56508.71745641246;56770;57050.714746426005;66472.67927584691;67494.2629876466;67747.66126169436;67790.32209677939;67812;15604.063756174666;15777;15838.52484425446;15890.52328430149;15891.364345426286;11997.800219977933;12053.457594408274;12060.457279422448;12062.819057714141;12075.09436792244;18312.81687183138;18472.630547388977;18587.721184182246;18672.066396680384;18694.25222991065;6908.723651053901;7003.719851205997;7200.903611447128;7201;7283.781486555412;811.5982588618672;967.4098799732158;981.293468702533;1033.2973577966904;1091.951726342704;28078.71921280802;28097.43805123886;28270.434591308058;28458.715412845606;28512.28719281993;1035.5598870480017;1053.1837825685154;1133.8922802333766;1167.1335200746905;1185.7984142695761;14631.634209144857;14694.11835289886;14925.40298388074;15050.698986020438;15095.849041509444;326212;332003;332572;332916;333686;51109.744451277504;51262.231066534034;51345.229821552704;51351.229731554056;51417.485825142016;1317.4466723975954;1323.2126884503705;1323.2788130468919;1325.0592079623575;1332.1274565159836;27328.72671273262;28311.15066548007;28438.289042774097;28490.145295641163;28711;46413.535864642276;47058;47086;47099;47115.528844712484;298646;299520;300229;302531;302710;26974;30323.24191895132;30729.385412292075;30787;30967;37060.258794823414;37480;37761.2447751049;38385.42421863618;38394.80802595969;31131.221719456287;32339.19152021218;32550.582188870776;33246.83376583199;33272.1681957953;28069.43861122725;33097.669023309456;34987.47518787271;35215;35233.82383088068;32165.678343216267;34419.827900860335;34507.48238776471;34538;34828;31276.843615781774;32554.674453255164;33006.504902426;33056.338873222885;33059.66940330662;24907.50184996326;25044;25144.37139071538;25540.744592553838;26749.732502674724 07:16:07 INFO - 2015-11-24 07:16:07,414 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.4222916645867;356.6059504247805;357.4031367616081;357.9731520135989;358.41936063577003;14164.92917535411;14415.78376324356;15900.522984310475;16321.755173672404;17169.484915452525;16216.675666486663;16282.592935176597;16366.590835229124;16591.91704041481;16613.252403641836;5125.692458452486;5313.654612450197;5318.1225097859;5319.0957537218765;5328.92006619901;4064;4148.481439820022;5352.330958630171;5843.79546715865;5990.400959903996;6056.121862329959;6082.878342433149;6085.391460853902;6086.269647642267;6111.327753947062;5120.15517439622;5237.947620523784;5245.527902488775;5247.160454327328;5248.42267350593;5047.798088076509;5050.747462626854;5062.924056139161;5068.543831055186;5073.771680274396;12416.75166496665;12800.87199128006;12801.871981280161;12851.100422970396;14727.631809204855;2040.1533363654066;2062.82465990391;2130.286354071388;2139.390273771983;2183.0268910582586;9331.953340233254;9373;9758.268129890215;11301.49143288554;13334;1764.1884733022825;1808.5659441734022;1812.3113216977465;1812.5740450994006;1866.9439916802517;54796.178057328776;55757.99999999959;59975;62965;63468;9405.90594094064;9730.221582273402;10073.69778906634;10112.24158188124;10291.742706432398;12865.935670321589;12900.161489503153;12940.223586584834;12961.740765184644;12977.091603587847;7312.597807120659;7460.253974602496;7465.29079737424;7496.325330720261;7709;7516.924830751623;7517.285857843496;7523.849523009619;7561.735339263099;7595.924040759633;4146.108586653884;4147.191297696981;4154.106867023544;4176.853810116631;4183.895402614898;1677.4464426739146;1718.4672751447092;1736.0625262358437;1789.1948623119388;1843.4653950354516;829.8257365953096;867.9869801952975;874.2743522875998;974.0357046523891;982.7248370456284;14244.928775356057;16033.679326413407;16110.113943732973;16203;16226;842.2924743215606;913.9680111196076;963.7108867339911;1016.7356487313352;1029.3155051890558;9002.324825638103;9245.167934885892;9329.084970584432;9529.857052144223;9542.379745316672;468903;475636;486466;487336;491202;70386.296137039;73753.6312318435;75000;76728.61635691786;77021.61489192519;1172.888575585318;1176.053277111916;1176.1825531255695;1190.0165335075876;1201.4773573495556;15783.368665253261;15875.761863571825;15962.760558591863;16063.196840157712;16262.67474650524;34067.48898766471;34611;34662.480062798575;34994.47508287428;35063.64936350604;45775.31337030014;45943.540564593925;46399.536004640875;47633.76183119062;48779;8914.465132092095;9029.593668285075;9078.636854525745;9110.908890911007;9134.680286189952;12879.678008049874;13387.598372048855;16550.751738724168;17422.303107875545;17566.473005809847;13297.933510332387;13924.721505570034;14041.719165616427;14178.574642760734;14186.219757913414;12649.873501265238;13508.054436189372;13545.1195672281;13570.321483925962;14196.645083872985;13734.175949443066;13810.723785524033;13871.23708196059;14288.42846286137;14653.780193296896;8548.700795472128;9192.310576706908;9468.053194680477;9495.525223738647;9496.43021418717;12503.687407814878;13657.590272291847;13831.585052448443;14311.85688143147;14549.709005820036 07:16:07 INFO - 2015-11-24 07:16:07,415 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1354.336375176164;1675.430353679749;1715.8112607613161;1729.2218501674242;1743;6967.4077703395205;7330.926690733091;7444.553326800382;7448.329650331469;7455.70177192913;7614.390848732102;7747.728829490969;7749.961250193755;7752.534847909129;7756.0692716874055;2018.9091490882872;2055.928042518512;2232.3191426614876;2247.6179049561533;2258.288639078685;2307.538492301538;2314.837961342707;2315.7452680205165;2316.3977365884907;2318.13070098713;2194.100418828281;2271.738750043741;2274.4541310085624;2274.8976296066717;2276.260215429992;1990.2138655231174;2039.4595432210401;2222.655488399301;2269;2269.7389800173028;2248.1457046322457;2251.9887400563057;2278.8860556972086;2280.0309868305903;2322.094383190557;7776.844463110762;7846.372290216769;7847;7856.960715196445;7858.607069646495;4735.479097299294;4822.10791003662;4849.466558678542;4853.587445067174;4856.538628830291;3016.713412225835;3053.9921825797655;3059.816411015346;3061.2499937515227;3188.58548388708;953.0850383631722;962.619765192752;986.7237173591334;996.5864166370948;1017.2269075502597;10671.253012289142;10822.78354432907;10846.620368287073;10857.697076350809;10872.619458319;4182.91634167315;4223.809928553161;4312.978435107804;4322.8703138905885;4353.10761293934;8775.912240877637;8785.69250076257;8786.428882122642;8810.251128654008;8811.515366654767;4767.642426818003;4784.569388754959;4816.662833601685;4821.397325334333;4826.710397376169;4435.866923992286;4437.800298986554;4439.689221754446;4439.755813430228;4440.33394990754;3450.344434557426;3478.704310133667;3511.0520159556777;3527.894163175109;3528.065062758371;1028.753099256173;1032.9431881246603;1035.5754140802235;1057.5346847387125;1058.714147180257;1025.2310766924807;1032.7056788815153;1265.221888538542;1272.2938768983304;1336.946522139123;7355.852882942419;7436.219196984347;7443.255674432514;7443.330100290891;7445.441591880631;496.31012892080037;498.7730582584915;1167.11882528692;1205.25274329916;1222.7860124478182;5839.5036421904615;5914;5918;5918.289805223315;5924.229850119543;8844.513551754715;9420.528973551433;9446.811063778687;9458.1487666109;9459.337846350827;9250.491222982666;9291.58187881547;9326.533673316442;9354.391964522285;9357.438553686801;7123.786286411416;7256.564606123649;7294.051773269547;7366.705331786776;7368.226336234726;7137.82155446118;7181.820454488679;7194.136703595602;7196.856062878818;7204.56772593646;7768.650410731644;7901.604919754104;7949.920500794918;7968.123506414406;8111.716089936824;8279.793005174919;8336.333093352396;8476.449030812977;8483.194096560817;8490.32077433816;6869.931300686929;7093.964530177316;7102.9289707104335;7105.6447177639875;7108.0048793170035;7431.99668044807;7477.513961592479;7492.475526713078;7507.549547027196;7526.13449453298;6816.897746533707;7007.369336759716;7161.928380716126;7192.4246060314;7212.206657267801;6756.831079223059;6763.985402189711;6928;7037.507374483737;7088.539244949062;7044.718211271492;7119.67961441726;7144.571325720473;7146.249643787535;7146.428285737233;6434.324395938546;6462.870742585216;6466.191726034246;6483.189601299838;6489.221293444817;6432.807015789534;6664.83337916556;6672.83317917056;6688.565243259172;6704.027915952257 07:16:07 INFO - 2015-11-24 07:16:07,418 DEBUG : BROWSER_OUTPUT: |4;prototype.html;340.61510493142754;344.9818561415718;346.4318517631084;348.99651003489987;352.53113359232225;5908.645481271126;5963.612365196264;6008.729607167672;6026.367231440701;6037.6075555089;5663.461971112748;5786.189933409316;5847.122931560268;5915.231019967409;5934.258217722785;4596.333531637911;4602.516735742749;4606.447226332836;4614.23865062266;4632.837850675227;4413.3159360299205;4606.493285738566;4620.838270660528;4624.468186158584;4629.537046295377;4422.889427764299;4426.933595996063;4560.133574620828;4577.977110114445;4596.379488769024;4548.545145485425;4554.772261386917;4555.385023021883;4555.863324100283;4564.383808185902;3960.049588098864;4028;4031.4355990161403;4033.6369726724733;4033.757974521538;5514.476124768141;5636.323641163046;5637.7181140942785;5647.943520564824;5651.124075768263;5350.491703288181;5352.357717073937;5353.250544923714;5357.624966252364;5359.517643412073;6309.990401535732;6310.8106756796915;6311.93688063118;6317.968410157966;6318.083877837687;4486.4840543337605;4490.618297444688;4495.865124046284;4497.23546997008;4502.234620114588;6338.619682819046;6545.770898018546;6551.1155993941165;6552.93447065528;6567.047778072153;4461.286194208911;4476.7090139140855;4477.28363461851;4480;4481.663875209372;4531.750753708512;4532;4534.36518887356;4538.228501154812;4538.614217791459;5256.579473642099;5264.736763161904;5265.368155821249;5268.92096618551;5269.894602107936;6225.8132256032395;6320.494360451153;6339.207599050119;6341.4292713656;6413.743450262031;1624.285314461633;1652.6859896619603;1654.3961454069179;1655.3047719957406;1655.4206027890143;1112.1547623805966;1113.8774734779167;1115.7210697325668;1118.2284223885492;1133.9149563782748;6086.269647642312;6093.969530152321;6105.877882442326;6107.6640784757265;6107.96946015276;6549.967250163719;6552.082708420825;6552.411797340024;6587;6607.174103237096;5893.381194974466;6010.158577799111;6043.395660433922;6147.907781383283;6168.19813424252;3554.0759402555004;3570.8214589270433;3577.7853328800356;3578.087587665129;3580.6598373154507;6824.112865327475;6829.760958366433;6830;6842.178938527409;6846.281140480178;6625.403713665697;6727.697253623599;6744.393004629607;6759.155105611799;6767.966160169168;6826.488013399015;6834.4874134440115;6836.6923488443135;6838.521303508806;6840.452763778985;6595.505337099641;6597.538172327891;6597.967010164918;6599.472042236705;6602.933970660232;6325.4939604832425;6475.255345635313;6480.189976252968;6481.481481481376;6520.771772987922;6738.966305168443;6788.083608712761;6801.9319806801295;6804.4556435484055;6810.046593476818;4542.841000564964;4555.088982203639;4556.567126123013;4562.133194692998;4564.908701826012;6418.326075762165;6546.803595892131;6571.34286571339;6573.671316434255;6586.045023471665;6419.582727122722;6424.421802037839;6425.389587989133;6425.807225783234;6430.871382572416;6400.51996100285;6412.23053233615;6412.487001039999;6416.230052393743;6421.775237866652;6172.506199504119;6262.060690896402;6285.057241413641;6289.779857704958;6292.024736165901;6390.201224846895;6426.4537514311805;6434.935650643621;6441.5490915635455;6442.323556026738;6263.3736626337;6275.780347687809;6276.654783986742;6283.8114856554375;6287.056941458818 07:16:07 INFO - 2015-11-24 07:16:07,418 DEBUG : BROWSER_OUTPUT: |5;yui.html;796.9721059762908;852.5225873510831;861.2378045429797;870.347239570322;889.9243564297035;12956.54652087177;13157.473701051946;13227.933860330697;13230.213921120645;13265.933670331648;13274.20354778714;13363.599092027254;13394.799078013813;14716.969812113157;15181.240937953113;801.507073150013;841.6254766628853;841.9368547358941;848.9320854331638;850.5959669157163;799.6801279488193;835.1272919798824;844.6283635200523;844.7001314533344;844.9619767110495;849.3375167369462;882.3955590420583;885.2254277507182;887.9556022198897;888.5734847273312;851.833892390984;878.6968495868915;881.4138597832434;883.3154305413292;883.9469631822047;624.0919462182513;634.5241069198102;648.9091527186198;649.0718272869794;649.1593386564364;14198.858011419858;14242.430302787876;14351.856481435156;14356.353964071643;14393.352299146563;11903;12159.331236781973;12188.085893558018;12240.510379584806;12727.23636581808;9846.65536706219;10400;10436.983918951883;10679;10785.676429707122;3557.875474358411;3580.15866271426;3650.5984341722387;3653.853845846163;3699.3711069118312;42492.150156996686;42692.359614605804;42795.78602107001;43049.35425968582;47833.52166478326;9549.188318992963;9639.662611808553;9734.026597340351;9941.751456213653;10189.949050254849;18168.45494635163;18216;18216.726749098772;18221.08894555267;18238.361657341928;7459.664315105833;7480.850382992418;7505.962470187614;7519.248075192437;7905.051393832777;4166.66666666666;4172.3532852407925;4217.325227963511;4228.471441069866;4291.635211007037;3113.891013814551;3123.625164980217;3132.7650426218124;3133.2010337363827;3135.8275294859;536.4581772409816;550.9724513774295;552.4917076289823;554.4594020829659;558.7904535799075;578.7974209026806;703.5110598134247;704.520925770481;707.2291202589203;712.2272334517004;8906.465612063168;9206.677766278148;9292;9309.581068851918;9463.76340591477;630.1744714424119;648.2091847945499;659.9043138744855;679.8572299816994;680.1701923653135;4034.636882680514;4299.763513006815;4301.892452688645;4345.695801293942;4410.823567057346;57802.42197578055;58952.7052364744;59026.70486647539;59216.40783592109;59371.40628593745;47866.760666196446;48318.758406207744;50884;50962.23556646653;51307.74346128246;42307.7884610575;43035.13929721388;43525.56474435215;47969.76015119902;48357.75821120872;8849.469031858109;9165.17513423795;9287.535623218677;9472.242220622471;9543.856842147234;33553.83223083869;34603.65396346004;34991.65008349986;35011.29977400489;35087.29825403529;35640.108997275274;38678.80660596679;40038.1992360157;40801.387979179744;44258.77870610626;11414.086873050303;11419;11458.82811757841;11477;11619.825702614637;12536.811947820972;12802.67993300175;12815.743685126432;12881.677958051123;12898.67753306175;11654.184207105422;11830.349330786545;12091.758164836478;12123.211991220542;12257.693557660774;11325;11420.714482138013;11591.420428978348;11929.701757455787;12305.876941230832;11371.14716396257;11709.121815863675;11936.924655599138;11991.880081199426;12454.56409025716;9798.216142708709;10050.949745251228;10052.497375131361;10426;10735.516901739597;10101.747456313651;10424.166066714797;10446.52990615409;10446.529906154394;10576.629817956335 07:16:07 INFO - 2015-11-24 07:16:07,418 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:16:07 INFO - 2015-11-24 07:16:07,418 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:16:07 INFO - 2015-11-24 07:16:07,419 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 07:16:07 INFO - 2015-11-24 07:16:07,419 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:16:07 INFO - 2015-11-24 07:16:07,419 DEBUG : BROWSER_OUTPUT: __startTimestamp1448378167407__endTimestamp 07:16:07 INFO - 2015-11-24 07:16:07,419 DEBUG : BROWSER_OUTPUT: 07:16:07 INFO - 2015-11-24 07:16:07,419 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:16:07 INFO - 2015-11-24 07:16:07,419 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:16:07 INFO - 2015-11-24 07:16:07,419 DEBUG : BROWSER_OUTPUT: 07:16:07 INFO - 2015-11-24 07:16:07,419 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5522.93 Median:5733.71 stddev:626.34 (10.9%) stddev-sans-first:600.83 07:16:07 INFO - 2015-11-24 07:16:07,419 DEBUG : BROWSER_OUTPUT: Values: 3185.6 3247.7 3292.4 3296.5 3316.8 5357.1 5467.1 5496.0 5509.1 5509.1 5446.8 5482.4 5542.7 5553.2 5629.0 4951.0 5018.9 5029.6 5098.1 5151.1 4874.8 5120.5 5130.7 5172.9 5199.8 4947.7 5008.8 5021.6 5029.4 5078.7 5033.0 5050.6 5052.7 5055.0 5096.4 5027.6 5027.8 5029.1 5029.2 5053.3 5255.8 5359.7 5361.6 5374.3 5399.0 5858.4 6030.5 6033.4 6047.5 6064.5 6037.8 6070.3 6071.0 6072.0 6077.9 5433.0 5528.9 5530.3 5574.7 5733.7 6073.1 6074.1 6075.9 6086.8 6092.5 5769.9 5875.9 5888.8 5893.5 5898.1 5888.7 5985.3 5986.9 5993.0 5994.0 5913.6 5916.4 5916.4 5919.1 5959.4 6005.3 6038.8 6046.4 6048.0 6048.3 4497.8 4535.8 4579.4 4633.1 4636.6 4046.0 4052.8 4089.1 4107.8 4136.8 5527.4 5565.1 5571.2 5576.6 5622.3 5814.5 5882.8 5919.2 5945.0 5978.3 5562.9 5568.8 5569.4 5595.8 5596.7 5123.8 5129.2 5130.6 5133.2 5174.7 6086.0 6136.1 6142.7 6163.4 6171.3 5955.9 6045.1 6057.1 6060.4 6100.2 6149.5 6173.0 6174.6 6175.7 6177.8 5766.5 5808.8 5881.8 5884.4 5885.4 5910.2 5962.2 5995.3 5998.9 6042.8 5829.0 5831.1 5833.9 5838.8 5843.5 5627.9 5730.6 5798.8 5837.3 5843.0 5712.8 5803.1 5803.7 5807.6 5852.6 5768.9 5796.9 5799.3 5800.8 5852.3 5517.1 5625.5 5633.2 5664.0 5702.7 07:16:07 INFO - 2015-11-24 07:16:07,420 DEBUG : BROWSER_OUTPUT: 07:16:07 INFO - 2015-11-24 07:16:07,420 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47066.99 Median:32444.89 stddev:79647.06 (245.5%) stddev-sans-first:79793.98 07:16:07 INFO - 2015-11-24 07:16:07,421 DEBUG : BROWSER_OUTPUT: Values: 568.9 585.6 592.3 607.7 608.6 30906.8 31999.4 32014.8 40283.6 41153.0 44244.6 44288.3 44631.6 44634.6 44828.0 8728.0 8893.6 8894.6 8896.1 8897.4 7617.0 7795.5 10412.9 10684.0 10697.2 10389.2 10482.6 10486.2 10493.4 10494.7 7585.2 7761.2 10374.6 10465.1 10492.2 10403.5 10727.5 10730.0 10735.6 10743.2 40015.4 40200.2 40462.8 40497.4 40598.8 3361.6 3402.1 3566.2 3992.9 3997.0 29928.6 30346.0 30634.5 30642.2 31378.0 3820.7 3838.0 3855.0 3961.8 3967.6 276016.0 278479.0 279019.0 280015.0 280089.0 54516.2 55129.7 56508.7 56770.0 57050.7 66472.7 67494.3 67747.7 67790.3 67812.0 15604.1 15777.0 15838.5 15890.5 15891.4 11997.8 12053.5 12060.5 12062.8 12075.1 18312.8 18472.6 18587.7 18672.1 18694.3 6908.7 7003.7 7200.9 7201.0 7283.8 811.6 967.4 981.3 1033.3 1092.0 28078.7 28097.4 28270.4 28458.7 28512.3 1035.6 1053.2 1133.9 1167.1 1185.8 14631.6 14694.1 14925.4 15050.7 15095.8 326212.0 332003.0 332572.0 332916.0 333686.0 51109.7 51262.2 51345.2 51351.2 51417.5 1317.4 1323.2 1323.3 1325.1 1332.1 27328.7 28311.2 28438.3 28490.1 28711.0 46413.5 47058.0 47086.0 47099.0 47115.5 298646.0 299520.0 300229.0 302531.0 302710.0 26974.0 30323.2 30729.4 30787.0 30967.0 37060.3 37480.0 37761.2 38385.4 38394.8 31131.2 32339.2 32550.6 33246.8 33272.2 28069.4 33097.7 34987.5 35215.0 35233.8 32165.7 34419.8 34507.5 34538.0 34828.0 31276.8 32554.7 33006.5 33056.3 33059.7 24907.5 25044.0 25144.4 25540.7 26749.7 07:16:07 INFO - 2015-11-24 07:16:07,421 DEBUG : BROWSER_OUTPUT: 07:16:07 INFO - 2015-11-24 07:16:07,421 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26701.70 Median:358.20 stddev:78796.17 (21998.0%) stddev-sans-first:78992.38 07:16:07 INFO - 2015-11-24 07:16:07,422 DEBUG : BROWSER_OUTPUT: Values: 354.4 356.6 357.4 358.0 358.4 14164.9 14415.8 15900.5 16321.8 17169.5 16216.7 16282.6 16366.6 16591.9 16613.3 5125.7 5313.7 5318.1 5319.1 5328.9 4064.0 4148.5 5352.3 5843.8 5990.4 6056.1 6082.9 6085.4 6086.3 6111.3 5120.2 5237.9 5245.5 5247.2 5248.4 5047.8 5050.7 5062.9 5068.5 5073.8 12416.8 12800.9 12801.9 12851.1 14727.6 2040.2 2062.8 2130.3 2139.4 2183.0 9332.0 9373.0 9758.3 11301.5 13334.0 1764.2 1808.6 1812.3 1812.6 1866.9 54796.2 55758.0 59975.0 62965.0 63468.0 9405.9 9730.2 10073.7 10112.2 10291.7 12865.9 12900.2 12940.2 12961.7 12977.1 7312.6 7460.3 7465.3 7496.3 7709.0 7516.9 7517.3 7523.8 7561.7 7595.9 4146.1 4147.2 4154.1 4176.9 4183.9 1677.4 1718.5 1736.1 1789.2 1843.5 829.8 868.0 874.3 974.0 982.7 14244.9 16033.7 16110.1 16203.0 16226.0 842.3 914.0 963.7 1016.7 1029.3 9002.3 9245.2 9329.1 9529.9 9542.4 468903.0 475636.0 486466.0 487336.0 491202.0 70386.3 73753.6 75000.0 76728.6 77021.6 1172.9 1176.1 1176.2 1190.0 1201.5 15783.4 15875.8 15962.8 16063.2 16262.7 34067.5 34611.0 34662.5 34994.5 35063.6 45775.3 45943.5 46399.5 47633.8 48779.0 8914.5 9029.6 9078.6 9110.9 9134.7 12879.7 13387.6 16550.8 17422.3 17566.5 13297.9 13924.7 14041.7 14178.6 14186.2 12649.9 13508.1 13545.1 13570.3 14196.6 13734.2 13810.7 13871.2 14288.4 14653.8 8548.7 9192.3 9468.1 9495.5 9496.4 12503.7 13657.6 13831.6 14311.9 14549.7 07:16:07 INFO - 2015-11-24 07:16:07,422 DEBUG : BROWSER_OUTPUT: 07:16:07 INFO - 2015-11-24 07:16:07,422 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5441.86 Median:6486.21 stddev:2815.92 (43.4%) stddev-sans-first:2807.06 07:16:07 INFO - 2015-11-24 07:16:07,423 DEBUG : BROWSER_OUTPUT: Values: 1354.3 1675.4 1715.8 1729.2 1743.0 6967.4 7330.9 7444.6 7448.3 7455.7 7614.4 7747.7 7750.0 7752.5 7756.1 2018.9 2055.9 2232.3 2247.6 2258.3 2307.5 2314.8 2315.7 2316.4 2318.1 2194.1 2271.7 2274.5 2274.9 2276.3 1990.2 2039.5 2222.7 2269.0 2269.7 2248.1 2252.0 2278.9 2280.0 2322.1 7776.8 7846.4 7847.0 7857.0 7858.6 4735.5 4822.1 4849.5 4853.6 4856.5 3016.7 3054.0 3059.8 3061.2 3188.6 953.1 962.6 986.7 996.6 1017.2 10671.3 10822.8 10846.6 10857.7 10872.6 4182.9 4223.8 4313.0 4322.9 4353.1 8775.9 8785.7 8786.4 8810.3 8811.5 4767.6 4784.6 4816.7 4821.4 4826.7 4435.9 4437.8 4439.7 4439.8 4440.3 3450.3 3478.7 3511.1 3527.9 3528.1 1028.8 1032.9 1035.6 1057.5 1058.7 1025.2 1032.7 1265.2 1272.3 1336.9 7355.9 7436.2 7443.3 7443.3 7445.4 496.3 498.8 1167.1 1205.3 1222.8 5839.5 5914.0 5918.0 5918.3 5924.2 8844.5 9420.5 9446.8 9458.1 9459.3 9250.5 9291.6 9326.5 9354.4 9357.4 7123.8 7256.6 7294.1 7366.7 7368.2 7137.8 7181.8 7194.1 7196.9 7204.6 7768.7 7901.6 7949.9 7968.1 8111.7 8279.8 8336.3 8476.4 8483.2 8490.3 6869.9 7094.0 7102.9 7105.6 7108.0 7432.0 7477.5 7492.5 7507.5 7526.1 6816.9 7007.4 7161.9 7192.4 7212.2 6756.8 6764.0 6928.0 7037.5 7088.5 7044.7 7119.7 7144.6 7146.2 7146.4 6434.3 6462.9 6466.2 6483.2 6489.2 6432.8 6664.8 6672.8 6688.6 6704.0 07:16:07 INFO - 2015-11-24 07:16:07,423 DEBUG : BROWSER_OUTPUT: 07:16:07 INFO - 2015-11-24 07:16:07,424 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5320.52 Median:6031.99 stddev:1594.88 (26.4%) stddev-sans-first:1554.93 07:16:07 INFO - 2015-11-24 07:16:07,424 DEBUG : BROWSER_OUTPUT: Values: 340.6 345.0 346.4 349.0 352.5 5908.6 5963.6 6008.7 6026.4 6037.6 5663.5 5786.2 5847.1 5915.2 5934.3 4596.3 4602.5 4606.4 4614.2 4632.8 4413.3 4606.5 4620.8 4624.5 4629.5 4422.9 4426.9 4560.1 4578.0 4596.4 4548.5 4554.8 4555.4 4555.9 4564.4 3960.0 4028.0 4031.4 4033.6 4033.8 5514.5 5636.3 5637.7 5647.9 5651.1 5350.5 5352.4 5353.3 5357.6 5359.5 6310.0 6310.8 6311.9 6318.0 6318.1 4486.5 4490.6 4495.9 4497.2 4502.2 6338.6 6545.8 6551.1 6552.9 6567.0 4461.3 4476.7 4477.3 4480.0 4481.7 4531.8 4532.0 4534.4 4538.2 4538.6 5256.6 5264.7 5265.4 5268.9 5269.9 6225.8 6320.5 6339.2 6341.4 6413.7 1624.3 1652.7 1654.4 1655.3 1655.4 1112.2 1113.9 1115.7 1118.2 1133.9 6086.3 6094.0 6105.9 6107.7 6108.0 6550.0 6552.1 6552.4 6587.0 6607.2 5893.4 6010.2 6043.4 6147.9 6168.2 3554.1 3570.8 3577.8 3578.1 3580.7 6824.1 6829.8 6830.0 6842.2 6846.3 6625.4 6727.7 6744.4 6759.2 6768.0 6826.5 6834.5 6836.7 6838.5 6840.5 6595.5 6597.5 6598.0 6599.5 6602.9 6325.5 6475.3 6480.2 6481.5 6520.8 6739.0 6788.1 6801.9 6804.5 6810.0 4542.8 4555.1 4556.6 4562.1 4564.9 6418.3 6546.8 6571.3 6573.7 6586.0 6419.6 6424.4 6425.4 6425.8 6430.9 6400.5 6412.2 6412.5 6416.2 6421.8 6172.5 6262.1 6285.1 6289.8 6292.0 6390.2 6426.5 6434.9 6441.5 6442.3 6263.4 6275.8 6276.7 6283.8 6287.1 07:16:07 INFO - 2015-11-24 07:16:07,424 DEBUG : BROWSER_OUTPUT: 07:16:07 INFO - 2015-11-24 07:16:07,424 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13690.46 Median:42744.07 stddev:15361.25 (35.9%) stddev-sans-first:15373.83 07:16:07 INFO - 2015-11-24 07:16:07,424 DEBUG : BROWSER_OUTPUT: Values: 797.0 852.5 861.2 870.3 889.9 12956.5 13157.5 13227.9 13230.2 13265.9 13274.2 13363.6 13394.8 14717.0 15181.2 801.5 841.6 841.9 848.9 850.6 799.7 835.1 844.6 844.7 845.0 849.3 882.4 885.2 888.0 888.6 851.8 878.7 881.4 883.3 883.9 624.1 634.5 648.9 649.1 649.2 14198.9 14242.4 14351.9 14356.4 14393.4 11903.0 12159.3 12188.1 12240.5 12727.2 9846.7 10400.0 10437.0 10679.0 10785.7 3557.9 3580.2 3650.6 3653.9 3699.4 42492.2 42692.4 42795.8 43049.4 47833.5 9549.2 9639.7 9734.0 9941.8 10189.9 18168.5 18216.0 18216.7 18221.1 18238.4 7459.7 7480.9 7506.0 7519.2 7905.1 4166.7 4172.4 4217.3 4228.5 4291.6 3113.9 3123.6 3132.8 3133.2 3135.8 536.5 551.0 552.5 554.5 558.8 578.8 703.5 704.5 707.2 712.2 8906.5 9206.7 9292.0 9309.6 9463.8 630.2 648.2 659.9 679.9 680.2 4034.6 4299.8 4301.9 4345.7 4410.8 57802.4 58952.7 59026.7 59216.4 59371.4 47866.8 48318.8 50884.0 50962.2 51307.7 42307.8 43035.1 43525.6 47969.8 48357.8 8849.5 9165.2 9287.5 9472.2 9543.9 33553.8 34603.7 34991.7 35011.3 35087.3 35640.1 38678.8 40038.2 40801.4 44258.8 11414.1 11419.0 11458.8 11477.0 11619.8 12536.8 12802.7 12815.7 12881.7 12898.7 11654.2 11830.3 12091.8 12123.2 12257.7 11325.0 11420.7 11591.4 11929.7 12305.9 11371.1 11709.1 11936.9 11991.9 12454.6 9798.2 10050.9 10052.5 10426.0 10735.5 10101.7 10424.2 10446.5 10446.5 10576.6 07:16:07 INFO - 2015-11-24 07:16:07,424 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:16:07 INFO - 2015-11-24 07:16:07,424 DEBUG : BROWSER_OUTPUT: 07:16:08 INFO - 2015-11-24 07:16:08,153 INFO : Browser exited with error code: 0 07:16:08 INFO - 2015-11-24 07:16:08,170 INFO : Completed test dromaeo_css (00:18:34) 07:16:08 INFO - 2015-11-24 07:16:08,170 INFO : Starting test kraken 07:16:08 INFO - 2015-11-24 07:16:08,170 DEBUG : operating with platform_type : linux_ 07:16:08 INFO - 2015-11-24 07:16:08,170 INFO : Initialising browser for kraken test... 07:16:08 INFO - 2015-11-24 07:16:08,176 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNS9RP0/profile http://localhost:60147/getInfo.html 07:16:12 INFO - 2015-11-24 07:16:12,387 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:16:12 INFO - 2015-11-24 07:16:12,387 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:16:12 INFO - 2015-11-24 07:16:12,387 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:16:12 INFO - 2015-11-24 07:16:12,388 DEBUG : BROWSER_OUTPUT: __metrics 07:16:12 INFO - 2015-11-24 07:16:12,585 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:16:13 INFO - 2015-11-24 07:16:13,997 INFO : Browser initialized. 07:16:13 INFO - 2015-11-24 07:16:13,997 INFO : Running cycle 1/1 for kraken test... 07:16:13 INFO - 2015-11-24 07:16:13,998 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNS9RP0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:16:25 INFO - 2015-11-24 07:16:25,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 140488704 07:16:25 INFO - 2015-11-24 07:16:25,755 DEBUG : BROWSER_OUTPUT: 07:16:28 INFO - 2015-11-24 07:16:28,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60147/tests/kraken/driver.html?testName=audio-beat-detection) 07:16:28 INFO - 2015-11-24 07:16:28,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 176136192 07:16:28 INFO - 2015-11-24 07:16:28,759 DEBUG : BROWSER_OUTPUT: 07:16:31 INFO - 2015-11-24 07:16:31,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60147/tests/kraken/driver.html?testName=audio-dft) 07:16:31 INFO - 2015-11-24 07:16:31,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 165285888 07:16:31 INFO - 2015-11-24 07:16:31,958 DEBUG : BROWSER_OUTPUT: 07:16:34 INFO - 2015-11-24 07:16:34,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60147/tests/kraken/driver.html?testName=audio-fft) 07:16:35 INFO - 2015-11-24 07:16:35,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 152080384 07:16:35 INFO - 2015-11-24 07:16:35,342 DEBUG : BROWSER_OUTPUT: 07:16:37 INFO - 2015-11-24 07:16:37,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60147/tests/kraken/driver.html?testName=audio-oscillator) 07:16:37 INFO - 2015-11-24 07:16:37,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 152711168 07:16:37 INFO - 2015-11-24 07:16:37,873 DEBUG : BROWSER_OUTPUT: 07:16:40 INFO - 2015-11-24 07:16:40,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60147/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:16:40 INFO - 2015-11-24 07:16:40,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 154869760 07:16:40 INFO - 2015-11-24 07:16:40,628 DEBUG : BROWSER_OUTPUT: 07:16:43 INFO - 2015-11-24 07:16:43,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60147/tests/kraken/driver.html?testName=imaging-darkroom) 07:16:44 INFO - 2015-11-24 07:16:44,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 157224960 07:16:44 INFO - 2015-11-24 07:16:44,112 DEBUG : BROWSER_OUTPUT: 07:16:47 INFO - 2015-11-24 07:16:47,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60147/tests/kraken/driver.html?testName=imaging-desaturate) 07:16:48 INFO - 2015-11-24 07:16:48,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 158183424 07:16:48 INFO - 2015-11-24 07:16:48,047 DEBUG : BROWSER_OUTPUT: 07:16:50 INFO - 2015-11-24 07:16:50,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60147/tests/kraken/driver.html?testName=json-parse-financial) 07:16:51 INFO - 2015-11-24 07:16:51,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 157732864 07:16:51 INFO - 2015-11-24 07:16:51,377 DEBUG : BROWSER_OUTPUT: 07:16:52 INFO - 2015-11-24 07:16:52,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60147/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:16:53 INFO - 2015-11-24 07:16:53,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 167501824 07:16:53 INFO - 2015-11-24 07:16:53,485 DEBUG : BROWSER_OUTPUT: 07:16:55 INFO - 2015-11-24 07:16:55,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:16:55 INFO - 2015-11-24 07:16:55,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 166178816 07:16:55 INFO - 2015-11-24 07:16:55,870 DEBUG : BROWSER_OUTPUT: 07:16:57 INFO - 2015-11-24 07:16:57,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:16:58 INFO - 2015-11-24 07:16:58,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 172326912 07:16:58 INFO - 2015-11-24 07:16:58,456 DEBUG : BROWSER_OUTPUT: 07:17:00 INFO - 2015-11-24 07:17:00,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:17:01 INFO - 2015-11-24 07:17:01,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 180903936 07:17:01 INFO - 2015-11-24 07:17:01,431 DEBUG : BROWSER_OUTPUT: 07:17:03 INFO - 2015-11-24 07:17:03,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:17:04 INFO - 2015-11-24 07:17:04,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 178569216 07:17:04 INFO - 2015-11-24 07:17:04,559 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60147/tests/kraken/driver.html?testName=ai-astar) 07:17:06 INFO - 2015-11-24 07:17:06,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 237932544 07:17:06 INFO - 2015-11-24 07:17:06,459 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,459 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:17:06 INFO - 2015-11-24 07:17:06,459 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:17:06 INFO - 2015-11-24 07:17:06,460 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:17:06 INFO - 2015-11-24 07:17:06,460 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:17:06 INFO - 2015-11-24 07:17:06,460 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;110;102;111;109;109;98;107;107;99 07:17:06 INFO - 2015-11-24 07:17:06,460 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;126;154;162;134;158;148;127;169;124 07:17:06 INFO - 2015-11-24 07:17:06,460 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;160;161;160;161;159;159;162;161;161 07:17:06 INFO - 2015-11-24 07:17:06,461 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;87;90;71;71;71;101;92;73 07:17:06 INFO - 2015-11-24 07:17:06,461 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;137;93;92;94;143;94;93;138 07:17:06 INFO - 2015-11-24 07:17:06,461 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;110;109;109;109;109;110 07:17:06 INFO - 2015-11-24 07:17:06,461 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;145;145;146;145;146;145;145;146;145 07:17:06 INFO - 2015-11-24 07:17:06,461 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;95;95;96;96;95;95 07:17:06 INFO - 2015-11-24 07:17:06,461 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;59;58;57;59;58;60;59;67;56 07:17:06 INFO - 2015-11-24 07:17:06,462 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;69;70;69;69;69;71;69;69 07:17:06 INFO - 2015-11-24 07:17:06,462 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;84;84;83;84;83;84;86;85 07:17:06 INFO - 2015-11-24 07:17:06,462 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;116;119;114;132;120;120;123;115;118 07:17:06 INFO - 2015-11-24 07:17:06,462 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;139;149;152;148;140;152;150;147;137 07:17:06 INFO - 2015-11-24 07:17:06,462 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;65;66;69;69;65;68;67;68 07:17:06 INFO - 2015-11-24 07:17:06,462 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:17:06 INFO - 2015-11-24 07:17:06,463 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:17:06 INFO - 2015-11-24 07:17:06,463 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,921 07:17:06 INFO - 2015-11-24 07:17:06,463 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:17:06 INFO - 2015-11-24 07:17:06,463 DEBUG : BROWSER_OUTPUT: __startTimestamp1448378226458__endTimestamp 07:17:06 INFO - 2015-11-24 07:17:06,463 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,467 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:17:06 INFO - 2015-11-24 07:17:06,467 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:17:06 INFO - 2015-11-24 07:17:06,467 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,467 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.90 Median:109.50 stddev:4.61 (4.2%) stddev-sans-first:4.87 07:17:06 INFO - 2015-11-24 07:17:06,467 DEBUG : BROWSER_OUTPUT: Values: 107.0 110.0 102.0 111.0 109.0 109.0 98.0 107.0 107.0 99.0 07:17:06 INFO - 2015-11-24 07:17:06,468 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,468 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.30 Median:152.50 stddev:16.35 (10.7%) stddev-sans-first:17.21 07:17:06 INFO - 2015-11-24 07:17:06,468 DEBUG : BROWSER_OUTPUT: Values: 151.0 126.0 154.0 162.0 134.0 158.0 148.0 127.0 169.0 124.0 07:17:06 INFO - 2015-11-24 07:17:06,468 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,468 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 07:17:06 INFO - 2015-11-24 07:17:06,469 DEBUG : BROWSER_OUTPUT: Values: 159.0 160.0 161.0 160.0 161.0 159.0 159.0 162.0 161.0 161.0 07:17:06 INFO - 2015-11-24 07:17:06,469 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,469 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.00 Median:73.00 stddev:11.33 (15.5%) stddev-sans-first:11.54 07:17:06 INFO - 2015-11-24 07:17:06,469 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 87.0 90.0 71.0 71.0 71.0 101.0 92.0 73.0 07:17:06 INFO - 2015-11-24 07:17:06,469 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,469 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:93.50 stddev:22.17 (23.7%) stddev-sans-first:22.99 07:17:06 INFO - 2015-11-24 07:17:06,469 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 137.0 93.0 92.0 94.0 143.0 94.0 93.0 138.0 07:17:06 INFO - 2015-11-24 07:17:06,469 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,469 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:17:06 INFO - 2015-11-24 07:17:06,469 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 110.0 07:17:06 INFO - 2015-11-24 07:17:06,469 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:3.00 (5.1%) stddev-sans-first:3.15 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 58.0 57.0 59.0 58.0 60.0 59.0 67.0 56.0 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 70.0 69.0 69.0 69.0 71.0 69.0 69.0 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.10 (1.3%) stddev-sans-first:0.93 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 84.0 84.0 83.0 84.0 83.0 84.0 86.0 85.0 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,470 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:119.50 stddev:5.10 (4.3%) stddev-sans-first:5.41 07:17:06 INFO - 2015-11-24 07:17:06,471 DEBUG : BROWSER_OUTPUT: Values: 119.0 116.0 119.0 114.0 132.0 120.0 120.0 123.0 115.0 118.0 07:17:06 INFO - 2015-11-24 07:17:06,471 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,471 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:148.50 stddev:5.68 (3.8%) stddev-sans-first:5.79 07:17:06 INFO - 2015-11-24 07:17:06,471 DEBUG : BROWSER_OUTPUT: Values: 141.0 139.0 149.0 152.0 148.0 140.0 152.0 150.0 147.0 137.0 07:17:06 INFO - 2015-11-24 07:17:06,471 DEBUG : BROWSER_OUTPUT: 07:17:06 INFO - 2015-11-24 07:17:06,471 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.52 (2.3%) stddev-sans-first:1.58 07:17:06 INFO - 2015-11-24 07:17:06,471 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 65.0 66.0 69.0 69.0 65.0 68.0 67.0 68.0 07:17:06 INFO - 2015-11-24 07:17:06,471 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:17:06 INFO - 2015-11-24 07:17:06,471 DEBUG : BROWSER_OUTPUT: 07:17:07 INFO - 2015-11-24 07:17:07,337 INFO : Browser exited with error code: 0 07:17:07 INFO - 2015-11-24 07:17:07,393 INFO : Completed test kraken (00:00:59) 07:17:07 INFO - 2015-11-24 07:17:07,393 INFO : Starting test v8_7 07:17:07 INFO - 2015-11-24 07:17:07,393 DEBUG : operating with platform_type : linux_ 07:17:07 INFO - 2015-11-24 07:17:07,393 INFO : Initialising browser for v8_7 test... 07:17:07 INFO - 2015-11-24 07:17:07,399 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4nlScD/profile http://localhost:60147/getInfo.html 07:17:11 INFO - 2015-11-24 07:17:11,597 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:17:11 INFO - 2015-11-24 07:17:11,597 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:17:11 INFO - 2015-11-24 07:17:11,597 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:17:11 INFO - 2015-11-24 07:17:11,597 DEBUG : BROWSER_OUTPUT: __metrics 07:17:11 INFO - 2015-11-24 07:17:11,786 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:17:13 INFO - 2015-11-24 07:17:13,169 INFO : Browser initialized. 07:17:13 INFO - 2015-11-24 07:17:13,170 INFO : Running cycle 1/1 for v8_7 test... 07:17:13 INFO - 2015-11-24 07:17:13,170 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4nlScD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:17:24 INFO - 2015-11-24 07:17:24,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 139927552 07:17:24 INFO - 2015-11-24 07:17:24,886 DEBUG : BROWSER_OUTPUT: 07:17:46 INFO - 2015-11-24 07:17:46,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60147/tests/v8_7/run.html (next: http://localhost:60147/tests/v8_7/run.html) 07:17:46 INFO - 2015-11-24 07:17:46,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 612323328 07:17:46 INFO - 2015-11-24 07:17:46,535 DEBUG : BROWSER_OUTPUT: 07:17:46 INFO - 2015-11-24 07:17:46,535 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:17:46 INFO - 2015-11-24 07:17:46,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:17:46 INFO - 2015-11-24 07:17:46,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:17:46 INFO - 2015-11-24 07:17:46,535 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:17:46 INFO - 2015-11-24 07:17:46,535 DEBUG : BROWSER_OUTPUT: |0;Richards;186.04651162790697 07:17:46 INFO - 2015-11-24 07:17:46,535 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.28793471925394 07:17:46 INFO - 2015-11-24 07:17:46,535 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.7959416976279 07:17:46 INFO - 2015-11-24 07:17:46,536 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4975.124378109453 07:17:46 INFO - 2015-11-24 07:17:46,536 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1118.5682326621925 07:17:46 INFO - 2015-11-24 07:17:46,536 DEBUG : BROWSER_OUTPUT: |5;Earley;772.7975270479135 07:17:46 INFO - 2015-11-24 07:17:46,536 DEBUG : BROWSER_OUTPUT: |6;Boyer;12011.904761904761 07:17:46 INFO - 2015-11-24 07:17:46,536 DEBUG : BROWSER_OUTPUT: |7;RegExp;25350 07:17:46 INFO - 2015-11-24 07:17:46,536 DEBUG : BROWSER_OUTPUT: |8;Splay;630.517023959647 07:17:46 INFO - 2015-11-24 07:17:46,537 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 07:17:46 INFO - 2015-11-24 07:17:46,537 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:17:46 INFO - 2015-11-24 07:17:46,537 DEBUG : BROWSER_OUTPUT: __startTimestamp1448378266534__endTimestamp 07:17:46 INFO - 2015-11-24 07:17:46,537 DEBUG : BROWSER_OUTPUT: 07:17:46 INFO - 2015-11-24 07:17:46,537 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:17:46 INFO - 2015-11-24 07:17:46,537 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:17:46 INFO - 2015-11-24 07:17:46,537 DEBUG : BROWSER_OUTPUT: 07:17:46 INFO - 2015-11-24 07:17:46,538 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:186.05 Median:186.05 stddev:0.00 (0.0%) 07:17:46 INFO - 2015-11-24 07:17:46,539 DEBUG : BROWSER_OUTPUT: Values: 186.0 07:17:46 INFO - 2015-11-24 07:17:46,539 DEBUG : BROWSER_OUTPUT: 07:17:46 INFO - 2015-11-24 07:17:46,539 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.29 Median:194.29 stddev:0.00 (0.0%) 07:17:46 INFO - 2015-11-24 07:17:46,539 DEBUG : BROWSER_OUTPUT: Values: 194.3 07:17:46 INFO - 2015-11-24 07:17:46,539 DEBUG : BROWSER_OUTPUT: 07:17:46 INFO - 2015-11-24 07:17:46,539 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.80 Median:285.80 stddev:0.00 (0.0%) 07:17:46 INFO - 2015-11-24 07:17:46,539 DEBUG : BROWSER_OUTPUT: Values: 285.8 07:17:46 INFO - 2015-11-24 07:17:46,539 DEBUG : BROWSER_OUTPUT: 07:17:46 INFO - 2015-11-24 07:17:46,539 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4975.12 Median:4975.12 stddev:0.00 (0.0%) 07:17:46 INFO - 2015-11-24 07:17:46,539 DEBUG : BROWSER_OUTPUT: Values: 4975.1 07:17:46 INFO - 2015-11-24 07:17:46,539 DEBUG : BROWSER_OUTPUT: 07:17:46 INFO - 2015-11-24 07:17:46,539 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1118.57 Median:1118.57 stddev:0.00 (0.0%) 07:17:46 INFO - 2015-11-24 07:17:46,540 DEBUG : BROWSER_OUTPUT: Values: 1118.6 07:17:46 INFO - 2015-11-24 07:17:46,540 DEBUG : BROWSER_OUTPUT: 07:17:46 INFO - 2015-11-24 07:17:46,540 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:772.80 Median:772.80 stddev:0.00 (0.0%) 07:17:46 INFO - 2015-11-24 07:17:46,540 DEBUG : BROWSER_OUTPUT: Values: 772.8 07:17:46 INFO - 2015-11-24 07:17:46,540 DEBUG : BROWSER_OUTPUT: 07:17:46 INFO - 2015-11-24 07:17:46,540 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12011.90 Median:12011.90 stddev:0.00 (0.0%) 07:17:46 INFO - 2015-11-24 07:17:46,540 DEBUG : BROWSER_OUTPUT: Values: 12011.9 07:17:46 INFO - 2015-11-24 07:17:46,540 DEBUG : BROWSER_OUTPUT: 07:17:46 INFO - 2015-11-24 07:17:46,541 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25350.00 Median:25350.00 stddev:0.00 (0.0%) 07:17:46 INFO - 2015-11-24 07:17:46,541 DEBUG : BROWSER_OUTPUT: Values: 25350.0 07:17:46 INFO - 2015-11-24 07:17:46,541 DEBUG : BROWSER_OUTPUT: 07:17:46 INFO - 2015-11-24 07:17:46,541 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:630.52 Median:630.52 stddev:0.00 (0.0%) 07:17:46 INFO - 2015-11-24 07:17:46,541 DEBUG : BROWSER_OUTPUT: Values: 630.5 07:17:46 INFO - 2015-11-24 07:17:46,541 DEBUG : BROWSER_OUTPUT: 07:17:46 INFO - 2015-11-24 07:17:46,541 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:17:46 INFO - 2015-11-24 07:17:46,541 DEBUG : BROWSER_OUTPUT: Values: 4830.9 07:17:46 INFO - 2015-11-24 07:17:46,541 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:17:46 INFO - 2015-11-24 07:17:46,541 DEBUG : BROWSER_OUTPUT: 07:17:47 INFO - 2015-11-24 07:17:47,334 INFO : Browser exited with error code: 0 07:17:47 INFO - 2015-11-24 07:17:47,346 INFO : Completed test v8_7 (00:00:39) 07:17:47 INFO - 2015-11-24 07:17:47,549 INFO : Completed test suite (00:20:13) 07:17:47 INFO - 2015-11-24 07:17:47,550 DEBUG : Working with test: dromaeo_css 07:17:47 INFO - 2015-11-24 07:17:47,550 DEBUG : Generating results file: dromaeo_css 07:17:47 INFO - 2015-11-24 07:17:47,551 DEBUG : Working with test: kraken 07:17:47 INFO - 2015-11-24 07:17:47,551 DEBUG : Generating results file: kraken 07:17:47 INFO - 2015-11-24 07:17:47,551 INFO : javascript benchmark 07:17:47 INFO - 2015-11-24 07:17:47,551 DEBUG : Working with test: v8_7 07:17:47 INFO - 2015-11-24 07:17:47,552 DEBUG : Generating results file: v8_7 07:17:47 INFO - 2015-11-24 07:17:47,552 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:17:47 INFO - 2015-11-24 07:17:47,610 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 07:17:47 INFO - 2015-11-24 07:17:47,611 DEBUG : process_Request line: dromaeo_css 7030.87 graph.html#tests=[[72,64,35]] 07:17:47 INFO - 2015-11-24 07:17:47,611 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:17:47 INFO - 2015-11-24 07:17:47,642 DEBUG : process_Request line: kraken 1493.50 graph.html#tests=[[232,64,35]] 07:17:47 INFO - 2015-11-24 07:17:47,642 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:17:47 INFO - 2015-11-24 07:17:47,673 DEBUG : process_Request line: v8_7 20792.94 graph.html#tests=[[230,64,35]] 07:17:47 INFO - 2015-11-24 07:17:47,674 INFO : javascript benchmark 07:17:47 INFO - 2015-11-24 07:17:47,677 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3185.6177258728953, 3247.6589958054387, 3292.3744488547172, 3296.522004309377, 3316.7678262521617, 5357.062514060043, 5467.097928841747, 5496.0, 5509.11854103343, 5509.146082357236, 5446.836594902159, 5482.424345443731, 5542.667439953606, 5553.16702494626, 5629.0, 4950.950490495094, 5018.924716129261, 5029.572486338666, 5098.082345177866, 5151.0728068947765, 4874.7562621868765, 5120.487951204887, 5130.666506677073, 5172.896542069175, 5199.844004679866, 4947.6784009039475, 5008.7996480140755, 5021.57316628087, 5029.371328583927, 5078.746062696869, 5033.018561380532, 5050.595952323805, 5052.69683818972, 5054.963732434842, 5096.439391666913, 5027.597792176617, 5027.849164525033, 5029.094762942669, 5029.245613158019, 5053.317802096743, 5255.816046438395, 5359.651622644555, 5361.571074314045, 5374.328208973879, 5398.973005134949, 5858.355580886099, 6030.487408570277, 6033.42682445167, 6047.455728984369, 6064.484518815906, 6037.818865434044, 6070.271567411939, 6070.96964515179, 6072.0, 6077.878442431171, 5433.0, 5528.889422211573, 5530.336359636829, 5574.721263936787, 5733.713314334266, 6073.074145102274, 6074.086662701235, 6075.866057717283, 6086.847828804227, 6092.482139018233, 5769.884602308014, 5875.941240587625, 5888.793892213752, 5893.469587737124, 5898.14476900847, 5888.735006924699, 5985.281766188085, 5986.940130598726, 5993.0, 5994.0409534474275, 5913.615614985012, 5916.437938395846, 5916.437938395846, 5919.112133179971, 5959.374265702038, 6005.3394126646035, 6038.849028774316, 6046.425589568984, 6048.0, 6048.304444988883, 4497.797599108048, 4535.750533720611, 4579.358889755437, 4633.096546173464, 4636.582707556337, 4046.008727861693, 4052.8378864845076, 4089.1003979124544, 4107.774072426046, 4136.8138433770555, 5527.39198688144, 5565.109582466866, 5571.220029195916, 5576.581756368289, 5622.269105016404, 5814.476697097197, 5882.764689412461, 5919.1713160157615, 5944.970275148597, 5978.312494063239, 5562.9443705563235, 5568.832935011957, 5569.387367389584, 5595.776168953196, 5596.664200148004, 5123.769430375642, 5129.179331306973, 5130.640855140105, 5133.178691409356, 5174.715390653475, 6085.9695701521205, 6136.079588061826, 6142.662153581596, 6163.3836616338, 6171.290301615282, 5955.940440595538, 6045.093236014633, 6057.121717351048, 6060.363661815446, 6100.206973093647, 6149.508039356931, 6173.0, 6174.598651087665, 6175.6912154393, 6177.81466556004, 5766.452187042224, 5808.82573522795, 5881.7647294109465, 5884.35272120075, 5885.440883116097, 5910.202122713551, 5962.19510366095, 5995.340512543704, 5998.850028749316, 6042.848928776816, 5828.979928512408, 5831.125331200354, 5833.9416605835095, 5838.766449342149, 5843.474087332161, 5627.859303517281, 5730.598858079894, 5798.797042103675, 5837.328707198726, 5842.970785146047, 5712.828615141552, 5803.129530570448, 5803.65178089316, 5807.564432667651, 5852.619579727304, 5768.913466298093, 5796.855078623068, 5799.2750906136735, 5800.767969281182, 5852.268466441695, 5517.062099443024, 5625.493705566519, 5633.155026745857, 5663.9716801415725, 5702.743376547983], "unit": "ms", "name": "dojo.html", "value": 5481.2541831001545}, {"lowerIsBetter": false, "replicates": [568.8606291458592, 585.6017907822679, 592.3454582686131, 607.6748939317466, 608.5952841360493, 30906.84546577267, 31999.36001279973, 32014.839925800366, 40283.59716402835, 41153.0, 44244.55755442445, 44288.3356749649, 44631.55368446314, 44634.553654463525, 44828.0, 8727.999999999984, 8893.555322233895, 8894.599743011548, 8896.0659130791, 8897.421667591585, 7617.0, 7795.454318197729, 10412.895871041306, 10684.03843654071, 10697.19771017173, 10389.168866490663, 10482.633107841228, 10486.161107111451, 10493.422861742602, 10494.68515944523, 7585.203553626845, 7761.22387761225, 10374.585016599327, 10465.110465610433, 10492.160627149848, 10403.47982600867, 10727.463626818628, 10730.0, 10735.624253151102, 10743.194260430499, 40015.39976900349, 40200.195996079914, 40462.797686011385, 40497.392539111934, 40598.79700601478, 3361.647027062172, 3402.1324562236473, 3566.2154326048226, 3992.940105898414, 3997.040710229553, 29928.551071733942, 30346.0, 30634.54048189279, 30642.23394415135, 31378.0, 3820.6752426043818, 3838.0, 3855.0169706724605, 3961.835798970232, 3967.6230758077936, 276016.0, 278479.0, 279019.0, 280015.0, 280089.0, 54516.18225726617, 55129.72435137879, 56508.71745641246, 56770.0, 57050.714746426005, 66472.67927584691, 67494.2629876466, 67747.66126169436, 67790.32209677939, 67812.0, 15604.063756174666, 15777.0, 15838.52484425446, 15890.52328430149, 15891.364345426286, 11997.800219977933, 12053.457594408274, 12060.457279422448, 12062.819057714141, 12075.09436792244, 18312.81687183138, 18472.630547388977, 18587.721184182246, 18672.066396680384, 18694.25222991065, 6908.723651053901, 7003.719851205997, 7200.903611447128, 7201.0, 7283.781486555412, 811.5982588618672, 967.4098799732158, 981.293468702533, 1033.2973577966904, 1091.951726342704, 28078.71921280802, 28097.43805123886, 28270.434591308058, 28458.715412845606, 28512.28719281993, 1035.5598870480017, 1053.1837825685154, 1133.8922802333766, 1167.1335200746905, 1185.7984142695761, 14631.634209144857, 14694.11835289886, 14925.40298388074, 15050.698986020438, 15095.849041509444, 326212.0, 332003.0, 332572.0, 332916.0, 333686.0, 51109.744451277504, 51262.231066534034, 51345.229821552704, 51351.229731554056, 51417.485825142016, 1317.4466723975954, 1323.2126884503705, 1323.2788130468919, 1325.0592079623575, 1332.1274565159836, 27328.72671273262, 28311.15066548007, 28438.289042774097, 28490.145295641163, 28711.0, 46413.535864642276, 47058.0, 47086.0, 47099.0, 47115.528844712484, 298646.0, 299520.0, 300229.0, 302531.0, 302710.0, 26974.0, 30323.24191895132, 30729.385412292075, 30787.0, 30967.0, 37060.258794823414, 37480.0, 37761.2447751049, 38385.42421863618, 38394.80802595969, 31131.221719456287, 32339.19152021218, 32550.582188870776, 33246.83376583199, 33272.1681957953, 28069.43861122725, 33097.669023309456, 34987.47518787271, 35215.0, 35233.82383088068, 32165.678343216267, 34419.827900860335, 34507.48238776471, 34538.0, 34828.0, 31276.843615781774, 32554.674453255164, 33006.504902426, 33056.338873222885, 33059.66940330662, 24907.50184996326, 25044.0, 25144.37139071538, 25540.744592553838, 26749.732502674724], "unit": "ms", "name": "ext.html", "value": 18638.72522116425}, {"lowerIsBetter": false, "replicates": [354.4222916645867, 356.6059504247805, 357.4031367616081, 357.9731520135989, 358.41936063577003, 14164.92917535411, 14415.78376324356, 15900.522984310475, 16321.755173672404, 17169.484915452525, 16216.675666486663, 16282.592935176597, 16366.590835229124, 16591.91704041481, 16613.252403641836, 5125.692458452486, 5313.654612450197, 5318.1225097859, 5319.0957537218765, 5328.92006619901, 4064.0, 4148.481439820022, 5352.330958630171, 5843.79546715865, 5990.400959903996, 6056.121862329959, 6082.878342433149, 6085.391460853902, 6086.269647642267, 6111.327753947062, 5120.15517439622, 5237.947620523784, 5245.527902488775, 5247.160454327328, 5248.42267350593, 5047.798088076509, 5050.747462626854, 5062.924056139161, 5068.543831055186, 5073.771680274396, 12416.75166496665, 12800.87199128006, 12801.871981280161, 12851.100422970396, 14727.631809204855, 2040.1533363654066, 2062.82465990391, 2130.286354071388, 2139.390273771983, 2183.0268910582586, 9331.953340233254, 9373.0, 9758.268129890215, 11301.49143288554, 13334.0, 1764.1884733022825, 1808.5659441734022, 1812.3113216977465, 1812.5740450994006, 1866.9439916802517, 54796.178057328776, 55757.99999999959, 59975.0, 62965.0, 63468.0, 9405.90594094064, 9730.221582273402, 10073.69778906634, 10112.24158188124, 10291.742706432398, 12865.935670321589, 12900.161489503153, 12940.223586584834, 12961.740765184644, 12977.091603587847, 7312.597807120659, 7460.253974602496, 7465.29079737424, 7496.325330720261, 7709.0, 7516.924830751623, 7517.285857843496, 7523.849523009619, 7561.735339263099, 7595.924040759633, 4146.108586653884, 4147.191297696981, 4154.106867023544, 4176.853810116631, 4183.895402614898, 1677.4464426739146, 1718.4672751447092, 1736.0625262358437, 1789.1948623119388, 1843.4653950354516, 829.8257365953096, 867.9869801952975, 874.2743522875998, 974.0357046523891, 982.7248370456284, 14244.928775356057, 16033.679326413407, 16110.113943732973, 16203.0, 16226.0, 842.2924743215606, 913.9680111196076, 963.7108867339911, 1016.7356487313352, 1029.3155051890558, 9002.324825638103, 9245.167934885892, 9329.084970584432, 9529.857052144223, 9542.379745316672, 468903.0, 475636.0, 486466.0, 487336.0, 491202.0, 70386.296137039, 73753.6312318435, 75000.0, 76728.61635691786, 77021.61489192519, 1172.888575585318, 1176.053277111916, 1176.1825531255695, 1190.0165335075876, 1201.4773573495556, 15783.368665253261, 15875.761863571825, 15962.760558591863, 16063.196840157712, 16262.67474650524, 34067.48898766471, 34611.0, 34662.480062798575, 34994.47508287428, 35063.64936350604, 45775.31337030014, 45943.540564593925, 46399.536004640875, 47633.76183119062, 48779.0, 8914.465132092095, 9029.593668285075, 9078.636854525745, 9110.908890911007, 9134.680286189952, 12879.678008049874, 13387.598372048855, 16550.751738724168, 17422.303107875545, 17566.473005809847, 13297.933510332387, 13924.721505570034, 14041.719165616427, 14178.574642760734, 14186.219757913414, 12649.873501265238, 13508.054436189372, 13545.1195672281, 13570.321483925962, 14196.645083872985, 13734.175949443066, 13810.723785524033, 13871.23708196059, 14288.42846286137, 14653.780193296896, 8548.700795472128, 9192.310576706908, 9468.053194680477, 9495.525223738647, 9496.43021418717, 12503.687407814878, 13657.590272291847, 13831.585052448443, 14311.85688143147, 14549.709005820036], "unit": "ms", "name": "jquery.html", "value": 8601.850837468175}, {"lowerIsBetter": false, "replicates": [1354.336375176164, 1675.430353679749, 1715.8112607613161, 1729.2218501674242, 1743.0, 6967.4077703395205, 7330.926690733091, 7444.553326800382, 7448.329650331469, 7455.70177192913, 7614.390848732102, 7747.728829490969, 7749.961250193755, 7752.534847909129, 7756.0692716874055, 2018.9091490882872, 2055.928042518512, 2232.3191426614876, 2247.6179049561533, 2258.288639078685, 2307.538492301538, 2314.837961342707, 2315.7452680205165, 2316.3977365884907, 2318.13070098713, 2194.100418828281, 2271.738750043741, 2274.4541310085624, 2274.8976296066717, 2276.260215429992, 1990.2138655231174, 2039.4595432210401, 2222.655488399301, 2269.0, 2269.7389800173028, 2248.1457046322457, 2251.9887400563057, 2278.8860556972086, 2280.0309868305903, 2322.094383190557, 7776.844463110762, 7846.372290216769, 7847.0, 7856.960715196445, 7858.607069646495, 4735.479097299294, 4822.10791003662, 4849.466558678542, 4853.587445067174, 4856.538628830291, 3016.713412225835, 3053.9921825797655, 3059.816411015346, 3061.2499937515227, 3188.58548388708, 953.0850383631722, 962.619765192752, 986.7237173591334, 996.5864166370948, 1017.2269075502597, 10671.253012289142, 10822.78354432907, 10846.620368287073, 10857.697076350809, 10872.619458319, 4182.91634167315, 4223.809928553161, 4312.978435107804, 4322.8703138905885, 4353.10761293934, 8775.912240877637, 8785.69250076257, 8786.428882122642, 8810.251128654008, 8811.515366654767, 4767.642426818003, 4784.569388754959, 4816.662833601685, 4821.397325334333, 4826.710397376169, 4435.866923992286, 4437.800298986554, 4439.689221754446, 4439.755813430228, 4440.33394990754, 3450.344434557426, 3478.704310133667, 3511.0520159556777, 3527.894163175109, 3528.065062758371, 1028.753099256173, 1032.9431881246603, 1035.5754140802235, 1057.5346847387125, 1058.714147180257, 1025.2310766924807, 1032.7056788815153, 1265.221888538542, 1272.2938768983304, 1336.946522139123, 7355.852882942419, 7436.219196984347, 7443.255674432514, 7443.330100290891, 7445.441591880631, 496.31012892080037, 498.7730582584915, 1167.11882528692, 1205.25274329916, 1222.7860124478182, 5839.5036421904615, 5914.0, 5918.0, 5918.289805223315, 5924.229850119543, 8844.513551754715, 9420.528973551433, 9446.811063778687, 9458.1487666109, 9459.337846350827, 9250.491222982666, 9291.58187881547, 9326.533673316442, 9354.391964522285, 9357.438553686801, 7123.786286411416, 7256.564606123649, 7294.051773269547, 7366.705331786776, 7368.226336234726, 7137.82155446118, 7181.820454488679, 7194.136703595602, 7196.856062878818, 7204.56772593646, 7768.650410731644, 7901.604919754104, 7949.920500794918, 7968.123506414406, 8111.716089936824, 8279.793005174919, 8336.333093352396, 8476.449030812977, 8483.194096560817, 8490.32077433816, 6869.931300686929, 7093.964530177316, 7102.9289707104335, 7105.6447177639875, 7108.0048793170035, 7431.99668044807, 7477.513961592479, 7492.475526713078, 7507.549547027196, 7526.13449453298, 6816.897746533707, 7007.369336759716, 7161.928380716126, 7192.4246060314, 7212.206657267801, 6756.831079223059, 6763.985402189711, 6928.0, 7037.507374483737, 7088.539244949062, 7044.718211271492, 7119.67961441726, 7144.571325720473, 7146.249643787535, 7146.428285737233, 6434.324395938546, 6462.870742585216, 6466.191726034246, 6483.189601299838, 6489.221293444817, 6432.807015789534, 6664.83337916556, 6672.83317917056, 6688.565243259172, 6704.027915952257], "unit": "ms", "name": "mootools.html", "value": 4447.3672022458}, {"lowerIsBetter": false, "replicates": [340.61510493142754, 344.9818561415718, 346.4318517631084, 348.99651003489987, 352.53113359232225, 5908.645481271126, 5963.612365196264, 6008.729607167672, 6026.367231440701, 6037.6075555089, 5663.461971112748, 5786.189933409316, 5847.122931560268, 5915.231019967409, 5934.258217722785, 4596.333531637911, 4602.516735742749, 4606.447226332836, 4614.23865062266, 4632.837850675227, 4413.3159360299205, 4606.493285738566, 4620.838270660528, 4624.468186158584, 4629.537046295377, 4422.889427764299, 4426.933595996063, 4560.133574620828, 4577.977110114445, 4596.379488769024, 4548.545145485425, 4554.772261386917, 4555.385023021883, 4555.863324100283, 4564.383808185902, 3960.049588098864, 4028.0, 4031.4355990161403, 4033.6369726724733, 4033.757974521538, 5514.476124768141, 5636.323641163046, 5637.7181140942785, 5647.943520564824, 5651.124075768263, 5350.491703288181, 5352.357717073937, 5353.250544923714, 5357.624966252364, 5359.517643412073, 6309.990401535732, 6310.8106756796915, 6311.93688063118, 6317.968410157966, 6318.083877837687, 4486.4840543337605, 4490.618297444688, 4495.865124046284, 4497.23546997008, 4502.234620114588, 6338.619682819046, 6545.770898018546, 6551.1155993941165, 6552.93447065528, 6567.047778072153, 4461.286194208911, 4476.7090139140855, 4477.28363461851, 4480.0, 4481.663875209372, 4531.750753708512, 4532.0, 4534.36518887356, 4538.228501154812, 4538.614217791459, 5256.579473642099, 5264.736763161904, 5265.368155821249, 5268.92096618551, 5269.894602107936, 6225.8132256032395, 6320.494360451153, 6339.207599050119, 6341.4292713656, 6413.743450262031, 1624.285314461633, 1652.6859896619603, 1654.3961454069179, 1655.3047719957406, 1655.4206027890143, 1112.1547623805966, 1113.8774734779167, 1115.7210697325668, 1118.2284223885492, 1133.9149563782748, 6086.269647642312, 6093.969530152321, 6105.877882442326, 6107.6640784757265, 6107.96946015276, 6549.967250163719, 6552.082708420825, 6552.411797340024, 6587.0, 6607.174103237096, 5893.381194974466, 6010.158577799111, 6043.395660433922, 6147.907781383283, 6168.19813424252, 3554.0759402555004, 3570.8214589270433, 3577.7853328800356, 3578.087587665129, 3580.6598373154507, 6824.112865327475, 6829.760958366433, 6830.0, 6842.178938527409, 6846.281140480178, 6625.403713665697, 6727.697253623599, 6744.393004629607, 6759.155105611799, 6767.966160169168, 6826.488013399015, 6834.4874134440115, 6836.6923488443135, 6838.521303508806, 6840.452763778985, 6595.505337099641, 6597.538172327891, 6597.967010164918, 6599.472042236705, 6602.933970660232, 6325.4939604832425, 6475.255345635313, 6480.189976252968, 6481.481481481376, 6520.771772987922, 6738.966305168443, 6788.083608712761, 6801.9319806801295, 6804.4556435484055, 6810.046593476818, 4542.841000564964, 4555.088982203639, 4556.567126123013, 4562.133194692998, 4564.908701826012, 6418.326075762165, 6546.803595892131, 6571.34286571339, 6573.671316434255, 6586.045023471665, 6419.582727122722, 6424.421802037839, 6425.389587989133, 6425.807225783234, 6430.871382572416, 6400.51996100285, 6412.23053233615, 6412.487001039999, 6416.230052393743, 6421.775237866652, 6172.506199504119, 6262.060690896402, 6285.057241413641, 6289.779857704958, 6292.024736165901, 6390.201224846895, 6426.4537514311805, 6434.935650643621, 6441.5490915635455, 6442.323556026738, 6263.3736626337, 6275.780347687809, 6276.654783986742, 6283.8114856554375, 6287.056941458818], "unit": "ms", "name": "prototype.html", "value": 4809.153934664924}, {"lowerIsBetter": false, "replicates": [796.9721059762908, 852.5225873510831, 861.2378045429797, 870.347239570322, 889.9243564297035, 12956.54652087177, 13157.473701051946, 13227.933860330697, 13230.213921120645, 13265.933670331648, 13274.20354778714, 13363.599092027254, 13394.799078013813, 14716.969812113157, 15181.240937953113, 801.507073150013, 841.6254766628853, 841.9368547358941, 848.9320854331638, 850.5959669157163, 799.6801279488193, 835.1272919798824, 844.6283635200523, 844.7001314533344, 844.9619767110495, 849.3375167369462, 882.3955590420583, 885.2254277507182, 887.9556022198897, 888.5734847273312, 851.833892390984, 878.6968495868915, 881.4138597832434, 883.3154305413292, 883.9469631822047, 624.0919462182513, 634.5241069198102, 648.9091527186198, 649.0718272869794, 649.1593386564364, 14198.858011419858, 14242.430302787876, 14351.856481435156, 14356.353964071643, 14393.352299146563, 11903.0, 12159.331236781973, 12188.085893558018, 12240.510379584806, 12727.23636581808, 9846.65536706219, 10400.0, 10436.983918951883, 10679.0, 10785.676429707122, 3557.875474358411, 3580.15866271426, 3650.5984341722387, 3653.853845846163, 3699.3711069118312, 42492.150156996686, 42692.359614605804, 42795.78602107001, 43049.35425968582, 47833.52166478326, 9549.188318992963, 9639.662611808553, 9734.026597340351, 9941.751456213653, 10189.949050254849, 18168.45494635163, 18216.0, 18216.726749098772, 18221.08894555267, 18238.361657341928, 7459.664315105833, 7480.850382992418, 7505.962470187614, 7519.248075192437, 7905.051393832777, 4166.66666666666, 4172.3532852407925, 4217.325227963511, 4228.471441069866, 4291.635211007037, 3113.891013814551, 3123.625164980217, 3132.7650426218124, 3133.2010337363827, 3135.8275294859, 536.4581772409816, 550.9724513774295, 552.4917076289823, 554.4594020829659, 558.7904535799075, 578.7974209026806, 703.5110598134247, 704.520925770481, 707.2291202589203, 712.2272334517004, 8906.465612063168, 9206.677766278148, 9292.0, 9309.581068851918, 9463.76340591477, 630.1744714424119, 648.2091847945499, 659.9043138744855, 679.8572299816994, 680.1701923653135, 4034.636882680514, 4299.763513006815, 4301.892452688645, 4345.695801293942, 4410.823567057346, 57802.42197578055, 58952.7052364744, 59026.70486647539, 59216.40783592109, 59371.40628593745, 47866.760666196446, 48318.758406207744, 50884.0, 50962.23556646653, 51307.74346128246, 42307.7884610575, 43035.13929721388, 43525.56474435215, 47969.76015119902, 48357.75821120872, 8849.469031858109, 9165.17513423795, 9287.535623218677, 9472.242220622471, 9543.856842147234, 33553.83223083869, 34603.65396346004, 34991.65008349986, 35011.29977400489, 35087.29825403529, 35640.108997275274, 38678.80660596679, 40038.1992360157, 40801.387979179744, 44258.77870610626, 11414.086873050303, 11419.0, 11458.82811757841, 11477.0, 11619.825702614637, 12536.811947820972, 12802.67993300175, 12815.743685126432, 12881.677958051123, 12898.67753306175, 11654.184207105422, 11830.349330786545, 12091.758164836478, 12123.211991220542, 12257.693557660774, 11325.0, 11420.714482138013, 11591.420428978348, 11929.701757455787, 12305.876941230832, 11371.14716396257, 11709.121815863675, 11936.924655599138, 11991.880081199426, 12454.56409025716, 9798.216142708709, 10050.949745251228, 10052.497375131361, 10426.0, 10735.516901739597, 10101.747456313651, 10424.166066714797, 10446.52990615409, 10446.529906154394, 10576.629817956335], "unit": "ms", "name": "yui.html", "value": 6426.249931951769}], "name": "dromaeo_css", "value": 7030.872321504158}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 110.0, 102.0, 111.0, 109.0, 109.0, 98.0, 107.0, 107.0, 99.0], "unit": "ms", "name": "ai-astar", "value": 105.9}, {"lowerIsBetter": true, "replicates": [151.0, 126.0, 154.0, 162.0, 134.0, 158.0, 148.0, 127.0, 169.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 161.0, 160.0, 161.0, 159.0, 159.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 87.0, 90.0, 71.0, 71.0, 71.0, 101.0, 92.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 137.0, 93.0, 92.0, 94.0, 143.0, 94.0, 93.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 58.0, 57.0, 59.0, 58.0, 60.0, 59.0, 67.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 70.0, 69.0, 69.0, 69.0, 71.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 84.0, 84.0, 83.0, 84.0, 83.0, 84.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 119.0, 114.0, 132.0, 120.0, 120.0, 123.0, 115.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [141.0, 139.0, 149.0, 152.0, 148.0, 140.0, 152.0, 150.0, 147.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.5}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 66.0, 69.0, 69.0, 65.0, 68.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1493.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [186.04651162790697], "unit": "score", "name": "Richards", "value": 189.74825000000004}, {"lowerIsBetter": false, "replicates": [194.28793471925394], "unit": "score", "name": "DeltaBlue", "value": 340.309346}, {"lowerIsBetter": false, "replicates": [285.7959416976279], "unit": "score", "name": "Encrypt", "value": 931.3673189999998}, {"lowerIsBetter": false, "replicates": [4975.124378109453], "unit": "score", "name": "Decrypt", "value": 53.502381}, {"lowerIsBetter": false, "replicates": [1118.5682326621925], "unit": "score", "name": "RayTrace", "value": 661.550166}, {"lowerIsBetter": false, "replicates": [772.7975270479135], "unit": "score", "name": "Earley", "value": 862.4031219999998}, {"lowerIsBetter": false, "replicates": [12011.904761904761], "unit": "score", "name": "Boyer", "value": 55.483540138751295}, {"lowerIsBetter": false, "replicates": [25350.0], "unit": "score", "name": "RegExp", "value": 35.936291913214966}, {"lowerIsBetter": false, "replicates": [630.517023959647], "unit": "score", "name": "Splay", "value": 129.24472600000004}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20792.935887258194}]} 07:17:47 INFO - RETURN: dromaeo_css: 7030.87 07:17:47 INFO - RETURN: kraken: 1493.50 07:17:47 INFO - RETURN: v8_7: 20792.94 07:17:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20792.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1493.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "7030.87"}}} 07:17:47 INFO - Return code: 0 07:17:47 INFO - # TBPL SUCCESS # 07:17:47 INFO - Running post-action listener: _resource_record_post_action 07:17:47 INFO - Running post-run listener: _resource_record_post_run 07:17:48 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 518524928; Read time: 24; Write time: 599220 07:17:48 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 221995008; Read time: 0; Write time: 327712 07:17:48 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8192; Write bytes: 285581312; Read time: 24; Write time: 266344 07:17:48 INFO - Running post-run listener: _upload_blobber_files 07:17:48 INFO - Blob upload gear active. 07:17:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:17:48 INFO - Copying logs to upload dir... 07:17:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.168622 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-24 07:17:48.081650) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 07:17:48.085608) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009902 build_url: 'https://queue.taskcluster.net/v1/task/dL9NlxbYTw2kN551dbMgtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 07:17:48.137478) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 07:17:48.137891) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1448373132.541191-250639532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 07:17:48.189954) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 07:17:48.190583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 07:17:48.191212) ========= ========= Total master_lag: 0.24 =========