builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1448107608.77 results: success (0) buildid: 20151121023041 builduid: 2660502593ca4b95b437f4f0d87f4fa5 revision: 489332006384610e3322739f66729448da0e98d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:48.765962) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:48.766466) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:48.766800) ========= 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=fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007282 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:48.788865) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:48.789141) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:48.810271) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:48.810543) ========= 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=fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004681 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:48.872433) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:48.872711) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:48.873077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:48.873371) ========= 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=fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-21 04:06:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2015-11-21 04:06:49 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.200667 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:49.090003) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:49.090356) ========= 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=fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016188 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:49.139548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-21 04:06:49.139879) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 489332006384610e3322739f66729448da0e98d9 --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 489332006384610e3322739f66729448da0e98d9 --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=fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-21 04:06:49,532 truncating revision to first 12 chars 2015-11-21 04:06:49,533 Setting DEBUG logging. 2015-11-21 04:06:49,533 attempt 1/10 2015-11-21 04:06:49,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/489332006384?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-21 04:06:50,365 unpacking tar archive at: fx-team-489332006384/testing/mozharness/ program finished with exit code 0 elapsedTime=1.117559 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-21 04:06:50.269696) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:50.270010) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:50.366936) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:50.367316) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:50.367814) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-21 04:06:50.368122) ========= /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=fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:06:50 INFO - MultiFileLogger online at 20151121 04:06:50 in /builds/slave/test-pgo 04:06:50 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 04:06:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:06:50 INFO - {'append_to_log': False, 04:06:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:06:50 INFO - 'blob_upload_branch': 'Fx-Team', 04:06:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:06:50 INFO - 'branch': 'Fx-Team', 04:06:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:06:50 INFO - 'config_files': ('talos/linux_config.py',), 04:06:50 INFO - 'default_actions': ('clobber', 04:06:50 INFO - 'read-buildbot-config', 04:06:50 INFO - 'download-and-extract', 04:06:50 INFO - 'populate-webroot', 04:06:50 INFO - 'create-virtualenv', 04:06:50 INFO - 'install', 04:06:50 INFO - 'run-tests'), 04:06:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:06:50 INFO - 'download_minidump_stackwalk': True, 04:06:50 INFO - 'download_symbols': 'ondemand', 04:06:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:06:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:06:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:06:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:06:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:06:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:06:50 INFO - 'installer_path': 'installer.exe', 04:06:50 INFO - 'log_level': 'info', 04:06:50 INFO - 'log_name': 'talos', 04:06:50 INFO - 'log_to_console': True, 04:06:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:06:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:06:50 INFO - 'opt_config_files': (), 04:06:50 INFO - 'pip_index': False, 04:06:50 INFO - 'sps_profile': False, 04:06:50 INFO - 'sps_profile_interval': 0, 04:06:50 INFO - 'suite': 'dromaeojs', 04:06:50 INFO - 'system_bits': '64', 04:06:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:50 INFO - 'title': 'talos-linux64-ix-046', 04:06:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:06:50 INFO - 'use_talos_json': True, 04:06:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:06:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:06:50 INFO - 'work_dir': 'build'} 04:06:50 INFO - ##### 04:06:50 INFO - ##### Running clobber step. 04:06:50 INFO - ##### 04:06:50 INFO - Running pre-action listener: _resource_record_pre_action 04:06:50 INFO - Running main action method: clobber 04:06:50 INFO - rmtree: /builds/slave/test-pgo/build 04:06:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:06:51 INFO - Running post-action listener: _resource_record_post_action 04:06:51 INFO - ##### 04:06:51 INFO - ##### Running read-buildbot-config step. 04:06:51 INFO - ##### 04:06:51 INFO - Running pre-action listener: _resource_record_pre_action 04:06:51 INFO - Running main action method: read_buildbot_config 04:06:51 INFO - Using buildbot properties: 04:06:51 INFO - { 04:06:51 INFO - "properties": { 04:06:51 INFO - "buildnumber": 507, 04:06:51 INFO - "product": "firefox", 04:06:51 INFO - "script_repo_revision": "production", 04:06:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:06:51 INFO - "repository": "", 04:06:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:06:51 INFO - "buildid": "20151121023041", 04:06:51 INFO - "slavename": "talos-linux64-ix-046", 04:06:51 INFO - "pgo_build": "True", 04:06:51 INFO - "basedir": "/builds/slave/test-pgo", 04:06:51 INFO - "project": "", 04:06:51 INFO - "platform": "ubuntu64_hw", 04:06:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:06:51 INFO - "slavebuilddir": "test", 04:06:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:06:51 INFO - "branch": "fx-team", 04:06:51 INFO - "repo_path": "integration/fx-team", 04:06:51 INFO - "stage_platform": "linux64-pgo", 04:06:51 INFO - "builduid": "2660502593ca4b95b437f4f0d87f4fa5", 04:06:51 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 04:06:51 INFO - }, 04:06:51 INFO - "sourcestamp": { 04:06:51 INFO - "repository": "", 04:06:51 INFO - "hasPatch": false, 04:06:51 INFO - "project": "", 04:06:51 INFO - "branch": "fx-team-linux64-pgo-talos", 04:06:51 INFO - "changes": [ 04:06:51 INFO - { 04:06:51 INFO - "category": null, 04:06:51 INFO - "files": [ 04:06:51 INFO - { 04:06:51 INFO - "url": null, 04:06:51 INFO - "name": "https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:06:51 INFO - } 04:06:51 INFO - ], 04:06:51 INFO - "repository": "", 04:06:51 INFO - "rev": "489332006384610e3322739f66729448da0e98d9", 04:06:51 INFO - "who": "sendchange", 04:06:51 INFO - "when": 1448107546, 04:06:51 INFO - "number": 6692256, 04:06:51 INFO - "comments": "", 04:06:51 INFO - "project": "", 04:06:51 INFO - "at": "Sat 21 Nov 2015 04:05:46", 04:06:51 INFO - "branch": "fx-team-linux64-pgo-talos", 04:06:51 INFO - "revlink": "", 04:06:51 INFO - "properties": [ 04:06:51 INFO - [ 04:06:51 INFO - "buildid", 04:06:51 INFO - "20151121023041", 04:06:51 INFO - "Change" 04:06:51 INFO - ], 04:06:51 INFO - [ 04:06:51 INFO - "builduid", 04:06:51 INFO - "2660502593ca4b95b437f4f0d87f4fa5", 04:06:51 INFO - "Change" 04:06:51 INFO - ], 04:06:51 INFO - [ 04:06:51 INFO - "pgo_build", 04:06:51 INFO - "True", 04:06:51 INFO - "Change" 04:06:51 INFO - ] 04:06:51 INFO - ], 04:06:51 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 04:06:51 INFO - } 04:06:51 INFO - ], 04:06:51 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 04:06:51 INFO - } 04:06:51 INFO - } 04:06:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:06:51 INFO - Running post-action listener: _resource_record_post_action 04:06:51 INFO - ##### 04:06:51 INFO - ##### Running download-and-extract step. 04:06:51 INFO - ##### 04:06:51 INFO - Running pre-action listener: _resource_record_pre_action 04:06:51 INFO - Running main action method: download_and_extract 04:06:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:51 INFO - https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:06:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/test_packages.json 04:06:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/test_packages.json 04:06:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:06:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:06:55 INFO - Downloaded 1302 bytes. 04:06:55 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:06:55 INFO - Using the following test package requirements: 04:06:55 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:55 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:06:55 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:55 INFO - u'jsshell-linux-x86_64.zip'], 04:06:55 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:06:55 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:55 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:06:55 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:06:55 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:06:55 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:55 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:06:55 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:55 INFO - https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:06:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:06:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:06:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:06:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:03 INFO - Downloaded 22523697 bytes. 04:07:03 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 04:07:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:07:03 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 04:07:04 INFO - Return code: 0 04:07:04 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 04:07: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')]} 04:07:04 INFO - https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:07:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:07:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:07:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:05 INFO - Downloaded 22523697 bytes. 04:07:05 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 04:07:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:07:05 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 04:07:06 INFO - Return code: 0 04:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:06 INFO - https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:07:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:07:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:07:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:07 INFO - Downloaded 11130997 bytes. 04:07:07 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 04:07:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:07:07 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 04:07:07 INFO - Return code: 0 04:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:07 INFO - https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:07:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:07:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:07:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:09 INFO - Downloaded 57431663 bytes. 04:07:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:07:09 INFO - mkdir: /builds/slave/test-pgo/properties 04:07:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:07:09 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:07:09 INFO - Contents: 04:07:09 INFO - build_url:https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:07:09 INFO - Running post-action listener: _resource_record_post_action 04:07:09 INFO - Running post-action listener: set_extra_try_arguments 04:07:09 INFO - ##### 04:07:09 INFO - ##### Running populate-webroot step. 04:07:09 INFO - ##### 04:07:09 INFO - Running pre-action listener: _resource_record_pre_action 04:07:09 INFO - Running main action method: populate_webroot 04:07:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:07:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:07:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:07:09 INFO - '../fennec_ids.txt'], 04:07:09 INFO - 'tests': ['tcheck2']}, 04:07:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:07:09 INFO - '--tppagecycles', 04:07:09 INFO - '7'], 04:07:09 INFO - 'tests': ['tsvgm']}}, 04:07:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:07:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:07:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:07:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:07:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:07:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:07:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:09 INFO - 'talos_options': ['--e10s'], 04:07:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:09 INFO - 'tests': ['damp', 'tps']}, 04:07:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:09 INFO - 'talos_options': ['--e10s'], 04:07:09 INFO - 'tests': ['damp', 'tps']}, 04:07:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:07:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:07:09 INFO - 'other': {'tests': ['a11yr', 04:07:09 INFO - 'ts_paint', 04:07:09 INFO - 'tpaint', 04:07:09 INFO - 'sessionrestore', 04:07:09 INFO - 'sessionrestore_no_auto_restore']}, 04:07:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:07:09 INFO - 'tests': ['a11yr', 04:07:09 INFO - 'ts_paint', 04:07:09 INFO - 'tpaint', 04:07:09 INFO - 'sessionrestore', 04:07:09 INFO - 'sessionrestore_no_auto_restore']}, 04:07:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:07:09 INFO - 'tests': ['a11yr', 04:07:09 INFO - 'ts_paint', 04:07:09 INFO - 'tpaint', 04:07:09 INFO - 'sessionrestore', 04:07:09 INFO - 'sessionrestore_no_auto_restore']}, 04:07:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:07:09 INFO - 'tests': ['a11yr', 04:07:09 INFO - 'ts_paint', 04:07:09 INFO - 'tpaint', 04:07:09 INFO - 'sessionrestore', 04:07:09 INFO - 'sessionrestore_no_auto_restore']}, 04:07:09 INFO - 'other_l64': {'tests': ['a11yr', 04:07:09 INFO - 'ts_paint', 04:07:09 INFO - 'tpaint', 04:07:09 INFO - 'sessionrestore', 04:07:09 INFO - 'sessionrestore_no_auto_restore']}, 04:07:09 INFO - 'other_nol64': {'tests': ['a11yr', 04:07:09 INFO - 'ts_paint', 04:07:09 INFO - 'tpaint', 04:07:09 INFO - 'sessionrestore', 04:07:09 INFO - 'sessionrestore_no_auto_restore']}, 04:07:09 INFO - 'svgr': {'tests': ['tsvgx', 04:07:09 INFO - 'tsvgr_opacity', 04:07:09 INFO - 'tart', 04:07:09 INFO - 'tscrollx', 04:07:09 INFO - 'cart']}, 04:07:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:07:09 INFO - 'tests': ['tsvgx', 04:07:09 INFO - 'tsvgr_opacity', 04:07:09 INFO - 'tart', 04:07:09 INFO - 'tscrollx', 04:07:09 INFO - 'cart']}, 04:07:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:09 INFO - 'tests': ['tp5o']}, 04:07:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:09 INFO - 'talos_options': ['--e10s'], 04:07:09 INFO - 'tests': ['tp5o']}, 04:07:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:09 INFO - 'talos_options': ['--xperf_path', 04:07:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:09 INFO - 'tests': ['tp5n']}, 04:07:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:09 INFO - 'talos_options': ['--e10s', 04:07:09 INFO - '--xperf_path', 04:07:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:09 INFO - 'tests': ['tp5n']}}, 04:07:09 INFO - 'talos.zip': {'path': '', 04:07:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:07:09 INFO - Running post-action listener: _resource_record_post_action 04:07:09 INFO - ##### 04:07:09 INFO - ##### Running create-virtualenv step. 04:07:09 INFO - ##### 04:07:09 INFO - Running pre-action listener: _resource_record_pre_action 04:07:09 INFO - Running main action method: create_virtualenv 04:07:09 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:07:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:07:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:07:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:07:09 INFO - Using real prefix '/usr' 04:07:09 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:07:10 INFO - Installing distribute.............................................................................................................................................................................................done. 04:07:12 INFO - Installing pip.................done. 04:07:12 INFO - Return code: 0 04:07:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f834a3b7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2451a90>, '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 0x24a3f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a42e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:07:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:07:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:07:12 INFO - Using env: {'DISPLAY': ':0', 04:07:12 INFO - 'HOME': '/home/cltbld', 04:07:12 INFO - 'LANG': 'en_US.UTF-8', 04:07:12 INFO - 'LANGUAGE': 'en_US:en', 04:07:12 INFO - 'LOGNAME': 'cltbld', 04:07:12 INFO - 'MAIL': '/var/mail/cltbld', 04:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:12 INFO - 'MOZ_NO_REMOTE': '1', 04:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:12 INFO - 'NO_EM_RESTART': '1', 04:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:12 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:12 INFO - 'SHELL': '/bin/bash', 04:07:12 INFO - 'SHLVL': '1', 04:07:12 INFO - 'TERM': 'linux', 04:07:12 INFO - 'TMOUT': '86400', 04:07:12 INFO - 'USER': 'cltbld', 04:07:12 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 04:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:12 INFO - '_': '/tools/buildbot/bin/python'} 04:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:07:12 INFO - Cleaning up... 04:07:12 INFO - Return code: 0 04:07:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f834a3b7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2451a90>, '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 0x24a3f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a42e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:07:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:07:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:07:12 INFO - Using env: {'DISPLAY': ':0', 04:07:12 INFO - 'HOME': '/home/cltbld', 04:07:12 INFO - 'LANG': 'en_US.UTF-8', 04:07:12 INFO - 'LANGUAGE': 'en_US:en', 04:07:12 INFO - 'LOGNAME': 'cltbld', 04:07:12 INFO - 'MAIL': '/var/mail/cltbld', 04:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:12 INFO - 'MOZ_NO_REMOTE': '1', 04:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:12 INFO - 'NO_EM_RESTART': '1', 04:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:12 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:12 INFO - 'SHELL': '/bin/bash', 04:07:12 INFO - 'SHLVL': '1', 04:07:12 INFO - 'TERM': 'linux', 04:07:12 INFO - 'TMOUT': '86400', 04:07:12 INFO - 'USER': 'cltbld', 04:07:12 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 04:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:12 INFO - '_': '/tools/buildbot/bin/python'} 04:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:12 INFO - Downloading/unpacking psutil>=0.7.1 04:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:14 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:07:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:07:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:07:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:14 INFO - Installing collected packages: psutil 04:07:14 INFO - Running setup.py install for psutil 04:07:14 INFO - building 'psutil._psutil_linux' extension 04:07:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:07:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:07:14 INFO - building 'psutil._psutil_posix' extension 04:07:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:07:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:07:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:15 INFO - Successfully installed psutil 04:07:15 INFO - Cleaning up... 04:07:15 INFO - Return code: 0 04:07:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f834a3b7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2451a90>, '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 0x24a3f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a42e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:07:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:07:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:07:15 INFO - Using env: {'DISPLAY': ':0', 04:07:15 INFO - 'HOME': '/home/cltbld', 04:07:15 INFO - 'LANG': 'en_US.UTF-8', 04:07:15 INFO - 'LANGUAGE': 'en_US:en', 04:07:15 INFO - 'LOGNAME': 'cltbld', 04:07:15 INFO - 'MAIL': '/var/mail/cltbld', 04:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:15 INFO - 'MOZ_NO_REMOTE': '1', 04:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:15 INFO - 'NO_EM_RESTART': '1', 04:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:15 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:15 INFO - 'SHELL': '/bin/bash', 04:07:15 INFO - 'SHLVL': '1', 04:07:15 INFO - 'TERM': 'linux', 04:07:15 INFO - 'TMOUT': '86400', 04:07:15 INFO - 'USER': 'cltbld', 04:07:15 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 04:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:15 INFO - '_': '/tools/buildbot/bin/python'} 04:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:07:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:07:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:07:17 INFO - Installing collected packages: mozsystemmonitor 04:07:17 INFO - Running setup.py install for mozsystemmonitor 04:07:17 INFO - Successfully installed mozsystemmonitor 04:07:17 INFO - Cleaning up... 04:07:17 INFO - Return code: 0 04:07:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:17 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 0x7f834a3b7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2451a90>, '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 0x24a3f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a42e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:07:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:07:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:07:17 INFO - Using env: {'DISPLAY': ':0', 04:07:17 INFO - 'HOME': '/home/cltbld', 04:07:17 INFO - 'LANG': 'en_US.UTF-8', 04:07:17 INFO - 'LANGUAGE': 'en_US:en', 04:07:17 INFO - 'LOGNAME': 'cltbld', 04:07:17 INFO - 'MAIL': '/var/mail/cltbld', 04:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:17 INFO - 'MOZ_NO_REMOTE': '1', 04:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:17 INFO - 'NO_EM_RESTART': '1', 04:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:17 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:17 INFO - 'SHELL': '/bin/bash', 04:07:17 INFO - 'SHLVL': '1', 04:07:17 INFO - 'TERM': 'linux', 04:07:17 INFO - 'TMOUT': '86400', 04:07:17 INFO - 'USER': 'cltbld', 04:07:17 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 04:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:17 INFO - '_': '/tools/buildbot/bin/python'} 04:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:17 INFO - Downloading/unpacking blobuploader==1.2.4 04:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:19 INFO - Downloading blobuploader-1.2.4.tar.gz 04:07:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:07:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:07:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:07:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:07:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:19 INFO - Downloading docopt-0.6.1.tar.gz 04:07:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:07:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:07:19 INFO - Installing collected packages: blobuploader, requests, docopt 04:07:19 INFO - Running setup.py install for blobuploader 04:07:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:07:19 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:07:19 INFO - Running setup.py install for requests 04:07:20 INFO - Running setup.py install for docopt 04:07:20 INFO - Successfully installed blobuploader requests docopt 04:07:20 INFO - Cleaning up... 04:07:20 INFO - Return code: 0 04:07:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:20 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 0x7f834a3b7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2451a90>, '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 0x24a3f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a42e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:07:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:07:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:07:20 INFO - Using env: {'DISPLAY': ':0', 04:07:20 INFO - 'HOME': '/home/cltbld', 04:07:20 INFO - 'LANG': 'en_US.UTF-8', 04:07:20 INFO - 'LANGUAGE': 'en_US:en', 04:07:20 INFO - 'LOGNAME': 'cltbld', 04:07:20 INFO - 'MAIL': '/var/mail/cltbld', 04:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:20 INFO - 'MOZ_NO_REMOTE': '1', 04:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:20 INFO - 'NO_EM_RESTART': '1', 04:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:20 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:20 INFO - 'SHELL': '/bin/bash', 04:07:20 INFO - 'SHLVL': '1', 04:07:20 INFO - 'TERM': 'linux', 04:07:20 INFO - 'TMOUT': '86400', 04:07:20 INFO - 'USER': 'cltbld', 04:07:20 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 04:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:20 INFO - '_': '/tools/buildbot/bin/python'} 04:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:07:20 INFO - Running setup.py (path:/tmp/pip-aNJ6WT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:07:20 INFO - Running setup.py (path:/tmp/pip-A4XZso-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:07:20 INFO - Running setup.py (path:/tmp/pip-Y2_pzl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:07:20 INFO - Running setup.py (path:/tmp/pip-fg2gMf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:07:20 INFO - Running setup.py (path:/tmp/pip-n5KtvB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:07:20 INFO - Running setup.py (path:/tmp/pip-6P2unY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:07:20 INFO - Running setup.py (path:/tmp/pip-LnA1dJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:07:21 INFO - Running setup.py (path:/tmp/pip-DYtbU8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:07:21 INFO - Running setup.py (path:/tmp/pip-PASxba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:07:21 INFO - Running setup.py (path:/tmp/pip-FKP744-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:07:21 INFO - Running setup.py (path:/tmp/pip-5brVkY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:07:21 INFO - Running setup.py (path:/tmp/pip-kOpnxr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:07:21 INFO - Running setup.py (path:/tmp/pip-abtjP9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:07:21 INFO - Running setup.py (path:/tmp/pip-5CDj8T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:07:21 INFO - Running setup.py (path:/tmp/pip-yjpGrh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:07:21 INFO - Running setup.py (path:/tmp/pip-gEIdgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:07:21 INFO - Running setup.py (path:/tmp/pip-LGrorM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:07:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:07:21 INFO - Running setup.py install for manifestparser 04:07:21 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:07:21 INFO - Running setup.py install for mozcrash 04:07:21 INFO - Running setup.py install for mozdebug 04:07:22 INFO - Running setup.py install for mozdevice 04:07:22 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:07:22 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:07:22 INFO - Running setup.py install for mozfile 04:07:22 INFO - Running setup.py install for mozhttpd 04:07:22 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:07:22 INFO - Running setup.py install for mozinfo 04:07:22 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:07:22 INFO - Running setup.py install for mozInstall 04:07:22 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:07:22 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:07:22 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:07:22 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:07:22 INFO - Running setup.py install for mozleak 04:07:22 INFO - Running setup.py install for mozlog 04:07:22 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:07:22 INFO - Running setup.py install for moznetwork 04:07:22 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:07:22 INFO - Running setup.py install for mozprocess 04:07:22 INFO - Running setup.py install for mozprofile 04:07:23 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:07:23 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:07:23 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:07:23 INFO - Running setup.py install for mozrunner 04:07:23 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:07:23 INFO - Running setup.py install for mozscreenshot 04:07:23 INFO - Running setup.py install for moztest 04:07:23 INFO - Running setup.py install for mozversion 04:07:23 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:07:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:07:23 INFO - Cleaning up... 04:07:23 INFO - Return code: 0 04:07:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:23 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 0x7f834a3b7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2451a90>, '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 0x24a3f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a42e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:07:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:07:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:07:23 INFO - Using env: {'DISPLAY': ':0', 04:07:23 INFO - 'HOME': '/home/cltbld', 04:07:23 INFO - 'LANG': 'en_US.UTF-8', 04:07:23 INFO - 'LANGUAGE': 'en_US:en', 04:07:23 INFO - 'LOGNAME': 'cltbld', 04:07:23 INFO - 'MAIL': '/var/mail/cltbld', 04:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:23 INFO - 'MOZ_NO_REMOTE': '1', 04:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:23 INFO - 'NO_EM_RESTART': '1', 04:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:23 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:23 INFO - 'SHELL': '/bin/bash', 04:07:23 INFO - 'SHLVL': '1', 04:07:23 INFO - 'TERM': 'linux', 04:07:23 INFO - 'TMOUT': '86400', 04:07:23 INFO - 'USER': 'cltbld', 04:07:23 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 04:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:23 INFO - '_': '/tools/buildbot/bin/python'} 04:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:07:23 INFO - Running setup.py (path:/tmp/pip-Ha2miG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:07:23 INFO - Running setup.py (path:/tmp/pip-Mzplpu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:07:23 INFO - Running setup.py (path:/tmp/pip-h0ReYB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:07:23 INFO - Running setup.py (path:/tmp/pip-OEr9G9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:07:24 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)) 04:07:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:07:24 INFO - Running setup.py (path:/tmp/pip-wb6zT8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 04:07:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:07:24 INFO - Running setup.py (path:/tmp/pip-YS5NjZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 04:07:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:07:24 INFO - Running setup.py (path:/tmp/pip-w_HEVa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:07:24 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)) 04:07:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:07:24 INFO - Running setup.py (path:/tmp/pip-SulftC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 04:07:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:07:24 INFO - Running setup.py (path:/tmp/pip-uiFeeX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 04:07:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:07:24 INFO - Running setup.py (path:/tmp/pip-11MdkY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:07:24 INFO - Running setup.py (path:/tmp/pip-78tYOT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:07:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:07:24 INFO - Running setup.py (path:/tmp/pip-3JulzF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:07:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:07:24 INFO - Running setup.py (path:/tmp/pip-rObhPZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 04:07:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:07:24 INFO - Running setup.py (path:/tmp/pip-Sw_WQF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:07:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:07:24 INFO - Running setup.py (path:/tmp/pip-j6085j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:07:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:07:24 INFO - Running setup.py (path:/tmp/pip-Xhf3Vq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:07:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:07:24 INFO - Running setup.py (path:/tmp/pip-PzbuR6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:07:24 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)) 04:07:24 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)) 04:07:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:26 INFO - Downloading blessings-1.5.1.tar.gz 04:07:26 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:07:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:26 INFO - Installing collected packages: blessings 04:07:26 INFO - Running setup.py install for blessings 04:07:26 INFO - Successfully installed blessings 04:07:26 INFO - Cleaning up... 04:07:26 INFO - Return code: 0 04:07:26 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:07:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:07:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:07:27 INFO - Reading from file tmpfile_stdout 04:07:27 INFO - Current package versions: 04:07:27 INFO - argparse == 1.2.1 04:07:27 INFO - blessings == 1.5.1 04:07:27 INFO - blobuploader == 1.2.4 04:07:27 INFO - docopt == 0.6.1 04:07:27 INFO - manifestparser == 1.1 04:07:27 INFO - mozInstall == 1.12 04:07:27 INFO - mozcrash == 0.16 04:07:27 INFO - mozdebug == 0.1 04:07:27 INFO - mozdevice == 0.47 04:07:27 INFO - mozfile == 1.2 04:07:27 INFO - mozhttpd == 0.7 04:07:27 INFO - mozinfo == 0.9 04:07:27 INFO - mozleak == 0.1 04:07:27 INFO - mozlog == 3.0 04:07:27 INFO - moznetwork == 0.27 04:07:27 INFO - mozprocess == 0.22 04:07:27 INFO - mozprofile == 0.27 04:07:27 INFO - mozrunner == 6.11 04:07:27 INFO - mozscreenshot == 0.1 04:07:27 INFO - mozsystemmonitor == 0.0 04:07:27 INFO - moztest == 0.7 04:07:27 INFO - mozversion == 1.4 04:07:27 INFO - psutil == 3.1.1 04:07:27 INFO - requests == 1.2.3 04:07:27 INFO - wsgiref == 0.1.2 04:07:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:27 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 0x7f834a3b7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241b6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2451a90>, '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 0x24a3f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a42e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:07:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 04:07:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:07:27 INFO - Using env: {'DISPLAY': ':0', 04:07:27 INFO - 'HOME': '/home/cltbld', 04:07:27 INFO - 'LANG': 'en_US.UTF-8', 04:07:27 INFO - 'LANGUAGE': 'en_US:en', 04:07:27 INFO - 'LOGNAME': 'cltbld', 04:07:27 INFO - 'MAIL': '/var/mail/cltbld', 04:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:27 INFO - 'MOZ_NO_REMOTE': '1', 04:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:27 INFO - 'NO_EM_RESTART': '1', 04:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:27 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:27 INFO - 'SHELL': '/bin/bash', 04:07:27 INFO - 'SHLVL': '1', 04:07:27 INFO - 'TERM': 'linux', 04:07:27 INFO - 'TMOUT': '86400', 04:07:27 INFO - 'USER': 'cltbld', 04:07:27 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 04:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:27 INFO - '_': '/tools/buildbot/bin/python'} 04:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 04:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 04:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 04:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 04:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 04:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:07:27 INFO - Cleaning up... 04:07:27 INFO - Return code: 0 04:07:27 INFO - Running post-action listener: _resource_record_post_action 04:07:27 INFO - Running post-action listener: _start_resource_monitoring 04:07:27 INFO - Starting resource monitoring. 04:07:27 INFO - ##### 04:07:27 INFO - ##### Running install step. 04:07:27 INFO - ##### 04:07:27 INFO - Running pre-action listener: _resource_record_pre_action 04:07:27 INFO - Running main action method: install 04:07:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:07:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:07:27 INFO - Reading from file tmpfile_stdout 04:07:27 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:07:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:07:27 INFO - Reading from file tmpfile_stdout 04:07:27 INFO - Output received: 04:07:27 INFO - Usage: mozinstall [options] installer 04:07:27 INFO - Options: 04:07:27 INFO - -h, --help show this help message and exit 04:07:27 INFO - -d DEST, --destination=DEST 04:07:27 INFO - Directory to install application into. [default: 04:07:27 INFO - "/builds/slave/test-pgo"] 04:07:27 INFO - --app=APP Application being installed. [default: firefox] 04:07:27 INFO - mkdir: /builds/slave/test-pgo/build/application 04:07:27 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'] 04:07:27 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 04:07:42 INFO - Reading from file tmpfile_stdout 04:07:42 INFO - Output received: 04:07:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:07:42 INFO - Running post-action listener: _resource_record_post_action 04:07:42 INFO - ##### 04:07:42 INFO - ##### Running run-tests step. 04:07:42 INFO - ##### 04:07:42 INFO - Running pre-action listener: _resource_record_pre_action 04:07:42 INFO - Running main action method: run_tests 04:07:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:07:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:07:42 INFO - Python 2.7.3 04:07:42 INFO - Return code: 0 04:07:42 INFO - grabbing minidump binary from tooltool 04:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:42 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 0x2451a90>, '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 0x24a3f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a42e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:07:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:07:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:07:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:42 INFO - Return code: 0 04:07:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:07:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:07:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:07:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:07:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:07:42 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/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:07:42 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/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost 04:07:42 INFO - Using env: {'DISPLAY': ':0', 04:07:42 INFO - 'HOME': '/home/cltbld', 04:07:42 INFO - 'LANG': 'en_US.UTF-8', 04:07:42 INFO - 'LANGUAGE': 'en_US:en', 04:07:42 INFO - 'LOGNAME': 'cltbld', 04:07:42 INFO - 'MAIL': '/var/mail/cltbld', 04:07:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:07:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:42 INFO - 'MOZ_NO_REMOTE': '1', 04:07:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:42 INFO - 'NO_EM_RESTART': '1', 04:07:42 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:42 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:42 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:07:42 INFO - 'SHELL': '/bin/bash', 04:07:42 INFO - 'SHLVL': '1', 04:07:42 INFO - 'TERM': 'linux', 04:07:42 INFO - 'TMOUT': '86400', 04:07:42 INFO - 'USER': 'cltbld', 04:07:42 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736', 04:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:42 INFO - '_': '/tools/buildbot/bin/python'} 04:07:42 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/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost'] with output_timeout 3600 04:07:42 INFO - mozversion INFO | application_buildid: 20151121023041 04:07:42 INFO - mozversion INFO | application_changeset: 489332006384610e3322739f66729448da0e98d9 04:07:42 INFO - mozversion INFO | application_display_name: Nightly 04:07:42 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:42 INFO - mozversion INFO | application_name: Firefox 04:07:42 INFO - mozversion INFO | application_remotingname: firefox 04:07:42 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:07:42 INFO - mozversion INFO | application_vendor: Mozilla 04:07:42 INFO - mozversion INFO | application_version: 45.0a1 04:07:42 INFO - mozversion INFO | platform_buildid: 20151121023041 04:07:42 INFO - mozversion INFO | platform_changeset: 489332006384610e3322739f66729448da0e98d9 04:07:42 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:07:42 INFO - mozversion INFO | platform_version: 45.0a1 04:07:42 INFO - 2015-11-21 04:07:42,323 DEBUG : using testdate: 1448107662 04:07:42 INFO - 2015-11-21 04:07:42,323 DEBUG : actual date: 1448107662 04:07:42 INFO - 2015-11-21 04:07:42,371 INFO : starting webserver on 'localhost:37757' 04:07:42 INFO - 2015-11-21 04:07:42,372 INFO : Starting test suite talos-linux64-ix-046 04:07:42 INFO - 2015-11-21 04:07:42,372 INFO : Starting test dromaeo_css 04:07:42 INFO - 2015-11-21 04:07:42,372 DEBUG : operating with platform_type : linux_ 04:07:42 INFO - 2015-11-21 04:07:42,373 INFO : Initialising browser for dromaeo_css test... 04:07:42 INFO - 2015-11-21 04:07:42,389 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5Ay5O5/profile http://localhost:37757/getInfo.html 04:07:45 INFO - 2015-11-21 04:07:45,943 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:07:45 INFO - 2015-11-21 04:07:45,943 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:07:45 INFO - 2015-11-21 04:07:45,943 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:07:45 INFO - 2015-11-21 04:07:45,943 DEBUG : BROWSER_OUTPUT: __metrics 04:07:46 INFO - 2015-11-21 04:07:46,088 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:07:47 INFO - 2015-11-21 04:07:47,362 INFO : Browser initialized. 04:07:47 INFO - 2015-11-21 04:07:47,362 INFO : Running cycle 1/1 for dromaeo_css test... 04:07:47 INFO - 2015-11-21 04:07:47,362 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5Ay5O5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:07:59 INFO - 2015-11-21 04:07:59,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 142761984 04:07:59 INFO - 2015-11-21 04:07:59,137 DEBUG : BROWSER_OUTPUT: 04:08:50 INFO - 2015-11-21 04:08:50,686 DEBUG : BROWSER_OUTPUT: 1448107730682 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:10:59 INFO - 2015-11-21 04:10:59,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37757/tests/dromaeo/cssquery-ext.html) 04:11:00 INFO - 2015-11-21 04:11:00,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 272592896 04:11:00 INFO - 2015-11-21 04:11:00,477 DEBUG : BROWSER_OUTPUT: 04:14:02 INFO - 2015-11-21 04:14:02,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/dromaeo/cssquery-ext.html (next: http://localhost:37757/tests/dromaeo/cssquery-jquery.html) 04:14:03 INFO - 2015-11-21 04:14:03,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 219389952 04:14:03 INFO - 2015-11-21 04:14:03,571 DEBUG : BROWSER_OUTPUT: 04:17:05 INFO - 2015-11-21 04:17:05,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37757/tests/dromaeo/cssquery-mootools.html) 04:17:06 INFO - 2015-11-21 04:17:06,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 206110720 04:17:06 INFO - 2015-11-21 04:17:06,045 DEBUG : BROWSER_OUTPUT: 04:20:07 INFO - 2015-11-21 04:20:07,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37757/tests/dromaeo/cssquery-prototype.html) 04:20:08 INFO - 2015-11-21 04:20:08,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 201396224 04:20:08 INFO - 2015-11-21 04:20:08,400 DEBUG : BROWSER_OUTPUT: 04:23:10 INFO - 2015-11-21 04:23:10,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37757/tests/dromaeo/cssquery-yui.html) 04:23:11 INFO - 2015-11-21 04:23:11,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 188211200 04:23:11 INFO - 2015-11-21 04:23:11,495 DEBUG : BROWSER_OUTPUT: 04:26:14 INFO - 2015-11-21 04:26:14,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/dromaeo/cssquery-yui.html (next: http://localhost:37757/tests/dromaeo/cssquery-dojo.html) 04:26:14 INFO - 2015-11-21 04:26:14,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 276602880 04:26:14 INFO - 2015-11-21 04:26:14,265 DEBUG : BROWSER_OUTPUT: 04:26:14 INFO - 2015-11-21 04:26:14,266 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:26:14 INFO - 2015-11-21 04:26:14,266 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:26:14 INFO - 2015-11-21 04:26:14,266 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:26:14 INFO - 2015-11-21 04:26:14,266 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:26:14 INFO - 2015-11-21 04:26:14,266 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3163.367326534693;3215.614126304844;3223.5325877747728;3232.1757951722307;3258;5249.658772179815;5374.865628359293;5397.973010134953;5460.453954604538;5521.25463062487;5359.812406565771;5417.079096553595;5443.265159203506;5525.640833345829;5546.91679624806;4954.504549545044;4971.45314015458;4992.026554821811;4999;5077.619178561604;5078.162103252977;5087.79648814047;5117.309163262968;5151.150060240056;5163.612729045318;4809.879753006167;4883.9511604883855;4926.950730492703;5014.5737612303;5052.949470505321;4978.054169707744;4982.028504441635;4991.725455099968;4992.625553083497;5029.220470827027;4933.260010998343;4973.42805577356;4982.153033984195;4983.825566105169;5031.119554078058;5136.922946155811;5154.020736060136;5212.687238765686;5229.294045303874;5250;5896.115582662592;5918.763249470016;5921.437463440966;5927.436893495111;5929.169916211734;5780.988327042751;5984.222051133368;6008.6094403864045;6013.428724271187;6018.2778066631845;5404.162354835007;5480.451954804487;5499.890002199973;5516.310461192351;5532.004239236895;6032.668203248776;6039.818805435844;6065.939340606537;6121.908171377433;6122.2959359674205;5461.726913654302;5903.527717782567;5905.7932972346625;5911.083782013795;5920.4967577755515;5765.250517432707;5770.682612456355;5857.824265272048;5862.413758624103;5916.940830591639;5906.468417842329;5914.645121292736;5916.437938395846;5942.227510423617;5946.940530594725;5632.239647647597;5743.396943320975;5952.136940143655;5956.76172953077;5957;4483.237849565582;4498.235299999008;4508.301213311942;4517.525659805673;4523.5250298718165;3998.300297447935;4030.334994725896;4043.7169398141846;4074.5517993020744;4086.652634526039;5344.465553444625;5566.888662226814;5586.804461843816;5590;5594.104943209149;5697.857553561194;5769.249997500298;5787.479126878601;5809.128630705343;5865;5479.479449452296;5480;5481.75332110056;5482.890342193134;5486.506214440719;4871.610271178368;5053.242013697901;5072.137736584789;5089.185730283211;5137.255098010843;5955.642661440327;6042.335343112254;6044.274687037584;6051.3041000283765;6086.056661217518;5895.793647222326;5926.051831707078;5931.6441013539325;5957.314908785545;5962.55280853929;5808.244928159313;5934.465898069195;6120.510359171345;6133.3866613338305;6138.9386106140155;5633.295838020247;5812.18629391877;5889.49939255151;5922.1412895130825;5972.313183983723;5867.178594996789;5912.142739302691;5918.141869428995;5924.7926322578505;5941.405859414197;5527.198556209247;5576.275084239023;5805.564582656233;5813.505852002627;5815.41845815415;5673.858153546029;5765.336986246635;5772.19189313488;5782.479576837936;5821.825345239649;5530.419305972815;5533.667979921218;5534.1975413565615;5543.3902270751;5545.334559852843;5626.35296940857;5647.689377084135;5700.230468886647;5726.885462290814;5789.450002249948;5567.972160139173;5662.631928924607;5664.631798933221;5682.261306030189;5695.886082278248 04:26:14 INFO - 2015-11-21 04:26:14,266 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.4112352591542;611.251217258858;614.2444792904727;614.8708771158057;616.340515648256;30906.69093309069;31387.686123138792;31395.529067064013;31408.214794630116;39605.20789584207;42257.57742422583;42527.3620895686;42611;42719;42746.35880461796;8630.784230394227;8715.694950676727;8787.824243515157;8793;8801.339899507531;7733.883991740128;7953.761387158394;8539;10281.383117012965;10651.041406273434;10380.221483388737;10474;10476.633317833877;10476.790464190712;10482.213833962445;7836.568988705619;10374.740631484236;10386.740331491774;10443.79112417755;10487.213458990605;7706;10328.380297182193;10713.839292410543;10719.249652524326;10721.249512534127;38331.61668383336;39068.21863562741;39111;39117.217655647015;39165.41251881224;3222.8066316021113;3477.982610086933;3732.6267373262726;3836.2135762168687;4007.499062617173;28780.136595902157;28933;29762.851185743933;29813.10560683183;30196.396072078656;3939.625735555118;4065.6340929316502;4096.651784598313;4102.753834769894;4107.322291821846;256243;257316;258079.9999999981;258188;258814;55964.24303934211;58340.708296458244;59537;59894;64911;60134.69932650309;60697.39302606917;60723.392766071775;60793.39206607877;60838.695806520685;13074.215547067206;13227.404766785517;13246.801297980537;13302.068855180045;13316.267605281802;9909.603615855285;9910.058544438267;9911.752206194902;9912.306138570231;9912.55393507294;19707.704384434244;19946.902920339522;20083.497912552302;20126.89936550308;20193.394198173784;7790.05248687828;7969.561674107864;7996.24035716606;8013.19868013194;8122.55325957078;883.4478450968145;935.6304259817334;950.9619615215314;1048.3290693955873;1122.2144498850837;28302.433951320858;28334.69529257328;28523.286917826805;28601.427971440455;28902.855485722437;962.6775030364767;966.1980556138388;1006.864073350103;1008.6469735592484;1125.2348403085816;14584.85415145835;14685.118892866461;14737;14884.553463396116;14946;364047;367343;368128;368622;369779;51327.743361283705;51431.48568514267;51938.48061519412;51992;52054;1234.4876876096498;1237.1587320622064;1249.6063739921894;1271.0721173543366;1275.5599318235195;26318.21045368642;27318.31704207331;27335.316617084733;27425.31436714098;27687;41203.58796411997;42100.789496052326;43951;44553;46889.53110468852;202278;203150;203335;203409;206891;27336.589951150352;27906.441871162868;30082.69917300799;30424.695753042186;30435.391292174474;44844.32733508935;45049.91826103434;45321.77339113415;45350.54649453463;45790;34130.317393651494;34220.14449638779;34275.82862085674;41989.37015944702;42817.487165201324;37380.626193738804;37781;37943.94011785263;38038;38581.614183857804;36461.45307820332;37191.442128367555;37300;37479.81260093682;37481.2503749918;31859.20351991219;33697;34219.65780342164;34266.82866585651;34578.135546611535;25687.871560642823;25918.35204119912;26054.609180861924;26056.73943260619;26327.68643496934 04:26:14 INFO - 2015-11-21 04:26:14,266 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.58805903063893;358.9479525468807;361.6058496239099;362.99092522686936;364.3332701156883;13856.792148117785;14001;16106.516804495855;16705;17598.648027039453;15039.548813535612;16229.350825966976;16272.75590866135;16335.59161020975;17279.74080388795;5197.376314842224;5326;5326.5472434842895;5327.200919862033;5332.57339412848;3948.387999860012;4026.436298918139;5318.095923692981;5352.090144675414;5802.535797136219;5894.440028197314;5919.052951527757;5922.822315330525;5937.37657545958;5940.910886336708;5747.626404283729;5871.677057761822;5876.29484461863;5876.882462350772;5902.822915312548;5143.897122057575;5162.612804039674;5178.844634660966;5182.481751824825;5184.092783762864;18739.53151171218;20473;20791.58416831655;20793.16827326905;20809.791902081088;1951.8243358097839;2028.1785876719953;2035.1350675962656;2076.1176499987596;2202.438378213545;12432.316222607753;12520;13068.738625227443;13110.213387196798;13475.663108422368;1557.9688406231926;1563.7185306644799;1563.9609009774733;1588.904665720049;1611.790467239263;56566;59635.403645963415;59856.700716496576;60484.39515604832;60856.39143608551;9400.435973841591;9486.288528360263;9540.284478664127;9586.760330991781;9623.518824058769;12454.81317780234;12525.185862918881;12595;12603.369831508571;12616.747665046647;6825.317468253135;6866.725330986805;6896.137982752156;7055.576665400093;7107.289271072851;6518.967405162944;6593.307702691244;6666.933330666729;6741.662916854138;6752;5783.421657834183;5848.912266316009;5873.618214816109;5894.734736936848;5913.704314784243;1581.541353007638;1596.1380854338759;1667.1914121650989;1667.5414261078058;1771.8582513398896;399.22749479756766;400.6554363247605;841.427829076234;981.8625392445064;1013.9239557033252;10250.282480226462;10412.271141020208;10545.367277963347;10672.30630009047;10784.352938823538;412.43908284732737;419.76493163828354;425.7977460706202;426.100927043937;426.65440992795936;5556.611037227436;5813.767449302065;5878.764849406061;9535.952320238355;9987.450690211963;497263;501137;502009.4296699598;506814;507171;77620.61189694016;79611.20388796154;80313.19686803174;80390.59804701056;81883.5905820467;1098.0501865885951;1104.5968221599057;1112.1714322829382;1128.1313388690662;1129.4409267412684;14734.042287251294;14825.92587037058;15039.323230454436;15050.69898602;15235.619109522351;32353;32789.18027049343;33233.941173825704;35333;36041;44486.663500236966;44801.32798007967;47374.52625473839;47459.52540474551;47896.28155577739;9156.587953541974;9455.763605909631;9495.43027418357;10009.799804003733;10010.549525271235;16723.163841807618;17039.40362087321;17362.47912562625;17537.824621753618;17562.38531651437;9952.302557955498;13935.790963135358;14399.78400323975;14604.269786510844;15199.392024318904;13998.300084995506;14134.858651413766;14785.556433307018;14855;14884.925575372054;14590.854091459374;14807.629809254855;15252.923735381251;15370.23148842531;15502.83728720328;9265.86101208469;9457.810843782949;9501.239900808057;9875.061869122423;9890.258230632588;14472.34874430632;14494.347754350869;14755.926220368829;14899.255037248311;15085.24573771285 04:26:14 INFO - 2015-11-21 04:26:14,266 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1326.5158217250707;1671.3147609480116;1704.7442883567464;1734.4103004978308;1735.600811813283;6876.209235937862;7431.071116110486;7553.773386798405;7559.130699969505;7565.697372105123;7735.38116950644;7852.646630901609;7921.20787921209;7924.80187995299;7932.008498937633;1970.8817470951717;2010.2059686423854;2295.5294164696197;2322.5471033148583;2347.6713260143592;2345.2260753951155;2351.8471299365574;2352.9176478823247;2355.1286024170995;2356.175338631482;2242.4169715873827;2297.517521320525;2299.5056062946464;2300.7584203658625;2304.3087073877855;1956.3739603326942;2004.0681083296338;2266.172846910874;2317.582835089683;2317.8841057947034;2285.6971526230054;2304.1129165271323;2320.8607483550873;2334.568104900599;2335.9649605255936;7859.449838511307;7885.369170466406;7904.683812647487;7910.169432209593;7912.208779122099;4709.481956984729;4777.689450185727;4779.450363208241;4796.664233503656;4815.927761083586;3119.142235885127;3137.921551961196;3140.9685903140903;3189.9043028709175;3216.163797412666;1001.2640709078821;1004.45257334752;1007.5113569918584;1037.2169012395593;1039.6049501189575;11170.664880053611;11187.496562654618;11251;11251.943740281245;11264.887351126466;4270.957290427118;4328.069465065026;4364.388985542027;4451.732896026248;4456.487503937024;9558.665446709332;9569.282303827102;9571.28215383849;9593.520323983774;9602.90397096034;4913.459519452857;4914.827981020647;4916;4920.458749537548;4926.531979461945;4431.490378606437;4477.597016268552;4483.327500874895;4489.034857505652;4489.506154323022;3652.7808331500196;3714.665680088805;3730.6642402183934;3733.9439908401396;3759.3233218020473;1200.5557943560939;1203.4764877278237;1208.4924331780674;1210.2073142091945;1213.1811027556541;943.8395472769646;1025.2105878473533;1042.6976176908763;1045.3309881675734;1103.0403548912498;7312.049433573601;7340.559566426032;7387.224341444178;7426.4430167736555;7428.4428667850125;1076.235872530512;1090.4166271044953;1092.847001419802;1093;1098.8516550265772;5644.858878527987;5730.627509211888;5750.539956803445;5774.335951365647;5783.971080144573;9216.400933939272;9393.57728902201;9637.469939153414;9641.517924103768;9652.22782177424;9701.563429645683;9701.854472182782;9713.417194968324;9732.270079743907;9740.172085372822;7308.780736577911;7399;7477.102747670315;7488.176300606929;7500.137484189279;7143.9285607143265;7170.677319520739;7171.103612048494;7181.317774811385;7189.928100719135;8221.712240071807;8434.072252052392;8436.831263374821;8595.699150529701;8622.26710729595;8693.32540508409;8805.955970220108;8832.735017949472;8842.46945183291;8854.778630534289;6826.385625293548;6947.79156625302;6959.478039146983;6963.338482844122;6964.930350696428;7739.458237923516;7785.493942893694;7794.88307675374;7795.376369890509;7802.960985195038;6876.449884009167;6965.895511567432;7107.538010029331;7228.96385518069;7275.890861636974;6986.510944233854;7084.964575177298;7145.7498987537265;7163.247858974941;7228.89156662661;7151.642417879189;7190.173130089897;7195.820104497429;7198.100237470317;7202.927970720226;6625.238097618835;6647.302033286435;6659.600423974577;6660.300668429745;6667.799966001027;6648.7340506379205;6766.492513061442;6767.695453704497;6771.89842152378;6775.830604234933 04:26:14 INFO - 2015-11-21 04:26:14,266 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.6100757076366;321.88412171618216;324.46301371230606;325.1562196101117;330.4877439968049;5984.82045538634;6012.398760123985;6051.183090282811;6069.848253793657;6079.513638908893;5741.397153298906;5836.766529338832;5902.114682797583;5967.731452084656;5998.4901283390855;4572.314152877062;4581;4589.495155532905;4594.173048851206;4599.333096700976;4379.167958087969;4523;4555.817767289304;4581.908361832761;4592.196365636017;4388.429504164455;4425.336199570074;4476.306172543261;4506.662000349987;4515.864524064284;4458.108378324316;4473.463184417858;4484.080763443486;4485.192665320241;4496.213162696531;3920.862769803072;3923.019245188703;3927.8036098194975;3928.8428462861452;3938.940915886264;5558.110702287655;5666.121751128581;5668.489835914746;5669.092945128759;5672.120821272668;5311.176767601028;5318.680879147263;5323.787048518055;5325.360956685184;5326.174442961347;6350.079238510436;6352.396522330371;6359.268684101341;6373.171487706569;6378.808635740936;4410.514843367227;4416.690831641787;4419.049904270565;4421.646268298528;4440.267355886275;6475.870482590369;6636.634985075819;6637.800865974028;6644.43522300605;6648.534602577822;4520.570545798144;4537.047220083753;4537.8184872604725;4537.931931021038;4546.772661366918;4577.771111444415;4580.290055041474;4584.083183363341;4584.312353147055;4586.105709386704;5297.231901374356;5297.390800057966;5307.230451584499;5308;5314.043472175045;6271.216097987752;6404.231492220963;6419.037144428373;6427.003814408774;6438.742450302029;1574.6378332983477;1597.9920100399424;1599.1684324151377;1599.9680006399806;1600.0559669794877;1032.1897310611284;1052.6210564196883;1055.6674647486018;1056.5087234436023;1076.9983914959164;6219.564630475823;6221.3156552779155;6228.56400051992;6234.5635805494085;6241.875162496815;6639.3692599203;6651.933480665131;6662.866742665216;6676.26561078281;6679;6029.186059881948;6029.517638588903;6074.42292982166;6171;6205.81382558524;3565.3760591896316;3611.620779818134;3648.21563363878;3653.050206946213;3660.9633903661156;6947.652617369213;6959.478039147084;6960.338767817049;6978.685959131852;6979.127609048869;6756.189257289157;6879.965600172067;6890.827729306808;6892.241853396123;6893.345132212432;6955.582665040012;6958.721651133898;6958.7912362628185;6973.163220413583;6995.475339349569;6683.699233534406;6700.128983232149;6709.194896612437;6712.83217919556;6727.899081513683;6583.177102862142;6624.304448032887;6679.265280819009;6679.265280819203;6685.231198412051;6990.056342393712;6990.300969903173;6994.510384273256;7001.789946301619;7006.299370062953;4416.205083085076;4421.624161946142;4421.646268298464;4423.469183697976;4428.2029234736765;6568.080468734285;6682.866342673022;6690.29751876046;6690.330966903271;6703.262641109572;6541.738330466728;6543.214814222324;6552.6723663815665;6553.2136143663065;6555.704993275219;6526.24948130971;6526.9347306528225;6528.934710652833;6535.673216339259;6539.313372095861;6229.159063526366;6355.809325720235;6357.650329231937;6368.363163683594;6372.681365931778;6300.621962682254;6408.871822563616;6423.935760642334;6537.640429776408;6570.244421891352;6383;6414.262359828493;6419.775307864203;6425.871482570229;6426.775062872777 04:26:14 INFO - 2015-11-21 04:26:14,267 DEBUG : BROWSER_OUTPUT: |5;yui.html;776.9899131129537;828.709951516969;835.4820011592814;845.9746207613766;857.3184318466816;12707.174033687805;12986.28575428351;12991.2205267684;13008.024398170139;13038.93480532596;11633.243839150471;11731.941340293286;11742.706432339175;11745.236559623618;11758.41207939604;795.8726603743388;801.4950581133907;814.4665244265016;814.6497006287294;815.1848151848152;669.9531032827704;677.5832862789374;806.9072056713494;813.4793732011517;814.0882211922625;831.501099340397;840.4789030800912;845.8308338332358;845.9619317130744;846.2975730143966;834.8747687846841;835.4903508859621;835.5655059369094;836.5148214035845;836.523181786382;512.9743512824381;516.6099594805897;612.6079309242089;619.1486705779553;621.0528943361364;12320.81518777219;12385.071119666061;12386.442610082478;12464.189827661263;12509.74980500394;11798.88201117995;12130.454129564103;12138.271703697717;12209.511619535208;12222.877771222264;9141;9153.81692366149;9162.221211197057;9184.540772961325;9257.305702072304;3520;3571.6428357164336;3646.3436581415335;3655.908602284964;3660.359437098497;49676;49841.50158498405;50758.99999999963;50761.74619126918;50971.49028509705;9311.208547273422;9622.422654640604;9736.318457707892;9958.402495850272;9969.451680157661;17783.377581784574;17846.643067138586;17856.821431785775;17864.196111175028;17867.910660446876;7412.295831895961;7522.962385188039;7599.316061554487;7667.769966901002;7766.961165194138;4006.9198616027516;4100.712950093524;4106.2198182345255;4158.750474971512;4176.352665336878;3017;3019.531972544259;3029.66673665901;3031.651360093573;3037.0433313506173;527.1960260602611;539.4874868874584;548.2516365161606;567.0869899461863;567.4835899331589;535.884784771276;565.2679779685317;607.8115784106941;609.1228630771675;667.5961043568668;7904.525728456311;8187.263146316741;8710.651573937099;9450.243980481546;9584.952075239578;648.251269783401;683.7094234950126;687.1547995964892;701.6737217194029;750.8423231121526;3760.4547340635454;3839.3665045267776;3975.4036894465485;4009.7794621296107;4069.348904175318;60247;61025.69487152625;61427.6928615363;61527.384726152166;61565;52509;52669;52693.209601856004;52851.20723189155;52965.2055219172;47087.76456117766;49482.752586237555;49556.25665615091;49730.751346243764;49928;7864;7907.9604601976625;7964.681412743425;8074.878876816735;8162.959185204273;32302.515462267616;32520.34959300848;33353;33633.327333452704;33695.663043369255;42226.788866055475;42283;46341.30488042615;47528.762356187995;47673.04653906972;9768.413895166314;9847.753806154904;9915.107640312406;10077.647282345082;10186.210266997748;10028.799424011624;10045.547950342398;10150.441725705157;11333.603323883624;11713.596620444088;9049.230815380766;9222.631094756134;9256.07439256069;9284.071592840663;9554.092361225672;9873.95063024709;10001.499925003574;10207.387556746618;10493.9475302623;10559.894401055892;8578.4424012439;8801.91198088011;8921.866172007554;9039.96040455356;9140.817183656423;8535.701250456204;8800.339974502065;8832.109545544852;8954.417962832395;8960.283177345666;8096.230858068474;8532.146785321418;8606.483610983361;8622.094680058504;8628.322976433878 04:26:14 INFO - 2015-11-21 04:26:14,267 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:26:14 INFO - 2015-11-21 04:26:14,268 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:26:14 INFO - 2015-11-21 04:26:14,268 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1007 04:26:14 INFO - 2015-11-21 04:26:14,268 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:26:14 INFO - 2015-11-21 04:26:14,268 DEBUG : BROWSER_OUTPUT: __startTimestamp1448108774258__endTimestamp 04:26:14 INFO - 2015-11-21 04:26:14,268 DEBUG : BROWSER_OUTPUT: 04:26:14 INFO - 2015-11-21 04:26:14,268 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:26:14 INFO - 2015-11-21 04:26:14,268 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:26:14 INFO - 2015-11-21 04:26:14,268 DEBUG : BROWSER_OUTPUT: 04:26:14 INFO - 2015-11-21 04:26:14,268 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5445.36 Median:5590.00 stddev:616.61 (11.0%) stddev-sans-first:591.94 04:26:14 INFO - 2015-11-21 04:26:14,268 DEBUG : BROWSER_OUTPUT: Values: 3163.4 3215.6 3223.5 3232.2 3258.0 5249.7 5374.9 5398.0 5460.5 5521.3 5359.8 5417.1 5443.3 5525.6 5546.9 4954.5 4971.5 4992.0 4999.0 5077.6 5078.2 5087.8 5117.3 5151.2 5163.6 4809.9 4884.0 4927.0 5014.6 5052.9 4978.1 4982.0 4991.7 4992.6 5029.2 4933.3 4973.4 4982.2 4983.8 5031.1 5136.9 5154.0 5212.7 5229.3 5250.0 5896.1 5918.8 5921.4 5927.4 5929.2 5781.0 5984.2 6008.6 6013.4 6018.3 5404.2 5480.5 5499.9 5516.3 5532.0 6032.7 6039.8 6065.9 6121.9 6122.3 5461.7 5903.5 5905.8 5911.1 5920.5 5765.3 5770.7 5857.8 5862.4 5916.9 5906.5 5914.6 5916.4 5942.2 5946.9 5632.2 5743.4 5952.1 5956.8 5957.0 4483.2 4498.2 4508.3 4517.5 4523.5 3998.3 4030.3 4043.7 4074.6 4086.7 5344.5 5566.9 5586.8 5590.0 5594.1 5697.9 5769.2 5787.5 5809.1 5865.0 5479.5 5480.0 5481.8 5482.9 5486.5 4871.6 5053.2 5072.1 5089.2 5137.3 5955.6 6042.3 6044.3 6051.3 6086.1 5895.8 5926.1 5931.6 5957.3 5962.6 5808.2 5934.5 6120.5 6133.4 6138.9 5633.3 5812.2 5889.5 5922.1 5972.3 5867.2 5912.1 5918.1 5924.8 5941.4 5527.2 5576.3 5805.6 5813.5 5815.4 5673.9 5765.3 5772.2 5782.5 5821.8 5530.4 5533.7 5534.2 5543.4 5545.3 5626.4 5647.7 5700.2 5726.9 5789.5 5568.0 5662.6 5664.6 5682.3 5695.9 04:26:14 INFO - 2015-11-21 04:26:14,268 DEBUG : BROWSER_OUTPUT: 04:26:14 INFO - 2015-11-21 04:26:14,268 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44922.59 Median:201902.23 stddev:74662.02 (37.0%) stddev-sans-first:74797.17 04:26:14 INFO - 2015-11-21 04:26:14,268 DEBUG : BROWSER_OUTPUT: Values: 563.4 611.3 614.2 614.9 616.3 30906.7 31387.7 31395.5 31408.2 39605.2 42257.6 42527.4 42611.0 42719.0 42746.4 8630.8 8715.7 8787.8 8793.0 8801.3 7733.9 7953.8 8539.0 10281.4 10651.0 10380.2 10474.0 10476.6 10476.8 10482.2 7836.6 10374.7 10386.7 10443.8 10487.2 7706.0 10328.4 10713.8 10719.2 10721.2 38331.6 39068.2 39111.0 39117.2 39165.4 3222.8 3478.0 3732.6 3836.2 4007.5 28780.1 28933.0 29762.9 29813.1 30196.4 3939.6 4065.6 4096.7 4102.8 4107.3 256243.0 257316.0 258080.0 258188.0 258814.0 55964.2 58340.7 59537.0 59894.0 64911.0 60134.7 60697.4 60723.4 60793.4 60838.7 13074.2 13227.4 13246.8 13302.1 13316.3 9909.6 9910.1 9911.8 9912.3 9912.6 19707.7 19946.9 20083.5 20126.9 20193.4 7790.1 7969.6 7996.2 8013.2 8122.6 883.4 935.6 951.0 1048.3 1122.2 28302.4 28334.7 28523.3 28601.4 28902.9 962.7 966.2 1006.9 1008.6 1125.2 14584.9 14685.1 14737.0 14884.6 14946.0 364047.0 367343.0 368128.0 368622.0 369779.0 51327.7 51431.5 51938.5 51992.0 52054.0 1234.5 1237.2 1249.6 1271.1 1275.6 26318.2 27318.3 27335.3 27425.3 27687.0 41203.6 42100.8 43951.0 44553.0 46889.5 202278.0 203150.0 203335.0 203409.0 206891.0 27336.6 27906.4 30082.7 30424.7 30435.4 44844.3 45049.9 45321.8 45350.5 45790.0 34130.3 34220.1 34275.8 41989.4 42817.5 37380.6 37781.0 37943.9 38038.0 38581.6 36461.5 37191.4 37300.0 37479.8 37481.3 31859.2 33697.0 34219.7 34266.8 34578.1 25687.9 25918.4 26054.6 26056.7 26327.7 04:26:14 INFO - 2015-11-21 04:26:14,269 DEBUG : BROWSER_OUTPUT: 04:26:14 INFO - 2015-11-21 04:26:14,269 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27548.45 Median:363.66 stddev:82247.73 (22616.5%) stddev-sans-first:82453.11 04:26:14 INFO - 2015-11-21 04:26:14,270 DEBUG : BROWSER_OUTPUT: Values: 350.6 358.9 361.6 363.0 364.3 13856.8 14001.0 16106.5 16705.0 17598.6 15039.5 16229.4 16272.8 16335.6 17279.7 5197.4 5326.0 5326.5 5327.2 5332.6 3948.4 4026.4 5318.1 5352.1 5802.5 5894.4 5919.1 5922.8 5937.4 5940.9 5747.6 5871.7 5876.3 5876.9 5902.8 5143.9 5162.6 5178.8 5182.5 5184.1 18739.5 20473.0 20791.6 20793.2 20809.8 1951.8 2028.2 2035.1 2076.1 2202.4 12432.3 12520.0 13068.7 13110.2 13475.7 1558.0 1563.7 1564.0 1588.9 1611.8 56566.0 59635.4 59856.7 60484.4 60856.4 9400.4 9486.3 9540.3 9586.8 9623.5 12454.8 12525.2 12595.0 12603.4 12616.7 6825.3 6866.7 6896.1 7055.6 7107.3 6519.0 6593.3 6666.9 6741.7 6752.0 5783.4 5848.9 5873.6 5894.7 5913.7 1581.5 1596.1 1667.2 1667.5 1771.9 399.2 400.7 841.4 981.9 1013.9 10250.3 10412.3 10545.4 10672.3 10784.4 412.4 419.8 425.8 426.1 426.7 5556.6 5813.8 5878.8 9536.0 9987.5 497263.0 501137.0 502009.4 506814.0 507171.0 77620.6 79611.2 80313.2 80390.6 81883.6 1098.1 1104.6 1112.2 1128.1 1129.4 14734.0 14825.9 15039.3 15050.7 15235.6 32353.0 32789.2 33233.9 35333.0 36041.0 44486.7 44801.3 47374.5 47459.5 47896.3 9156.6 9455.8 9495.4 10009.8 10010.5 16723.2 17039.4 17362.5 17537.8 17562.4 9952.3 13935.8 14399.8 14604.3 15199.4 13998.3 14134.9 14785.6 14855.0 14884.9 14590.9 14807.6 15252.9 15370.2 15502.8 9265.9 9457.8 9501.2 9875.1 9890.3 14472.3 14494.3 14755.9 14899.3 15085.2 04:26:14 INFO - 2015-11-21 04:26:14,270 DEBUG : BROWSER_OUTPUT: 04:26:14 INFO - 2015-11-21 04:26:14,270 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5567.30 Median:6648.02 stddev:2911.21 (43.8%) stddev-sans-first:2901.93 04:26:14 INFO - 2015-11-21 04:26:14,270 DEBUG : BROWSER_OUTPUT: Values: 1326.5 1671.3 1704.7 1734.4 1735.6 6876.2 7431.1 7553.8 7559.1 7565.7 7735.4 7852.6 7921.2 7924.8 7932.0 1970.9 2010.2 2295.5 2322.5 2347.7 2345.2 2351.8 2352.9 2355.1 2356.2 2242.4 2297.5 2299.5 2300.8 2304.3 1956.4 2004.1 2266.2 2317.6 2317.9 2285.7 2304.1 2320.9 2334.6 2336.0 7859.4 7885.4 7904.7 7910.2 7912.2 4709.5 4777.7 4779.5 4796.7 4815.9 3119.1 3137.9 3141.0 3189.9 3216.2 1001.3 1004.5 1007.5 1037.2 1039.6 11170.7 11187.5 11251.0 11251.9 11264.9 4271.0 4328.1 4364.4 4451.7 4456.5 9558.7 9569.3 9571.3 9593.5 9602.9 4913.5 4914.8 4916.0 4920.5 4926.5 4431.5 4477.6 4483.3 4489.0 4489.5 3652.8 3714.7 3730.7 3733.9 3759.3 1200.6 1203.5 1208.5 1210.2 1213.2 943.8 1025.2 1042.7 1045.3 1103.0 7312.0 7340.6 7387.2 7426.4 7428.4 1076.2 1090.4 1092.8 1093.0 1098.9 5644.9 5730.6 5750.5 5774.3 5784.0 9216.4 9393.6 9637.5 9641.5 9652.2 9701.6 9701.9 9713.4 9732.3 9740.2 7308.8 7399.0 7477.1 7488.2 7500.1 7143.9 7170.7 7171.1 7181.3 7189.9 8221.7 8434.1 8436.8 8595.7 8622.3 8693.3 8806.0 8832.7 8842.5 8854.8 6826.4 6947.8 6959.5 6963.3 6964.9 7739.5 7785.5 7794.9 7795.4 7803.0 6876.4 6965.9 7107.5 7229.0 7275.9 6986.5 7085.0 7145.7 7163.2 7228.9 7151.6 7190.2 7195.8 7198.1 7202.9 6625.2 6647.3 6659.6 6660.3 6667.8 6648.7 6766.5 6767.7 6771.9 6775.8 04:26:14 INFO - 2015-11-21 04:26:14,270 DEBUG : BROWSER_OUTPUT: 04:26:14 INFO - 2015-11-21 04:26:14,270 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5366.70 Median:6072.14 stddev:1653.47 (27.2%) stddev-sans-first:1614.13 04:26:14 INFO - 2015-11-21 04:26:14,270 DEBUG : BROWSER_OUTPUT: Values: 319.6 321.9 324.5 325.2 330.5 5984.8 6012.4 6051.2 6069.8 6079.5 5741.4 5836.8 5902.1 5967.7 5998.5 4572.3 4581.0 4589.5 4594.2 4599.3 4379.2 4523.0 4555.8 4581.9 4592.2 4388.4 4425.3 4476.3 4506.7 4515.9 4458.1 4473.5 4484.1 4485.2 4496.2 3920.9 3923.0 3927.8 3928.8 3938.9 5558.1 5666.1 5668.5 5669.1 5672.1 5311.2 5318.7 5323.8 5325.4 5326.2 6350.1 6352.4 6359.3 6373.2 6378.8 4410.5 4416.7 4419.0 4421.6 4440.3 6475.9 6636.6 6637.8 6644.4 6648.5 4520.6 4537.0 4537.8 4537.9 4546.8 4577.8 4580.3 4584.1 4584.3 4586.1 5297.2 5297.4 5307.2 5308.0 5314.0 6271.2 6404.2 6419.0 6427.0 6438.7 1574.6 1598.0 1599.2 1600.0 1600.1 1032.2 1052.6 1055.7 1056.5 1077.0 6219.6 6221.3 6228.6 6234.6 6241.9 6639.4 6651.9 6662.9 6676.3 6679.0 6029.2 6029.5 6074.4 6171.0 6205.8 3565.4 3611.6 3648.2 3653.1 3661.0 6947.7 6959.5 6960.3 6978.7 6979.1 6756.2 6880.0 6890.8 6892.2 6893.3 6955.6 6958.7 6958.8 6973.2 6995.5 6683.7 6700.1 6709.2 6712.8 6727.9 6583.2 6624.3 6679.3 6679.3 6685.2 6990.1 6990.3 6994.5 7001.8 7006.3 4416.2 4421.6 4421.6 4423.5 4428.2 6568.1 6682.9 6690.3 6690.3 6703.3 6541.7 6543.2 6552.7 6553.2 6555.7 6526.2 6526.9 6528.9 6535.7 6539.3 6229.2 6355.8 6357.7 6368.4 6372.7 6300.6 6408.9 6423.9 6537.6 6570.2 6383.0 6414.3 6419.8 6425.9 6426.8 04:26:14 INFO - 2015-11-21 04:26:14,270 DEBUG : BROWSER_OUTPUT: 04:26:14 INFO - 2015-11-21 04:26:14,270 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13598.33 Median:30427.41 stddev:16682.48 (54.8%) stddev-sans-first:16701.50 04:26:14 INFO - 2015-11-21 04:26:14,270 DEBUG : BROWSER_OUTPUT: Values: 777.0 828.7 835.5 846.0 857.3 12707.2 12986.3 12991.2 13008.0 13038.9 11633.2 11731.9 11742.7 11745.2 11758.4 795.9 801.5 814.5 814.6 815.2 670.0 677.6 806.9 813.5 814.1 831.5 840.5 845.8 846.0 846.3 834.9 835.5 835.6 836.5 836.5 513.0 516.6 612.6 619.1 621.1 12320.8 12385.1 12386.4 12464.2 12509.7 11798.9 12130.5 12138.3 12209.5 12222.9 9141.0 9153.8 9162.2 9184.5 9257.3 3520.0 3571.6 3646.3 3655.9 3660.4 49676.0 49841.5 50759.0 50761.7 50971.5 9311.2 9622.4 9736.3 9958.4 9969.5 17783.4 17846.6 17856.8 17864.2 17867.9 7412.3 7523.0 7599.3 7667.8 7767.0 4006.9 4100.7 4106.2 4158.8 4176.4 3017.0 3019.5 3029.7 3031.7 3037.0 527.2 539.5 548.3 567.1 567.5 535.9 565.3 607.8 609.1 667.6 7904.5 8187.3 8710.7 9450.2 9585.0 648.3 683.7 687.2 701.7 750.8 3760.5 3839.4 3975.4 4009.8 4069.3 60247.0 61025.7 61427.7 61527.4 61565.0 52509.0 52669.0 52693.2 52851.2 52965.2 47087.8 49482.8 49556.3 49730.8 49928.0 7864.0 7908.0 7964.7 8074.9 8163.0 32302.5 32520.3 33353.0 33633.3 33695.7 42226.8 42283.0 46341.3 47528.8 47673.0 9768.4 9847.8 9915.1 10077.6 10186.2 10028.8 10045.5 10150.4 11333.6 11713.6 9049.2 9222.6 9256.1 9284.1 9554.1 9874.0 10001.5 10207.4 10493.9 10559.9 8578.4 8801.9 8921.9 9040.0 9140.8 8535.7 8800.3 8832.1 8954.4 8960.3 8096.2 8532.1 8606.5 8622.1 8628.3 04:26:14 INFO - 2015-11-21 04:26:14,272 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:26:14 INFO - 2015-11-21 04:26:14,272 DEBUG : BROWSER_OUTPUT: 04:26:14 INFO - 2015-11-21 04:26:14,904 INFO : Browser exited with error code: 0 04:26:14 INFO - 2015-11-21 04:26:14,920 INFO : Completed test dromaeo_css (00:18:32) 04:26:14 INFO - 2015-11-21 04:26:14,920 INFO : Starting test kraken 04:26:14 INFO - 2015-11-21 04:26:14,920 DEBUG : operating with platform_type : linux_ 04:26:14 INFO - 2015-11-21 04:26:14,920 INFO : Initialising browser for kraken test... 04:26:14 INFO - 2015-11-21 04:26:14,926 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSCx0ZG/profile http://localhost:37757/getInfo.html 04:26:18 INFO - 2015-11-21 04:26:18,484 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:26:18 INFO - 2015-11-21 04:26:18,484 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:26:18 INFO - 2015-11-21 04:26:18,484 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:26:18 INFO - 2015-11-21 04:26:18,484 DEBUG : BROWSER_OUTPUT: __metrics 04:26:18 INFO - 2015-11-21 04:26:18,620 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:19 INFO - 2015-11-21 04:26:19,796 INFO : Browser initialized. 04:26:19 INFO - 2015-11-21 04:26:19,797 INFO : Running cycle 1/1 for kraken test... 04:26:19 INFO - 2015-11-21 04:26:19,797 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSCx0ZG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:26:31 INFO - 2015-11-21 04:26:31,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 141983744 04:26:31 INFO - 2015-11-21 04:26:31,522 DEBUG : BROWSER_OUTPUT: 04:26:33 INFO - 2015-11-21 04:26:33,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37757/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:34 INFO - 2015-11-21 04:26:34,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 178794496 04:26:34 INFO - 2015-11-21 04:26:34,550 DEBUG : BROWSER_OUTPUT: 04:26:37 INFO - 2015-11-21 04:26:37,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37757/tests/kraken/driver.html?testName=audio-dft) 04:26:37 INFO - 2015-11-21 04:26:37,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 167931904 04:26:37 INFO - 2015-11-21 04:26:37,734 DEBUG : BROWSER_OUTPUT: 04:26:40 INFO - 2015-11-21 04:26:40,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37757/tests/kraken/driver.html?testName=audio-fft) 04:26:41 INFO - 2015-11-21 04:26:41,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 149766144 04:26:41 INFO - 2015-11-21 04:26:41,141 DEBUG : BROWSER_OUTPUT: 04:26:43 INFO - 2015-11-21 04:26:43,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37757/tests/kraken/driver.html?testName=audio-oscillator) 04:26:43 INFO - 2015-11-21 04:26:43,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 153726976 04:26:43 INFO - 2015-11-21 04:26:43,672 DEBUG : BROWSER_OUTPUT: 04:26:45 INFO - 2015-11-21 04:26:45,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37757/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:46 INFO - 2015-11-21 04:26:46,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 155885568 04:26:46 INFO - 2015-11-21 04:26:46,379 DEBUG : BROWSER_OUTPUT: 04:26:49 INFO - 2015-11-21 04:26:49,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37757/tests/kraken/driver.html?testName=imaging-darkroom) 04:26:49 INFO - 2015-11-21 04:26:49,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 154234880 04:26:49 INFO - 2015-11-21 04:26:49,850 DEBUG : BROWSER_OUTPUT: 04:26:53 INFO - 2015-11-21 04:26:53,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37757/tests/kraken/driver.html?testName=imaging-desaturate) 04:26:53 INFO - 2015-11-21 04:26:53,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 155443200 04:26:53 INFO - 2015-11-21 04:26:53,765 DEBUG : BROWSER_OUTPUT: 04:26:56 INFO - 2015-11-21 04:26:56,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37757/tests/kraken/driver.html?testName=json-parse-financial) 04:26:57 INFO - 2015-11-21 04:26:57,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 155418624 04:26:57 INFO - 2015-11-21 04:26:57,106 DEBUG : BROWSER_OUTPUT: 04:26:58 INFO - 2015-11-21 04:26:58,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37757/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:26:59 INFO - 2015-11-21 04:26:59,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 169414656 04:26:59 INFO - 2015-11-21 04:26:59,280 DEBUG : BROWSER_OUTPUT: 04:27:01 INFO - 2015-11-21 04:27:01,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37757/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:27:01 INFO - 2015-11-21 04:27:01,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 164982784 04:27:01 INFO - 2015-11-21 04:27:01,669 DEBUG : BROWSER_OUTPUT: 04:27:03 INFO - 2015-11-21 04:27:03,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37757/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:27:04 INFO - 2015-11-21 04:27:04,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 171782144 04:27:04 INFO - 2015-11-21 04:27:04,329 DEBUG : BROWSER_OUTPUT: 04:27:06 INFO - 2015-11-21 04:27:06,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:27:07 INFO - 2015-11-21 04:27:07,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 179154944 04:27:07 INFO - 2015-11-21 04:27:07,296 DEBUG : BROWSER_OUTPUT: 04:27:09 INFO - 2015-11-21 04:27:09,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:27:10 INFO - 2015-11-21 04:27:10,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 174931968 04:27:10 INFO - 2015-11-21 04:27:10,445 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37757/tests/kraken/driver.html?testName=ai-astar) 04:27:12 INFO - 2015-11-21 04:27:12,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 234520576 04:27:12 INFO - 2015-11-21 04:27:12,359 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,361 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:27:12 INFO - 2015-11-21 04:27:12,361 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:27:12 INFO - 2015-11-21 04:27:12,361 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:27:12 INFO - 2015-11-21 04:27:12,361 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:27:12 INFO - 2015-11-21 04:27:12,361 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;110;102;109;109;113;99;110;114;109 04:27:12 INFO - 2015-11-21 04:27:12,361 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;127;151;163;132;153;145;132;182;124 04:27:12 INFO - 2015-11-21 04:27:12,362 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;159;161;160;160;158;163;160;161 04:27:12 INFO - 2015-11-21 04:27:12,363 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;83;98;72;71;73;101;92;72 04:27:12 INFO - 2015-11-21 04:27:12,363 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;127;90;90;89;135;89;89;135 04:27:12 INFO - 2015-11-21 04:27:12,363 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;110;109;110;110;109 04:27:12 INFO - 2015-11-21 04:27:12,363 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;146;145;146;146;146;146;145 04:27:12 INFO - 2015-11-21 04:27:12,363 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;96;97;96;95;96;96 04:27:12 INFO - 2015-11-21 04:27:12,363 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;62;63;62;61;64;63;70;59;60 04:27:12 INFO - 2015-11-21 04:27:12,364 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;69;68;69;69;68;69 04:27:12 INFO - 2015-11-21 04:27:12,364 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;96;84;87;93;83;86;86;86;86;86 04:27:12 INFO - 2015-11-21 04:27:12,364 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;116;116;114;123;118;121;125;115;118 04:27:12 INFO - 2015-11-21 04:27:12,364 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;142;151;157;154;142;155;152;151;143 04:27:12 INFO - 2015-11-21 04:27:12,364 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;67;67;67;66;68;67;70;68 04:27:12 INFO - 2015-11-21 04:27:12,365 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:27:12 INFO - 2015-11-21 04:27:12,365 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:27:12 INFO - 2015-11-21 04:27:12,365 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,931 04:27:12 INFO - 2015-11-21 04:27:12,365 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:27:12 INFO - 2015-11-21 04:27:12,365 DEBUG : BROWSER_OUTPUT: __startTimestamp1448108832360__endTimestamp 04:27:12 INFO - 2015-11-21 04:27:12,366 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,367 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:27:12 INFO - 2015-11-21 04:27:12,367 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:27:12 INFO - 2015-11-21 04:27:12,367 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,367 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:4.63 (4.2%) stddev-sans-first:4.85 04:27:12 INFO - 2015-11-21 04:27:12,367 DEBUG : BROWSER_OUTPUT: Values: 106.0 110.0 102.0 109.0 109.0 113.0 99.0 110.0 114.0 109.0 04:27:12 INFO - 2015-11-21 04:27:12,368 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,368 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.10 Median:151.50 stddev:18.05 (11.9%) stddev-sans-first:19.02 04:27:12 INFO - 2015-11-21 04:27:12,368 DEBUG : BROWSER_OUTPUT: Values: 152.0 127.0 151.0 163.0 132.0 153.0 145.0 132.0 182.0 124.0 04:27:12 INFO - 2015-11-21 04:27:12,368 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,368 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.37 (0.9%) stddev-sans-first:1.45 04:27:12 INFO - 2015-11-21 04:27:12,368 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 159.0 161.0 160.0 160.0 158.0 163.0 160.0 161.0 04:27:12 INFO - 2015-11-21 04:27:12,368 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,368 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:72.50 stddev:12.02 (16.6%) stddev-sans-first:12.34 04:27:12 INFO - 2015-11-21 04:27:12,369 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 83.0 98.0 72.0 71.0 73.0 101.0 92.0 72.0 04:27:12 INFO - 2015-11-21 04:27:12,369 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,369 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.50 Median:89.50 stddev:20.71 (23.1%) stddev-sans-first:21.55 04:27:12 INFO - 2015-11-21 04:27:12,369 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 127.0 90.0 90.0 89.0 135.0 89.0 89.0 135.0 04:27:12 INFO - 2015-11-21 04:27:12,369 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,369 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:27:12 INFO - 2015-11-21 04:27:12,369 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 110.0 109.0 110.0 110.0 109.0 04:27:12 INFO - 2015-11-21 04:27:12,369 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,369 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:27:12 INFO - 2015-11-21 04:27:12,370 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 04:27:12 INFO - 2015-11-21 04:27:12,370 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,370 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:27:12 INFO - 2015-11-21 04:27:12,370 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 96.0 97.0 96.0 95.0 96.0 96.0 04:27:12 INFO - 2015-11-21 04:27:12,370 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,370 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:2.98 (4.7%) stddev-sans-first:3.16 04:27:12 INFO - 2015-11-21 04:27:12,370 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 63.0 62.0 61.0 64.0 63.0 70.0 59.0 60.0 04:27:12 INFO - 2015-11-21 04:27:12,370 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,371 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 04:27:12 INFO - 2015-11-21 04:27:12,371 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 69.0 68.0 69.0 69.0 68.0 69.0 04:27:12 INFO - 2015-11-21 04:27:12,371 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,371 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:86.00 stddev:4.03 (4.7%) stddev-sans-first:2.78 04:27:12 INFO - 2015-11-21 04:27:12,371 DEBUG : BROWSER_OUTPUT: Values: 96.0 84.0 87.0 93.0 83.0 86.0 86.0 86.0 86.0 86.0 04:27:12 INFO - 2015-11-21 04:27:12,371 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,371 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:118.50 stddev:3.57 (3.0%) stddev-sans-first:3.78 04:27:12 INFO - 2015-11-21 04:27:12,371 DEBUG : BROWSER_OUTPUT: Values: 119.0 116.0 116.0 114.0 123.0 118.0 121.0 125.0 115.0 118.0 04:27:12 INFO - 2015-11-21 04:27:12,371 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,372 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:151.50 stddev:5.89 (3.9%) stddev-sans-first:5.83 04:27:12 INFO - 2015-11-21 04:27:12,372 DEBUG : BROWSER_OUTPUT: Values: 143.0 142.0 151.0 157.0 154.0 142.0 155.0 152.0 151.0 143.0 04:27:12 INFO - 2015-11-21 04:27:12,372 DEBUG : BROWSER_OUTPUT: 04:27:12 INFO - 2015-11-21 04:27:12,372 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 04:27:12 INFO - 2015-11-21 04:27:12,372 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 67.0 67.0 66.0 68.0 67.0 70.0 68.0 04:27:12 INFO - 2015-11-21 04:27:12,372 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:27:12 INFO - 2015-11-21 04:27:12,372 DEBUG : BROWSER_OUTPUT: 04:27:13 INFO - 2015-11-21 04:27:13,215 INFO : Browser exited with error code: 0 04:27:13 INFO - 2015-11-21 04:27:13,268 INFO : Completed test kraken (00:00:58) 04:27:13 INFO - 2015-11-21 04:27:13,268 INFO : Starting test v8_7 04:27:13 INFO - 2015-11-21 04:27:13,268 DEBUG : operating with platform_type : linux_ 04:27:13 INFO - 2015-11-21 04:27:13,269 INFO : Initialising browser for v8_7 test... 04:27:13 INFO - 2015-11-21 04:27:13,275 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkRHHVg/profile http://localhost:37757/getInfo.html 04:27:16 INFO - 2015-11-21 04:27:16,974 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:27:16 INFO - 2015-11-21 04:27:16,975 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:27:16 INFO - 2015-11-21 04:27:16,975 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:27:16 INFO - 2015-11-21 04:27:16,975 DEBUG : BROWSER_OUTPUT: __metrics 04:27:17 INFO - 2015-11-21 04:27:17,071 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:27:18 INFO - 2015-11-21 04:27:18,311 INFO : Browser initialized. 04:27:18 INFO - 2015-11-21 04:27:18,312 INFO : Running cycle 1/1 for v8_7 test... 04:27:18 INFO - 2015-11-21 04:27:18,312 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkRHHVg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:27:30 INFO - 2015-11-21 04:27:30,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 140271616 04:27:30 INFO - 2015-11-21 04:27:30,111 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37757/tests/v8_7/run.html (next: http://localhost:37757/tests/v8_7/run.html) 04:27:51 INFO - 2015-11-21 04:27:51,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 575897600 04:27:51 INFO - 2015-11-21 04:27:51,774 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,774 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:27:51 INFO - 2015-11-21 04:27:51,774 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:27:51 INFO - 2015-11-21 04:27:51,774 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:27:51 INFO - 2015-11-21 04:27:51,774 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:27:51 INFO - 2015-11-21 04:27:51,774 DEBUG : BROWSER_OUTPUT: |0;Richards;162.86644951140065 04:27:51 INFO - 2015-11-21 04:27:51,775 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.57250612860645 04:27:51 INFO - 2015-11-21 04:27:51,775 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.135788585887 04:27:51 INFO - 2015-11-21 04:27:51,775 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 04:27:51 INFO - 2015-11-21 04:27:51,775 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1949.317738791423 04:27:51 INFO - 2015-11-21 04:27:51,775 DEBUG : BROWSER_OUTPUT: |5;Earley;775.1937984496124 04:27:51 INFO - 2015-11-21 04:27:51,775 DEBUG : BROWSER_OUTPUT: |6;Boyer;12108.43373493976 04:27:51 INFO - 2015-11-21 04:27:51,775 DEBUG : BROWSER_OUTPUT: |7;RegExp;25692.30769230769 04:27:51 INFO - 2015-11-21 04:27:51,776 DEBUG : BROWSER_OUTPUT: |8;Splay;597.5029726516052 04:27:51 INFO - 2015-11-21 04:27:51,776 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 04:27:51 INFO - 2015-11-21 04:27:51,776 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:27:51 INFO - 2015-11-21 04:27:51,776 DEBUG : BROWSER_OUTPUT: __startTimestamp1448108871766__endTimestamp 04:27:51 INFO - 2015-11-21 04:27:51,776 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,776 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:27:51 INFO - 2015-11-21 04:27:51,776 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:27:51 INFO - 2015-11-21 04:27:51,777 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,777 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.87 Median:162.87 stddev:0.00 (0.0%) 04:27:51 INFO - 2015-11-21 04:27:51,777 DEBUG : BROWSER_OUTPUT: Values: 162.9 04:27:51 INFO - 2015-11-21 04:27:51,777 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,777 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.57 Median:188.57 stddev:0.00 (0.0%) 04:27:51 INFO - 2015-11-21 04:27:51,777 DEBUG : BROWSER_OUTPUT: Values: 188.6 04:27:51 INFO - 2015-11-21 04:27:51,777 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,777 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.14 Median:281.14 stddev:0.00 (0.0%) 04:27:51 INFO - 2015-11-21 04:27:51,778 DEBUG : BROWSER_OUTPUT: Values: 281.1 04:27:51 INFO - 2015-11-21 04:27:51,778 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,778 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 04:27:51 INFO - 2015-11-21 04:27:51,778 DEBUG : BROWSER_OUTPUT: Values: 5030.2 04:27:51 INFO - 2015-11-21 04:27:51,778 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,778 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1949.32 Median:1949.32 stddev:0.00 (0.0%) 04:27:51 INFO - 2015-11-21 04:27:51,778 DEBUG : BROWSER_OUTPUT: Values: 1949.3 04:27:51 INFO - 2015-11-21 04:27:51,779 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,779 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:775.19 Median:775.19 stddev:0.00 (0.0%) 04:27:51 INFO - 2015-11-21 04:27:51,779 DEBUG : BROWSER_OUTPUT: Values: 775.2 04:27:51 INFO - 2015-11-21 04:27:51,779 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,779 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12108.43 Median:12108.43 stddev:0.00 (0.0%) 04:27:51 INFO - 2015-11-21 04:27:51,779 DEBUG : BROWSER_OUTPUT: Values: 12108.4 04:27:51 INFO - 2015-11-21 04:27:51,779 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,780 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25692.31 Median:25692.31 stddev:0.00 (0.0%) 04:27:51 INFO - 2015-11-21 04:27:51,780 DEBUG : BROWSER_OUTPUT: Values: 25692.3 04:27:51 INFO - 2015-11-21 04:27:51,780 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,780 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.50 Median:597.50 stddev:0.00 (0.0%) 04:27:51 INFO - 2015-11-21 04:27:51,780 DEBUG : BROWSER_OUTPUT: Values: 597.5 04:27:51 INFO - 2015-11-21 04:27:51,780 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,780 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 04:27:51 INFO - 2015-11-21 04:27:51,780 DEBUG : BROWSER_OUTPUT: Values: 4845.4 04:27:51 INFO - 2015-11-21 04:27:51,781 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:27:51 INFO - 2015-11-21 04:27:51,781 DEBUG : BROWSER_OUTPUT: 04:27:52 INFO - 2015-11-21 04:27:52,607 INFO : Browser exited with error code: 0 04:27:52 INFO - 2015-11-21 04:27:52,625 INFO : Completed test v8_7 (00:00:39) 04:27:52 INFO - 2015-11-21 04:27:52,773 INFO : Completed test suite (00:20:10) 04:27:52 INFO - 2015-11-21 04:27:52,773 DEBUG : Working with test: dromaeo_css 04:27:52 INFO - 2015-11-21 04:27:52,774 DEBUG : Generating results file: dromaeo_css 04:27:52 INFO - 2015-11-21 04:27:52,775 DEBUG : Working with test: kraken 04:27:52 INFO - 2015-11-21 04:27:52,775 DEBUG : Generating results file: kraken 04:27:52 INFO - 2015-11-21 04:27:52,775 INFO : javascript benchmark 04:27:52 INFO - 2015-11-21 04:27:52,775 DEBUG : Working with test: v8_7 04:27:52 INFO - 2015-11-21 04:27:52,775 DEBUG : Generating results file: v8_7 04:27:52 INFO - 2015-11-21 04:27:52,776 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:27:52 INFO - 2015-11-21 04:27:52,906 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 04:27:52 INFO - 2015-11-21 04:27:52,906 DEBUG : process_Request line: dromaeo_css 6932.87 graph.html#tests=[[72,64,35]] 04:27:52 INFO - 2015-11-21 04:27:52,906 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:27:52 INFO - 2015-11-21 04:27:52,930 DEBUG : process_Request line: kraken 1501.80 graph.html#tests=[[232,64,35]] 04:27:52 INFO - 2015-11-21 04:27:52,930 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:27:53 INFO - 2015-11-21 04:27:53,037 DEBUG : process_Request line: v8_7 20053.95 graph.html#tests=[[230,64,35]] 04:27:53 INFO - 2015-11-21 04:27:53,039 INFO : javascript benchmark 04:27:53 INFO - 2015-11-21 04:27:53,042 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3163.367326534693, 3215.614126304844, 3223.5325877747728, 3232.1757951722307, 3258.0, 5249.658772179815, 5374.865628359293, 5397.973010134953, 5460.453954604538, 5521.25463062487, 5359.812406565771, 5417.079096553595, 5443.265159203506, 5525.640833345829, 5546.91679624806, 4954.504549545044, 4971.45314015458, 4992.026554821811, 4999.0, 5077.619178561604, 5078.162103252977, 5087.79648814047, 5117.309163262968, 5151.150060240056, 5163.612729045318, 4809.879753006167, 4883.9511604883855, 4926.950730492703, 5014.5737612303, 5052.949470505321, 4978.054169707744, 4982.028504441635, 4991.725455099968, 4992.625553083497, 5029.220470827027, 4933.260010998343, 4973.42805577356, 4982.153033984195, 4983.825566105169, 5031.119554078058, 5136.922946155811, 5154.020736060136, 5212.687238765686, 5229.294045303874, 5250.0, 5896.115582662592, 5918.763249470016, 5921.437463440966, 5927.436893495111, 5929.169916211734, 5780.988327042751, 5984.222051133368, 6008.6094403864045, 6013.428724271187, 6018.2778066631845, 5404.162354835007, 5480.451954804487, 5499.890002199973, 5516.310461192351, 5532.004239236895, 6032.668203248776, 6039.818805435844, 6065.939340606537, 6121.908171377433, 6122.2959359674205, 5461.726913654302, 5903.527717782567, 5905.7932972346625, 5911.083782013795, 5920.4967577755515, 5765.250517432707, 5770.682612456355, 5857.824265272048, 5862.413758624103, 5916.940830591639, 5906.468417842329, 5914.645121292736, 5916.437938395846, 5942.227510423617, 5946.940530594725, 5632.239647647597, 5743.396943320975, 5952.136940143655, 5956.76172953077, 5957.0, 4483.237849565582, 4498.235299999008, 4508.301213311942, 4517.525659805673, 4523.5250298718165, 3998.300297447935, 4030.334994725896, 4043.7169398141846, 4074.5517993020744, 4086.652634526039, 5344.465553444625, 5566.888662226814, 5586.804461843816, 5590.0, 5594.104943209149, 5697.857553561194, 5769.249997500298, 5787.479126878601, 5809.128630705343, 5865.0, 5479.479449452296, 5480.0, 5481.75332110056, 5482.890342193134, 5486.506214440719, 4871.610271178368, 5053.242013697901, 5072.137736584789, 5089.185730283211, 5137.255098010843, 5955.642661440327, 6042.335343112254, 6044.274687037584, 6051.3041000283765, 6086.056661217518, 5895.793647222326, 5926.051831707078, 5931.6441013539325, 5957.314908785545, 5962.55280853929, 5808.244928159313, 5934.465898069195, 6120.510359171345, 6133.3866613338305, 6138.9386106140155, 5633.295838020247, 5812.18629391877, 5889.49939255151, 5922.1412895130825, 5972.313183983723, 5867.178594996789, 5912.142739302691, 5918.141869428995, 5924.7926322578505, 5941.405859414197, 5527.198556209247, 5576.275084239023, 5805.564582656233, 5813.505852002627, 5815.41845815415, 5673.858153546029, 5765.336986246635, 5772.19189313488, 5782.479576837936, 5821.825345239649, 5530.419305972815, 5533.667979921218, 5534.1975413565615, 5543.3902270751, 5545.334559852843, 5626.35296940857, 5647.689377084135, 5700.230468886647, 5726.885462290814, 5789.450002249948, 5567.972160139173, 5662.631928924607, 5664.631798933221, 5682.261306030189, 5695.886082278248], "unit": "ms", "name": "dojo.html", "value": 5404.6495035656}, {"lowerIsBetter": false, "replicates": [563.4112352591542, 611.251217258858, 614.2444792904727, 614.8708771158057, 616.340515648256, 30906.69093309069, 31387.686123138792, 31395.529067064013, 31408.214794630116, 39605.20789584207, 42257.57742422583, 42527.3620895686, 42611.0, 42719.0, 42746.35880461796, 8630.784230394227, 8715.694950676727, 8787.824243515157, 8793.0, 8801.339899507531, 7733.883991740128, 7953.761387158394, 8539.0, 10281.383117012965, 10651.041406273434, 10380.221483388737, 10474.0, 10476.633317833877, 10476.790464190712, 10482.213833962445, 7836.568988705619, 10374.740631484236, 10386.740331491774, 10443.79112417755, 10487.213458990605, 7706.0, 10328.380297182193, 10713.839292410543, 10719.249652524326, 10721.249512534127, 38331.61668383336, 39068.21863562741, 39111.0, 39117.217655647015, 39165.41251881224, 3222.8066316021113, 3477.982610086933, 3732.6267373262726, 3836.2135762168687, 4007.499062617173, 28780.136595902157, 28933.0, 29762.851185743933, 29813.10560683183, 30196.396072078656, 3939.625735555118, 4065.6340929316502, 4096.651784598313, 4102.753834769894, 4107.322291821846, 256243.0, 257316.0, 258079.9999999981, 258188.0, 258814.0, 55964.24303934211, 58340.708296458244, 59537.0, 59894.0, 64911.0, 60134.69932650309, 60697.39302606917, 60723.392766071775, 60793.39206607877, 60838.695806520685, 13074.215547067206, 13227.404766785517, 13246.801297980537, 13302.068855180045, 13316.267605281802, 9909.603615855285, 9910.058544438267, 9911.752206194902, 9912.306138570231, 9912.55393507294, 19707.704384434244, 19946.902920339522, 20083.497912552302, 20126.89936550308, 20193.394198173784, 7790.05248687828, 7969.561674107864, 7996.24035716606, 8013.19868013194, 8122.55325957078, 883.4478450968145, 935.6304259817334, 950.9619615215314, 1048.3290693955873, 1122.2144498850837, 28302.433951320858, 28334.69529257328, 28523.286917826805, 28601.427971440455, 28902.855485722437, 962.6775030364767, 966.1980556138388, 1006.864073350103, 1008.6469735592484, 1125.2348403085816, 14584.85415145835, 14685.118892866461, 14737.0, 14884.553463396116, 14946.0, 364047.0, 367343.0, 368128.0, 368622.0, 369779.0, 51327.743361283705, 51431.48568514267, 51938.48061519412, 51992.0, 52054.0, 1234.4876876096498, 1237.1587320622064, 1249.6063739921894, 1271.0721173543366, 1275.5599318235195, 26318.21045368642, 27318.31704207331, 27335.316617084733, 27425.31436714098, 27687.0, 41203.58796411997, 42100.789496052326, 43951.0, 44553.0, 46889.53110468852, 202278.0, 203150.0, 203335.0, 203409.0, 206891.0, 27336.589951150352, 27906.441871162868, 30082.69917300799, 30424.695753042186, 30435.391292174474, 44844.32733508935, 45049.91826103434, 45321.77339113415, 45350.54649453463, 45790.0, 34130.317393651494, 34220.14449638779, 34275.82862085674, 41989.37015944702, 42817.487165201324, 37380.626193738804, 37781.0, 37943.94011785263, 38038.0, 38581.614183857804, 36461.45307820332, 37191.442128367555, 37300.0, 37479.81260093682, 37481.2503749918, 31859.20351991219, 33697.0, 34219.65780342164, 34266.82866585651, 34578.135546611535, 25687.871560642823, 25918.35204119912, 26054.609180861924, 26056.73943260619, 26327.68643496934], "unit": "ms", "name": "ext.html", "value": 18411.942587037352}, {"lowerIsBetter": false, "replicates": [350.58805903063893, 358.9479525468807, 361.6058496239099, 362.99092522686936, 364.3332701156883, 13856.792148117785, 14001.0, 16106.516804495855, 16705.0, 17598.648027039453, 15039.548813535612, 16229.350825966976, 16272.75590866135, 16335.59161020975, 17279.74080388795, 5197.376314842224, 5326.0, 5326.5472434842895, 5327.200919862033, 5332.57339412848, 3948.387999860012, 4026.436298918139, 5318.095923692981, 5352.090144675414, 5802.535797136219, 5894.440028197314, 5919.052951527757, 5922.822315330525, 5937.37657545958, 5940.910886336708, 5747.626404283729, 5871.677057761822, 5876.29484461863, 5876.882462350772, 5902.822915312548, 5143.897122057575, 5162.612804039674, 5178.844634660966, 5182.481751824825, 5184.092783762864, 18739.53151171218, 20473.0, 20791.58416831655, 20793.16827326905, 20809.791902081088, 1951.8243358097839, 2028.1785876719953, 2035.1350675962656, 2076.1176499987596, 2202.438378213545, 12432.316222607753, 12520.0, 13068.738625227443, 13110.213387196798, 13475.663108422368, 1557.9688406231926, 1563.7185306644799, 1563.9609009774733, 1588.904665720049, 1611.790467239263, 56566.0, 59635.403645963415, 59856.700716496576, 60484.39515604832, 60856.39143608551, 9400.435973841591, 9486.288528360263, 9540.284478664127, 9586.760330991781, 9623.518824058769, 12454.81317780234, 12525.185862918881, 12595.0, 12603.369831508571, 12616.747665046647, 6825.317468253135, 6866.725330986805, 6896.137982752156, 7055.576665400093, 7107.289271072851, 6518.967405162944, 6593.307702691244, 6666.933330666729, 6741.662916854138, 6752.0, 5783.421657834183, 5848.912266316009, 5873.618214816109, 5894.734736936848, 5913.704314784243, 1581.541353007638, 1596.1380854338759, 1667.1914121650989, 1667.5414261078058, 1771.8582513398896, 399.22749479756766, 400.6554363247605, 841.427829076234, 981.8625392445064, 1013.9239557033252, 10250.282480226462, 10412.271141020208, 10545.367277963347, 10672.30630009047, 10784.352938823538, 412.43908284732737, 419.76493163828354, 425.7977460706202, 426.100927043937, 426.65440992795936, 5556.611037227436, 5813.767449302065, 5878.764849406061, 9535.952320238355, 9987.450690211963, 497263.0, 501137.0, 502009.4296699598, 506814.0, 507171.0, 77620.61189694016, 79611.20388796154, 80313.19686803174, 80390.59804701056, 81883.5905820467, 1098.0501865885951, 1104.5968221599057, 1112.1714322829382, 1128.1313388690662, 1129.4409267412684, 14734.042287251294, 14825.92587037058, 15039.323230454436, 15050.69898602, 15235.619109522351, 32353.0, 32789.18027049343, 33233.941173825704, 35333.0, 36041.0, 44486.663500236966, 44801.32798007967, 47374.52625473839, 47459.52540474551, 47896.28155577739, 9156.587953541974, 9455.763605909631, 9495.43027418357, 10009.799804003733, 10010.549525271235, 16723.163841807618, 17039.40362087321, 17362.47912562625, 17537.824621753618, 17562.38531651437, 9952.302557955498, 13935.790963135358, 14399.78400323975, 14604.269786510844, 15199.392024318904, 13998.300084995506, 14134.858651413766, 14785.556433307018, 14855.0, 14884.925575372054, 14590.854091459374, 14807.629809254855, 15252.923735381251, 15370.23148842531, 15502.83728720328, 9265.86101208469, 9457.810843782949, 9501.239900808057, 9875.061869122423, 9890.258230632588, 14472.34874430632, 14494.347754350869, 14755.926220368829, 14899.255037248311, 15085.24573771285], "unit": "ms", "name": "jquery.html", "value": 8421.522526553064}, {"lowerIsBetter": false, "replicates": [1326.5158217250707, 1671.3147609480116, 1704.7442883567464, 1734.4103004978308, 1735.600811813283, 6876.209235937862, 7431.071116110486, 7553.773386798405, 7559.130699969505, 7565.697372105123, 7735.38116950644, 7852.646630901609, 7921.20787921209, 7924.80187995299, 7932.008498937633, 1970.8817470951717, 2010.2059686423854, 2295.5294164696197, 2322.5471033148583, 2347.6713260143592, 2345.2260753951155, 2351.8471299365574, 2352.9176478823247, 2355.1286024170995, 2356.175338631482, 2242.4169715873827, 2297.517521320525, 2299.5056062946464, 2300.7584203658625, 2304.3087073877855, 1956.3739603326942, 2004.0681083296338, 2266.172846910874, 2317.582835089683, 2317.8841057947034, 2285.6971526230054, 2304.1129165271323, 2320.8607483550873, 2334.568104900599, 2335.9649605255936, 7859.449838511307, 7885.369170466406, 7904.683812647487, 7910.169432209593, 7912.208779122099, 4709.481956984729, 4777.689450185727, 4779.450363208241, 4796.664233503656, 4815.927761083586, 3119.142235885127, 3137.921551961196, 3140.9685903140903, 3189.9043028709175, 3216.163797412666, 1001.2640709078821, 1004.45257334752, 1007.5113569918584, 1037.2169012395593, 1039.6049501189575, 11170.664880053611, 11187.496562654618, 11251.0, 11251.943740281245, 11264.887351126466, 4270.957290427118, 4328.069465065026, 4364.388985542027, 4451.732896026248, 4456.487503937024, 9558.665446709332, 9569.282303827102, 9571.28215383849, 9593.520323983774, 9602.90397096034, 4913.459519452857, 4914.827981020647, 4916.0, 4920.458749537548, 4926.531979461945, 4431.490378606437, 4477.597016268552, 4483.327500874895, 4489.034857505652, 4489.506154323022, 3652.7808331500196, 3714.665680088805, 3730.6642402183934, 3733.9439908401396, 3759.3233218020473, 1200.5557943560939, 1203.4764877278237, 1208.4924331780674, 1210.2073142091945, 1213.1811027556541, 943.8395472769646, 1025.2105878473533, 1042.6976176908763, 1045.3309881675734, 1103.0403548912498, 7312.049433573601, 7340.559566426032, 7387.224341444178, 7426.4430167736555, 7428.4428667850125, 1076.235872530512, 1090.4166271044953, 1092.847001419802, 1093.0, 1098.8516550265772, 5644.858878527987, 5730.627509211888, 5750.539956803445, 5774.335951365647, 5783.971080144573, 9216.400933939272, 9393.57728902201, 9637.469939153414, 9641.517924103768, 9652.22782177424, 9701.563429645683, 9701.854472182782, 9713.417194968324, 9732.270079743907, 9740.172085372822, 7308.780736577911, 7399.0, 7477.102747670315, 7488.176300606929, 7500.137484189279, 7143.9285607143265, 7170.677319520739, 7171.103612048494, 7181.317774811385, 7189.928100719135, 8221.712240071807, 8434.072252052392, 8436.831263374821, 8595.699150529701, 8622.26710729595, 8693.32540508409, 8805.955970220108, 8832.735017949472, 8842.46945183291, 8854.778630534289, 6826.385625293548, 6947.79156625302, 6959.478039146983, 6963.338482844122, 6964.930350696428, 7739.458237923516, 7785.493942893694, 7794.88307675374, 7795.376369890509, 7802.960985195038, 6876.449884009167, 6965.895511567432, 7107.538010029331, 7228.96385518069, 7275.890861636974, 6986.510944233854, 7084.964575177298, 7145.7498987537265, 7163.247858974941, 7228.89156662661, 7151.642417879189, 7190.173130089897, 7195.820104497429, 7198.100237470317, 7202.927970720226, 6625.238097618835, 6647.302033286435, 6659.600423974577, 6660.300668429745, 6667.799966001027, 6648.7340506379205, 6766.492513061442, 6767.695453704497, 6771.89842152378, 6775.830604234933], "unit": "ms", "name": "mootools.html", "value": 4550.623228042474}, {"lowerIsBetter": false, "replicates": [319.6100757076366, 321.88412171618216, 324.46301371230606, 325.1562196101117, 330.4877439968049, 5984.82045538634, 6012.398760123985, 6051.183090282811, 6069.848253793657, 6079.513638908893, 5741.397153298906, 5836.766529338832, 5902.114682797583, 5967.731452084656, 5998.4901283390855, 4572.314152877062, 4581.0, 4589.495155532905, 4594.173048851206, 4599.333096700976, 4379.167958087969, 4523.0, 4555.817767289304, 4581.908361832761, 4592.196365636017, 4388.429504164455, 4425.336199570074, 4476.306172543261, 4506.662000349987, 4515.864524064284, 4458.108378324316, 4473.463184417858, 4484.080763443486, 4485.192665320241, 4496.213162696531, 3920.862769803072, 3923.019245188703, 3927.8036098194975, 3928.8428462861452, 3938.940915886264, 5558.110702287655, 5666.121751128581, 5668.489835914746, 5669.092945128759, 5672.120821272668, 5311.176767601028, 5318.680879147263, 5323.787048518055, 5325.360956685184, 5326.174442961347, 6350.079238510436, 6352.396522330371, 6359.268684101341, 6373.171487706569, 6378.808635740936, 4410.514843367227, 4416.690831641787, 4419.049904270565, 4421.646268298528, 4440.267355886275, 6475.870482590369, 6636.634985075819, 6637.800865974028, 6644.43522300605, 6648.534602577822, 4520.570545798144, 4537.047220083753, 4537.8184872604725, 4537.931931021038, 4546.772661366918, 4577.771111444415, 4580.290055041474, 4584.083183363341, 4584.312353147055, 4586.105709386704, 5297.231901374356, 5297.390800057966, 5307.230451584499, 5308.0, 5314.043472175045, 6271.216097987752, 6404.231492220963, 6419.037144428373, 6427.003814408774, 6438.742450302029, 1574.6378332983477, 1597.9920100399424, 1599.1684324151377, 1599.9680006399806, 1600.0559669794877, 1032.1897310611284, 1052.6210564196883, 1055.6674647486018, 1056.5087234436023, 1076.9983914959164, 6219.564630475823, 6221.3156552779155, 6228.56400051992, 6234.5635805494085, 6241.875162496815, 6639.3692599203, 6651.933480665131, 6662.866742665216, 6676.26561078281, 6679.0, 6029.186059881948, 6029.517638588903, 6074.42292982166, 6171.0, 6205.81382558524, 3565.3760591896316, 3611.620779818134, 3648.21563363878, 3653.050206946213, 3660.9633903661156, 6947.652617369213, 6959.478039147084, 6960.338767817049, 6978.685959131852, 6979.127609048869, 6756.189257289157, 6879.965600172067, 6890.827729306808, 6892.241853396123, 6893.345132212432, 6955.582665040012, 6958.721651133898, 6958.7912362628185, 6973.163220413583, 6995.475339349569, 6683.699233534406, 6700.128983232149, 6709.194896612437, 6712.83217919556, 6727.899081513683, 6583.177102862142, 6624.304448032887, 6679.265280819009, 6679.265280819203, 6685.231198412051, 6990.056342393712, 6990.300969903173, 6994.510384273256, 7001.789946301619, 7006.299370062953, 4416.205083085076, 4421.624161946142, 4421.646268298464, 4423.469183697976, 4428.2029234736765, 6568.080468734285, 6682.866342673022, 6690.29751876046, 6690.330966903271, 6703.262641109572, 6541.738330466728, 6543.214814222324, 6552.6723663815665, 6553.2136143663065, 6555.704993275219, 6526.24948130971, 6526.9347306528225, 6528.934710652833, 6535.673216339259, 6539.313372095861, 6229.159063526366, 6355.809325720235, 6357.650329231937, 6368.363163683594, 6372.681365931778, 6300.621962682254, 6408.871822563616, 6423.935760642334, 6537.640429776408, 6570.244421891352, 6383.0, 6414.262359828493, 6419.775307864203, 6425.871482570229, 6426.775062872777], "unit": "ms", "name": "prototype.html", "value": 4821.875882654108}, {"lowerIsBetter": false, "replicates": [776.9899131129537, 828.709951516969, 835.4820011592814, 845.9746207613766, 857.3184318466816, 12707.174033687805, 12986.28575428351, 12991.2205267684, 13008.024398170139, 13038.93480532596, 11633.243839150471, 11731.941340293286, 11742.706432339175, 11745.236559623618, 11758.41207939604, 795.8726603743388, 801.4950581133907, 814.4665244265016, 814.6497006287294, 815.1848151848152, 669.9531032827704, 677.5832862789374, 806.9072056713494, 813.4793732011517, 814.0882211922625, 831.501099340397, 840.4789030800912, 845.8308338332358, 845.9619317130744, 846.2975730143966, 834.8747687846841, 835.4903508859621, 835.5655059369094, 836.5148214035845, 836.523181786382, 512.9743512824381, 516.6099594805897, 612.6079309242089, 619.1486705779553, 621.0528943361364, 12320.81518777219, 12385.071119666061, 12386.442610082478, 12464.189827661263, 12509.74980500394, 11798.88201117995, 12130.454129564103, 12138.271703697717, 12209.511619535208, 12222.877771222264, 9141.0, 9153.81692366149, 9162.221211197057, 9184.540772961325, 9257.305702072304, 3520.0, 3571.6428357164336, 3646.3436581415335, 3655.908602284964, 3660.359437098497, 49676.0, 49841.50158498405, 50758.99999999963, 50761.74619126918, 50971.49028509705, 9311.208547273422, 9622.422654640604, 9736.318457707892, 9958.402495850272, 9969.451680157661, 17783.377581784574, 17846.643067138586, 17856.821431785775, 17864.196111175028, 17867.910660446876, 7412.295831895961, 7522.962385188039, 7599.316061554487, 7667.769966901002, 7766.961165194138, 4006.9198616027516, 4100.712950093524, 4106.2198182345255, 4158.750474971512, 4176.352665336878, 3017.0, 3019.531972544259, 3029.66673665901, 3031.651360093573, 3037.0433313506173, 527.1960260602611, 539.4874868874584, 548.2516365161606, 567.0869899461863, 567.4835899331589, 535.884784771276, 565.2679779685317, 607.8115784106941, 609.1228630771675, 667.5961043568668, 7904.525728456311, 8187.263146316741, 8710.651573937099, 9450.243980481546, 9584.952075239578, 648.251269783401, 683.7094234950126, 687.1547995964892, 701.6737217194029, 750.8423231121526, 3760.4547340635454, 3839.3665045267776, 3975.4036894465485, 4009.7794621296107, 4069.348904175318, 60247.0, 61025.69487152625, 61427.6928615363, 61527.384726152166, 61565.0, 52509.0, 52669.0, 52693.209601856004, 52851.20723189155, 52965.2055219172, 47087.76456117766, 49482.752586237555, 49556.25665615091, 49730.751346243764, 49928.0, 7864.0, 7907.9604601976625, 7964.681412743425, 8074.878876816735, 8162.959185204273, 32302.515462267616, 32520.34959300848, 33353.0, 33633.327333452704, 33695.663043369255, 42226.788866055475, 42283.0, 46341.30488042615, 47528.762356187995, 47673.04653906972, 9768.413895166314, 9847.753806154904, 9915.107640312406, 10077.647282345082, 10186.210266997748, 10028.799424011624, 10045.547950342398, 10150.441725705157, 11333.603323883624, 11713.596620444088, 9049.230815380766, 9222.631094756134, 9256.07439256069, 9284.071592840663, 9554.092361225672, 9873.95063024709, 10001.499925003574, 10207.387556746618, 10493.9475302623, 10559.894401055892, 8578.4424012439, 8801.91198088011, 8921.866172007554, 9039.96040455356, 9140.817183656423, 8535.701250456204, 8800.339974502065, 8832.109545544852, 8954.417962832395, 8960.283177345666, 8096.230858068474, 8532.146785321418, 8606.483610983361, 8622.094680058504, 8628.322976433878], "unit": "ms", "name": "yui.html", "value": 6038.063505008388}], "name": "dromaeo_css", "value": 6932.872874680848}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [106.0, 110.0, 102.0, 109.0, 109.0, 113.0, 99.0, 110.0, 114.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [152.0, 127.0, 151.0, 163.0, 132.0, 153.0, 145.0, 132.0, 182.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 159.0, 161.0, 160.0, 160.0, 158.0, 163.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 83.0, 98.0, 72.0, 71.0, 73.0, 101.0, 92.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 127.0, 90.0, 90.0, 89.0, 135.0, 89.0, 89.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 102.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 63.0, 62.0, 61.0, 64.0, 63.0, 70.0, 59.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 62.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [96.0, 84.0, 87.0, 93.0, 83.0, 86.0, 86.0, 86.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.3}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 116.0, 114.0, 123.0, 118.0, 121.0, 125.0, 115.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [143.0, 142.0, 151.0, 157.0, 154.0, 142.0, 155.0, 152.0, 151.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 68.0, 67.0, 70.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1501.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.86644951140065], "unit": "score", "name": "Richards", "value": 216.75427999999994}, {"lowerIsBetter": false, "replicates": [188.57250612860645], "unit": "score", "name": "DeltaBlue", "value": 350.62375399999996}, {"lowerIsBetter": false, "replicates": [281.135788585887], "unit": "score", "name": "Encrypt", "value": 946.8058169999996}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [1949.317738791423], "unit": "score", "name": "RayTrace", "value": 379.61435700000015}, {"lowerIsBetter": false, "replicates": [775.1937984496124], "unit": "score", "name": "Earley", "value": 859.7372699999999}, {"lowerIsBetter": false, "replicates": [12108.43373493976], "unit": "score", "name": "Boyer", "value": 55.0412228855721}, {"lowerIsBetter": false, "replicates": [25692.30769230769], "unit": "score", "name": "RegExp", "value": 35.4575}, {"lowerIsBetter": false, "replicates": [597.5029726516052], "unit": "score", "name": "Splay", "value": 136.3859323383085}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20053.95276215909}]} 04:27:53 INFO - RETURN: dromaeo_css: 6932.87 04:27:53 INFO - RETURN: kraken: 1501.80 04:27:53 INFO - RETURN: v8_7: 20053.95 04:27:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20053.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1501.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6932.87"}}} 04:27:53 INFO - Return code: 0 04:27:53 INFO - # TBPL SUCCESS # 04:27:53 INFO - Running post-action listener: _resource_record_post_action 04:27:53 INFO - Running post-run listener: _resource_record_post_run 04:27:54 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508223488; Read time: 12; Write time: 478192 04:27:54 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 183033856; Read time: 0; Write time: 208872 04:27:54 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 266915840; Read time: 12; Write time: 138688 04:27:54 INFO - Running post-run listener: _upload_blobber_files 04:27:54 INFO - Blob upload gear active. 04:27:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:27:54 INFO - Copying logs to upload dir... 04:27:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.532946 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-21 04:27:53.920394) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 04:27:53.924253) ========= 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=fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010047 build_url: 'https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/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-21 04:27:53.976172) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:27:53.976639) ========= 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=fce1c2174958ee92775f70ae000001a3-1448084193.920346-1672909736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:27:54.026887) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 04:27:54.027260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 04:27:54.027580) ========= ========= Total master_lag: 0.24 =========