builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1448388559.32 results: success (0) buildid: 20151124083105 builduid: 5361e55555cf4e8cab2a1ae26210b216 revision: d516d82f29a2636c5834c7f3c932025b8e85a8ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.323783) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.324388) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.324703) ========= 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=004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005000 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.340918) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.341261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.362506) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.363175) ========= 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=004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.026818 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.412241) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.412548) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.412944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.413234) ========= 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=004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 10:09:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2015-11-24 10:09:19 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.238771 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.664290) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.664786) ========= 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=004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.077826 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.753014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:19.753415) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d516d82f29a2636c5834c7f3c932025b8e85a8ad --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 d516d82f29a2636c5834c7f3c932025b8e85a8ad --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=004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 10:09:19,913 truncating revision to first 12 chars 2015-11-24 10:09:19,913 Setting DEBUG logging. 2015-11-24 10:09:19,913 attempt 1/10 2015-11-24 10:09:19,913 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d516d82f29a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 10:09:20,145 unpacking tar archive at: fx-team-d516d82f29a2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.520551 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:20.286794) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:20.287125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:20.294479) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:20.294834) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 10:09:20.295287) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-24 10:09:20.295585) ========= /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=004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:09:20 INFO - MultiFileLogger online at 20151124 10:09:20 in /builds/slave/test-pgo 10:09:20 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 10:09:20 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:09:20 INFO - {'append_to_log': False, 10:09:20 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:09:20 INFO - 'blob_upload_branch': 'Fx-Team', 10:09:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:09:20 INFO - 'branch': 'Fx-Team', 10:09:20 INFO - 'buildbot_json_path': 'buildprops.json', 10:09:20 INFO - 'config_files': ('talos/linux_config.py',), 10:09:20 INFO - 'default_actions': ('clobber', 10:09:20 INFO - 'read-buildbot-config', 10:09:20 INFO - 'download-and-extract', 10:09:20 INFO - 'populate-webroot', 10:09:20 INFO - 'create-virtualenv', 10:09:20 INFO - 'install', 10:09:20 INFO - 'run-tests'), 10:09:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:09:20 INFO - 'download_minidump_stackwalk': True, 10:09:20 INFO - 'download_symbols': 'ondemand', 10:09:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:09:20 INFO - 'tooltool.py': '/tools/tooltool.py', 10:09:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:09:20 INFO - '/tools/misc-python/virtualenv.py')}, 10:09:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:09:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:09:20 INFO - 'installer_path': 'installer.exe', 10:09:20 INFO - 'log_level': 'info', 10:09:20 INFO - 'log_name': 'talos', 10:09:20 INFO - 'log_to_console': True, 10:09:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:09:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:09:20 INFO - 'opt_config_files': (), 10:09:20 INFO - 'pip_index': False, 10:09:20 INFO - 'sps_profile': False, 10:09:20 INFO - 'sps_profile_interval': 0, 10:09:20 INFO - 'suite': 'dromaeojs', 10:09:20 INFO - 'system_bits': '64', 10:09:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:09:20 INFO - 'title': 'talos-linux64-ix-066', 10:09:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:09:20 INFO - 'use_talos_json': True, 10:09:20 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:09:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:09:20 INFO - 'work_dir': 'build'} 10:09:20 INFO - ##### 10:09:20 INFO - ##### Running clobber step. 10:09:20 INFO - ##### 10:09:20 INFO - Running pre-action listener: _resource_record_pre_action 10:09:20 INFO - Running main action method: clobber 10:09:20 INFO - rmtree: /builds/slave/test-pgo/build 10:09:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:09:25 INFO - Running post-action listener: _resource_record_post_action 10:09:25 INFO - ##### 10:09:25 INFO - ##### Running read-buildbot-config step. 10:09:25 INFO - ##### 10:09:25 INFO - Running pre-action listener: _resource_record_pre_action 10:09:25 INFO - Running main action method: read_buildbot_config 10:09:25 INFO - Using buildbot properties: 10:09:25 INFO - { 10:09:25 INFO - "properties": { 10:09:25 INFO - "buildnumber": 513, 10:09:25 INFO - "product": "firefox", 10:09:25 INFO - "script_repo_revision": "production", 10:09:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:09:25 INFO - "repository": "", 10:09:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:09:25 INFO - "buildid": "20151124083105", 10:09:25 INFO - "slavename": "talos-linux64-ix-066", 10:09:25 INFO - "pgo_build": "True", 10:09:25 INFO - "basedir": "/builds/slave/test-pgo", 10:09:25 INFO - "project": "", 10:09:25 INFO - "platform": "ubuntu64_hw", 10:09:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:09:25 INFO - "slavebuilddir": "test", 10:09:25 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:09:25 INFO - "branch": "fx-team", 10:09:25 INFO - "repo_path": "integration/fx-team", 10:09:25 INFO - "stage_platform": "linux64-pgo", 10:09:25 INFO - "builduid": "5361e55555cf4e8cab2a1ae26210b216", 10:09:25 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 10:09:25 INFO - }, 10:09:25 INFO - "sourcestamp": { 10:09:25 INFO - "repository": "", 10:09:25 INFO - "hasPatch": false, 10:09:25 INFO - "project": "", 10:09:25 INFO - "branch": "fx-team-linux64-pgo-talos", 10:09:25 INFO - "changes": [ 10:09:25 INFO - { 10:09:25 INFO - "category": null, 10:09:25 INFO - "files": [ 10:09:25 INFO - { 10:09:25 INFO - "url": null, 10:09:25 INFO - "name": "https://queue.taskcluster.net/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:09:25 INFO - } 10:09:25 INFO - ], 10:09:25 INFO - "repository": "", 10:09:25 INFO - "rev": "d516d82f29a2636c5834c7f3c932025b8e85a8ad", 10:09:25 INFO - "who": "sendchange", 10:09:25 INFO - "when": 1448388101, 10:09:25 INFO - "number": 6701076, 10:09:25 INFO - "comments": "", 10:09:25 INFO - "project": "", 10:09:25 INFO - "at": "Tue 24 Nov 2015 10:01:41", 10:09:25 INFO - "branch": "fx-team-linux64-pgo-talos", 10:09:25 INFO - "revlink": "", 10:09:25 INFO - "properties": [ 10:09:25 INFO - [ 10:09:25 INFO - "buildid", 10:09:25 INFO - "20151124083105", 10:09:25 INFO - "Change" 10:09:25 INFO - ], 10:09:25 INFO - [ 10:09:25 INFO - "builduid", 10:09:25 INFO - "5361e55555cf4e8cab2a1ae26210b216", 10:09:25 INFO - "Change" 10:09:25 INFO - ], 10:09:25 INFO - [ 10:09:25 INFO - "pgo_build", 10:09:25 INFO - "True", 10:09:25 INFO - "Change" 10:09:25 INFO - ] 10:09:25 INFO - ], 10:09:25 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 10:09:25 INFO - } 10:09:25 INFO - ], 10:09:25 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 10:09:25 INFO - } 10:09:25 INFO - } 10:09:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:09:25 INFO - Running post-action listener: _resource_record_post_action 10:09:25 INFO - ##### 10:09:25 INFO - ##### Running download-and-extract step. 10:09:25 INFO - ##### 10:09:25 INFO - Running pre-action listener: _resource_record_pre_action 10:09:25 INFO - Running main action method: download_and_extract 10:09:25 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:25 INFO - https://queue.taskcluster.net/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:09:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/test_packages.json 10:09:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/test_packages.json 10:09:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:09:26 INFO - Downloaded 1302 bytes. 10:09:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:09:26 INFO - Using the following test package requirements: 10:09:26 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:09:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:09:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:26 INFO - u'jsshell-linux-x86_64.zip'], 10:09:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:09:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:09:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:09:26 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:09:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:09:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:09:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:09:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:26 INFO - https://queue.taskcluster.net/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:09:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:09:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:09:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/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 10:09:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/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 10:09:27 INFO - Downloaded 22525771 bytes. 10:09:27 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 10:09:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:09:27 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 10:09:28 INFO - Return code: 0 10:09:28 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 10:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:28 INFO - https://queue.taskcluster.net/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/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 10:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/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 10:09:29 INFO - Downloaded 22525771 bytes. 10:09:29 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 10:09:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:09:29 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 10:09:30 INFO - Return code: 0 10:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:30 INFO - https://queue.taskcluster.net/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:09:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/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 10:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/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 10:09:32 INFO - Downloaded 11130997 bytes. 10:09:32 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 10:09:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:32 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 10:09:32 INFO - Return code: 0 10:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:32 INFO - https://queue.taskcluster.net/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/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 10:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/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 10:09:34 INFO - Downloaded 57566572 bytes. 10:09:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:09:34 INFO - mkdir: /builds/slave/test-pgo/properties 10:09:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:09:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:09:34 INFO - Contents: 10:09:34 INFO - build_url:https://queue.taskcluster.net/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:09:34 INFO - Running post-action listener: _resource_record_post_action 10:09:34 INFO - Running post-action listener: set_extra_try_arguments 10:09:34 INFO - ##### 10:09:34 INFO - ##### Running populate-webroot step. 10:09:34 INFO - ##### 10:09:34 INFO - Running pre-action listener: _resource_record_pre_action 10:09:34 INFO - Running main action method: populate_webroot 10:09:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:09:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:09:34 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:09:34 INFO - '../fennec_ids.txt'], 10:09:34 INFO - 'tests': ['tcheck2']}, 10:09:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:09:34 INFO - '--tppagecycles', 10:09:34 INFO - '7'], 10:09:34 INFO - 'tests': ['tsvgm']}}, 10:09:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:09:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:09:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:09:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:09:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:09:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:09:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:34 INFO - 'talos_options': ['--e10s'], 10:09:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:34 INFO - 'tests': ['damp', 'tps']}, 10:09:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:34 INFO - 'talos_options': ['--e10s'], 10:09:34 INFO - 'tests': ['damp', 'tps']}, 10:09:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:09:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:09:34 INFO - 'other': {'tests': ['a11yr', 10:09:34 INFO - 'ts_paint', 10:09:34 INFO - 'tpaint', 10:09:34 INFO - 'sessionrestore', 10:09:34 INFO - 'sessionrestore_no_auto_restore']}, 10:09:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:09:34 INFO - 'tests': ['a11yr', 10:09:34 INFO - 'ts_paint', 10:09:34 INFO - 'tpaint', 10:09:34 INFO - 'sessionrestore', 10:09:34 INFO - 'sessionrestore_no_auto_restore']}, 10:09:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:09:34 INFO - 'tests': ['a11yr', 10:09:34 INFO - 'ts_paint', 10:09:34 INFO - 'tpaint', 10:09:34 INFO - 'sessionrestore', 10:09:34 INFO - 'sessionrestore_no_auto_restore']}, 10:09:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:09:34 INFO - 'tests': ['a11yr', 10:09:34 INFO - 'ts_paint', 10:09:34 INFO - 'tpaint', 10:09:34 INFO - 'sessionrestore', 10:09:34 INFO - 'sessionrestore_no_auto_restore']}, 10:09:34 INFO - 'other_l64': {'tests': ['a11yr', 10:09:34 INFO - 'ts_paint', 10:09:34 INFO - 'tpaint', 10:09:34 INFO - 'sessionrestore', 10:09:34 INFO - 'sessionrestore_no_auto_restore']}, 10:09:34 INFO - 'other_nol64': {'tests': ['a11yr', 10:09:34 INFO - 'ts_paint', 10:09:34 INFO - 'tpaint', 10:09:34 INFO - 'sessionrestore', 10:09:34 INFO - 'sessionrestore_no_auto_restore']}, 10:09:34 INFO - 'svgr': {'tests': ['tsvgx', 10:09:34 INFO - 'tsvgr_opacity', 10:09:34 INFO - 'tart', 10:09:34 INFO - 'tscrollx', 10:09:34 INFO - 'cart']}, 10:09:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:09:34 INFO - 'tests': ['tsvgx', 10:09:34 INFO - 'tsvgr_opacity', 10:09:34 INFO - 'tart', 10:09:34 INFO - 'tscrollx', 10:09:34 INFO - 'cart']}, 10:09:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:34 INFO - 'tests': ['tp5o']}, 10:09:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:34 INFO - 'talos_options': ['--e10s'], 10:09:34 INFO - 'tests': ['tp5o']}, 10:09:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:34 INFO - 'talos_options': ['--xperf_path', 10:09:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:34 INFO - 'tests': ['tp5n']}, 10:09:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:34 INFO - 'talos_options': ['--e10s', 10:09:34 INFO - '--xperf_path', 10:09:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:34 INFO - 'tests': ['tp5n']}}, 10:09:34 INFO - 'talos.zip': {'path': '', 10:09:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:09:34 INFO - Running post-action listener: _resource_record_post_action 10:09:34 INFO - ##### 10:09:34 INFO - ##### Running create-virtualenv step. 10:09:34 INFO - ##### 10:09:34 INFO - Running pre-action listener: _resource_record_pre_action 10:09:34 INFO - Running main action method: create_virtualenv 10:09:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:09:34 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 10:09:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:09:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:09:34 INFO - Using real prefix '/usr' 10:09:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:09:35 INFO - Installing distribute.............................................................................................................................................................................................done. 10:09:37 INFO - Installing pip.................done. 10:09:37 INFO - Return code: 0 10:09:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:09:37 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')]} 10:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:37 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')]} 10:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:37 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 0x7f4f9ef2ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72d70>, '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 0x1e73b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e73fb0>, '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': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', '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 10:09:37 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 10:09:37 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 10:09:37 INFO - Using env: {'DISPLAY': ':0', 10:09:37 INFO - 'HOME': '/home/cltbld', 10:09:37 INFO - 'LANG': 'en_US.UTF-8', 10:09:37 INFO - 'LANGUAGE': 'en_US:en', 10:09:37 INFO - 'LOGNAME': 'cltbld', 10:09:37 INFO - 'MAIL': '/var/mail/cltbld', 10:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:37 INFO - 'MOZ_NO_REMOTE': '1', 10:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:37 INFO - 'NO_EM_RESTART': '1', 10:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:09:37 INFO - 'PWD': '/builds/slave/test-pgo', 10:09:37 INFO - 'SHELL': '/bin/bash', 10:09:37 INFO - 'SHLVL': '1', 10:09:37 INFO - 'TERM': 'linux', 10:09:37 INFO - 'TMOUT': '86400', 10:09:37 INFO - 'USER': 'cltbld', 10:09:37 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', 10:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:37 INFO - '_': '/tools/buildbot/bin/python'} 10:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:37 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 10:09:37 INFO - Cleaning up... 10:09:37 INFO - Return code: 0 10:09:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:09:37 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')]} 10:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:37 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')]} 10:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:37 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 0x7f4f9ef2ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72d70>, '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 0x1e73b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e73fb0>, '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': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', '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 10:09:37 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 10:09:37 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 10:09:37 INFO - Using env: {'DISPLAY': ':0', 10:09:37 INFO - 'HOME': '/home/cltbld', 10:09:37 INFO - 'LANG': 'en_US.UTF-8', 10:09:37 INFO - 'LANGUAGE': 'en_US:en', 10:09:37 INFO - 'LOGNAME': 'cltbld', 10:09:37 INFO - 'MAIL': '/var/mail/cltbld', 10:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:37 INFO - 'MOZ_NO_REMOTE': '1', 10:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:37 INFO - 'NO_EM_RESTART': '1', 10:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:09:37 INFO - 'PWD': '/builds/slave/test-pgo', 10:09:37 INFO - 'SHELL': '/bin/bash', 10:09:37 INFO - 'SHLVL': '1', 10:09:37 INFO - 'TERM': 'linux', 10:09:37 INFO - 'TMOUT': '86400', 10:09:37 INFO - 'USER': 'cltbld', 10:09:37 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', 10:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:37 INFO - '_': '/tools/buildbot/bin/python'} 10:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:37 INFO - Downloading/unpacking psutil>=0.7.1 10:09:37 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 10:09:37 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 10:09:37 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 10:09:37 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 10:09:37 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 10:09:37 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 10:09:39 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:09:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:09:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:09:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:39 INFO - Installing collected packages: psutil 10:09:39 INFO - Running setup.py install for psutil 10:09:39 INFO - building 'psutil._psutil_linux' extension 10:09:39 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 10:09:39 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 10:09:39 INFO - building 'psutil._psutil_posix' extension 10:09:39 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 10:09:39 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 10:09:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:39 INFO - Successfully installed psutil 10:09:39 INFO - Cleaning up... 10:09:40 INFO - Return code: 0 10:09:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:09:40 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')]} 10:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:40 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')]} 10:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:40 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 0x7f4f9ef2ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72d70>, '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 0x1e73b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e73fb0>, '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': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', '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 10:09:40 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 10:09:40 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 10:09:40 INFO - Using env: {'DISPLAY': ':0', 10:09:40 INFO - 'HOME': '/home/cltbld', 10:09:40 INFO - 'LANG': 'en_US.UTF-8', 10:09:40 INFO - 'LANGUAGE': 'en_US:en', 10:09:40 INFO - 'LOGNAME': 'cltbld', 10:09:40 INFO - 'MAIL': '/var/mail/cltbld', 10:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:40 INFO - 'MOZ_NO_REMOTE': '1', 10:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:40 INFO - 'NO_EM_RESTART': '1', 10:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:09:40 INFO - 'PWD': '/builds/slave/test-pgo', 10:09:40 INFO - 'SHELL': '/bin/bash', 10:09:40 INFO - 'SHLVL': '1', 10:09:40 INFO - 'TERM': 'linux', 10:09:40 INFO - 'TMOUT': '86400', 10:09:40 INFO - 'USER': 'cltbld', 10:09:40 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', 10:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:40 INFO - '_': '/tools/buildbot/bin/python'} 10:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:09:40 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 10:09:40 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 10:09:40 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 10:09:40 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 10:09:40 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 10:09:40 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 10:09:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:09:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:09:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:09:41 INFO - Installing collected packages: mozsystemmonitor 10:09:41 INFO - Running setup.py install for mozsystemmonitor 10:09:42 INFO - Successfully installed mozsystemmonitor 10:09:42 INFO - Cleaning up... 10:09:42 INFO - Return code: 0 10:09:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:09: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')]} 10:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:42 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 0x7f4f9ef2ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72d70>, '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 0x1e73b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e73fb0>, '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': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', '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 10:09:42 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 10:09:42 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 10:09:42 INFO - Using env: {'DISPLAY': ':0', 10:09:42 INFO - 'HOME': '/home/cltbld', 10:09:42 INFO - 'LANG': 'en_US.UTF-8', 10:09:42 INFO - 'LANGUAGE': 'en_US:en', 10:09:42 INFO - 'LOGNAME': 'cltbld', 10:09:42 INFO - 'MAIL': '/var/mail/cltbld', 10:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:42 INFO - 'MOZ_NO_REMOTE': '1', 10:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:42 INFO - 'NO_EM_RESTART': '1', 10:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:09:42 INFO - 'PWD': '/builds/slave/test-pgo', 10:09:42 INFO - 'SHELL': '/bin/bash', 10:09:42 INFO - 'SHLVL': '1', 10:09:42 INFO - 'TERM': 'linux', 10:09:42 INFO - 'TMOUT': '86400', 10:09:42 INFO - 'USER': 'cltbld', 10:09:42 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', 10:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:42 INFO - '_': '/tools/buildbot/bin/python'} 10:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:42 INFO - Downloading/unpacking blobuploader==1.2.4 10:09:42 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 10:09:42 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 10:09:42 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 10:09:42 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 10:09:42 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 10:09:42 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 10:09:43 INFO - Downloading blobuploader-1.2.4.tar.gz 10:09:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:09:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:09:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:09:44 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 10:09:44 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 10:09:44 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 10:09:44 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 10:09:44 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 10:09:44 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 10:09:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:09:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:09:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:09:44 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 10:09:44 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 10:09:44 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 10:09:44 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 10:09:44 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 10:09:44 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 10:09:44 INFO - Downloading docopt-0.6.1.tar.gz 10:09:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:09:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:09:44 INFO - Installing collected packages: blobuploader, requests, docopt 10:09:44 INFO - Running setup.py install for blobuploader 10:09:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:09:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:09:44 INFO - Running setup.py install for requests 10:09:45 INFO - Running setup.py install for docopt 10:09:45 INFO - Successfully installed blobuploader requests docopt 10:09:45 INFO - Cleaning up... 10:09:45 INFO - Return code: 0 10:09:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:09:45 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')]} 10:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:45 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')]} 10:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:45 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 0x7f4f9ef2ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72d70>, '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 0x1e73b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e73fb0>, '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': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', '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 10:09:45 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 10:09:45 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 10:09:45 INFO - Using env: {'DISPLAY': ':0', 10:09:45 INFO - 'HOME': '/home/cltbld', 10:09:45 INFO - 'LANG': 'en_US.UTF-8', 10:09:45 INFO - 'LANGUAGE': 'en_US:en', 10:09:45 INFO - 'LOGNAME': 'cltbld', 10:09:45 INFO - 'MAIL': '/var/mail/cltbld', 10:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:45 INFO - 'MOZ_NO_REMOTE': '1', 10:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:45 INFO - 'NO_EM_RESTART': '1', 10:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:09:45 INFO - 'PWD': '/builds/slave/test-pgo', 10:09:45 INFO - 'SHELL': '/bin/bash', 10:09:45 INFO - 'SHLVL': '1', 10:09:45 INFO - 'TERM': 'linux', 10:09:45 INFO - 'TMOUT': '86400', 10:09:45 INFO - 'USER': 'cltbld', 10:09:45 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', 10:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:45 INFO - '_': '/tools/buildbot/bin/python'} 10:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:09:45 INFO - Running setup.py (path:/tmp/pip-mlvgFV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:09:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:09:45 INFO - Running setup.py (path:/tmp/pip-2stkej-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:09:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:09:45 INFO - Running setup.py (path:/tmp/pip-X87G2o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:09:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:09:45 INFO - Running setup.py (path:/tmp/pip-znzIt4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:09:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:09:45 INFO - Running setup.py (path:/tmp/pip-ZdpQIf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:09:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:09:45 INFO - Running setup.py (path:/tmp/pip-AI0X8P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:09:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:09:45 INFO - Running setup.py (path:/tmp/pip-z2pCSE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:09:46 INFO - Running setup.py (path:/tmp/pip-c_4fCH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:09:46 INFO - Running setup.py (path:/tmp/pip-jbASX0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:09:46 INFO - Running setup.py (path:/tmp/pip-VWJxv7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:09:46 INFO - Running setup.py (path:/tmp/pip-j7brQi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:09:46 INFO - Running setup.py (path:/tmp/pip-7D7AZf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:09:46 INFO - Running setup.py (path:/tmp/pip-moi7X9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:09:46 INFO - Running setup.py (path:/tmp/pip-aAajaC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:09:46 INFO - Running setup.py (path:/tmp/pip-PTW6UM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:09:46 INFO - Running setup.py (path:/tmp/pip-Lp6HrB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:09:46 INFO - Running setup.py (path:/tmp/pip-tVbuk6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:09:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:09:46 INFO - Running setup.py install for manifestparser 10:09:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:09:46 INFO - Running setup.py install for mozcrash 10:09:46 INFO - Running setup.py install for mozdebug 10:09:47 INFO - Running setup.py install for mozdevice 10:09:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:09:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:09:47 INFO - Running setup.py install for mozfile 10:09:47 INFO - Running setup.py install for mozhttpd 10:09:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:09:47 INFO - Running setup.py install for mozinfo 10:09:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:09:47 INFO - Running setup.py install for mozInstall 10:09:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:09:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:09:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:09:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:09:47 INFO - Running setup.py install for mozleak 10:09:47 INFO - Running setup.py install for mozlog 10:09:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:09:47 INFO - Running setup.py install for moznetwork 10:09:47 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:09:47 INFO - Running setup.py install for mozprocess 10:09:48 INFO - Running setup.py install for mozprofile 10:09:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:09:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:09:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:09:48 INFO - Running setup.py install for mozrunner 10:09:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:09:48 INFO - Running setup.py install for mozscreenshot 10:09:48 INFO - Running setup.py install for moztest 10:09:48 INFO - Running setup.py install for mozversion 10:09:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:09:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:09:48 INFO - Cleaning up... 10:09:48 INFO - Return code: 0 10:09:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:09:48 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')]} 10:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:48 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')]} 10:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:48 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 0x7f4f9ef2ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72d70>, '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 0x1e73b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e73fb0>, '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': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', '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 10:09:48 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 10:09:48 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 10:09:48 INFO - Using env: {'DISPLAY': ':0', 10:09:48 INFO - 'HOME': '/home/cltbld', 10:09:48 INFO - 'LANG': 'en_US.UTF-8', 10:09:48 INFO - 'LANGUAGE': 'en_US:en', 10:09:48 INFO - 'LOGNAME': 'cltbld', 10:09:48 INFO - 'MAIL': '/var/mail/cltbld', 10:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:48 INFO - 'MOZ_NO_REMOTE': '1', 10:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:48 INFO - 'NO_EM_RESTART': '1', 10:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:09:48 INFO - 'PWD': '/builds/slave/test-pgo', 10:09:48 INFO - 'SHELL': '/bin/bash', 10:09:48 INFO - 'SHLVL': '1', 10:09:48 INFO - 'TERM': 'linux', 10:09:48 INFO - 'TMOUT': '86400', 10:09:48 INFO - 'USER': 'cltbld', 10:09:48 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', 10:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:48 INFO - '_': '/tools/buildbot/bin/python'} 10:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:09:48 INFO - Running setup.py (path:/tmp/pip-IUiPSW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:09:48 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)) 10:09:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:09:48 INFO - Running setup.py (path:/tmp/pip-iVnSWd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:09:48 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)) 10:09:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:09:48 INFO - Running setup.py (path:/tmp/pip-btUOgo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:09:48 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)) 10:09:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:09:49 INFO - Running setup.py (path:/tmp/pip-kfCmxM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:09:49 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)) 10:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:09:49 INFO - Running setup.py (path:/tmp/pip-C3T_xR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:09:49 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)) 10:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:09:49 INFO - Running setup.py (path:/tmp/pip-dx1JrN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:09:49 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)) 10:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:09:49 INFO - Running setup.py (path:/tmp/pip-VlW_UH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:09:49 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)) 10:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:09:49 INFO - Running setup.py (path:/tmp/pip-caL__X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:09:49 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)) 10:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:09:49 INFO - Running setup.py (path:/tmp/pip-YJKqgG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:09:49 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)) 10:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:09:49 INFO - Running setup.py (path:/tmp/pip-uqK3VQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:09:49 INFO - Running setup.py (path:/tmp/pip-1iv9sm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:09:49 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)) 10:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:09:49 INFO - Running setup.py (path:/tmp/pip-DbgSz1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:09:49 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)) 10:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:09:49 INFO - Running setup.py (path:/tmp/pip-eFvJcY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:09:49 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)) 10:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:09:49 INFO - Running setup.py (path:/tmp/pip-JrhraN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:09:49 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)) 10:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:09:49 INFO - Running setup.py (path:/tmp/pip-_sd0x1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:09:49 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)) 10:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:09:49 INFO - Running setup.py (path:/tmp/pip-3uU2fU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:09:49 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)) 10:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:09:49 INFO - Running setup.py (path:/tmp/pip-zz28kr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:09:50 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)) 10:09:50 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)) 10:09:50 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)) 10:09:50 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)) 10:09:50 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)) 10:09:50 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)) 10:09:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:50 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 10:09:50 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 10:09:50 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 10:09:50 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 10:09:50 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 10:09:50 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 10:09:51 INFO - Downloading blessings-1.5.1.tar.gz 10:09:51 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 10:09:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:09:51 INFO - Installing collected packages: blessings 10:09:51 INFO - Running setup.py install for blessings 10:09:51 INFO - Successfully installed blessings 10:09:51 INFO - Cleaning up... 10:09:52 INFO - Return code: 0 10:09:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:09:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:09:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:09:52 INFO - Reading from file tmpfile_stdout 10:09:52 INFO - Current package versions: 10:09:52 INFO - argparse == 1.2.1 10:09:52 INFO - blessings == 1.5.1 10:09:52 INFO - blobuploader == 1.2.4 10:09:52 INFO - docopt == 0.6.1 10:09:52 INFO - manifestparser == 1.1 10:09:52 INFO - mozInstall == 1.12 10:09:52 INFO - mozcrash == 0.16 10:09:52 INFO - mozdebug == 0.1 10:09:52 INFO - mozdevice == 0.47 10:09:52 INFO - mozfile == 1.2 10:09:52 INFO - mozhttpd == 0.7 10:09:52 INFO - mozinfo == 0.9 10:09:52 INFO - mozleak == 0.1 10:09:52 INFO - mozlog == 3.1 10:09:52 INFO - moznetwork == 0.27 10:09:52 INFO - mozprocess == 0.22 10:09:52 INFO - mozprofile == 0.27 10:09:52 INFO - mozrunner == 6.11 10:09:52 INFO - mozscreenshot == 0.1 10:09:52 INFO - mozsystemmonitor == 0.0 10:09:52 INFO - moztest == 0.7 10:09:52 INFO - mozversion == 1.4 10:09:52 INFO - psutil == 3.1.1 10:09:52 INFO - requests == 1.2.3 10:09:52 INFO - wsgiref == 0.1.2 10:09:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:09:52 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')]} 10:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:52 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')]} 10:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:52 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 0x7f4f9ef2ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72d70>, '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 0x1e73b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e73fb0>, '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': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', '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 10:09:52 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 10:09:52 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 10:09:52 INFO - Using env: {'DISPLAY': ':0', 10:09:52 INFO - 'HOME': '/home/cltbld', 10:09:52 INFO - 'LANG': 'en_US.UTF-8', 10:09:52 INFO - 'LANGUAGE': 'en_US:en', 10:09:52 INFO - 'LOGNAME': 'cltbld', 10:09:52 INFO - 'MAIL': '/var/mail/cltbld', 10:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:52 INFO - 'MOZ_NO_REMOTE': '1', 10:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:52 INFO - 'NO_EM_RESTART': '1', 10:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:09:52 INFO - 'PWD': '/builds/slave/test-pgo', 10:09:52 INFO - 'SHELL': '/bin/bash', 10:09:52 INFO - 'SHLVL': '1', 10:09:52 INFO - 'TERM': 'linux', 10:09:52 INFO - 'TMOUT': '86400', 10:09:52 INFO - 'USER': 'cltbld', 10:09:52 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', 10:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:52 INFO - '_': '/tools/buildbot/bin/python'} 10:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:52 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)) 10:09:52 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)) 10:09:52 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)) 10:09:52 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)) 10:09:52 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)) 10:09:52 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)) 10:09:52 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)) 10:09:52 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)) 10:09:52 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)) 10:09:52 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)) 10:09:52 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)) 10:09:52 INFO - Cleaning up... 10:09:52 INFO - Return code: 0 10:09:52 INFO - Running post-action listener: _resource_record_post_action 10:09:52 INFO - Running post-action listener: _start_resource_monitoring 10:09:52 INFO - Starting resource monitoring. 10:09:52 INFO - ##### 10:09:52 INFO - ##### Running install step. 10:09:52 INFO - ##### 10:09:52 INFO - Running pre-action listener: _resource_record_pre_action 10:09:52 INFO - Running main action method: install 10:09:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:09:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:09:52 INFO - Reading from file tmpfile_stdout 10:09:52 INFO - Detecting whether we're running mozinstall >=1.0... 10:09:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:09:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:09:52 INFO - Reading from file tmpfile_stdout 10:09:52 INFO - Output received: 10:09:52 INFO - Usage: mozinstall [options] installer 10:09:52 INFO - Options: 10:09:52 INFO - -h, --help show this help message and exit 10:09:52 INFO - -d DEST, --destination=DEST 10:09:52 INFO - Directory to install application into. [default: 10:09:52 INFO - "/builds/slave/test-pgo"] 10:09:52 INFO - --app=APP Application being installed. [default: firefox] 10:09:52 INFO - mkdir: /builds/slave/test-pgo/build/application 10:09:52 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'] 10:09:52 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 10:10:07 INFO - Reading from file tmpfile_stdout 10:10:07 INFO - Output received: 10:10:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:10:07 INFO - Running post-action listener: _resource_record_post_action 10:10:07 INFO - ##### 10:10:07 INFO - ##### Running run-tests step. 10:10:07 INFO - ##### 10:10:07 INFO - Running pre-action listener: _resource_record_pre_action 10:10:07 INFO - Running main action method: run_tests 10:10:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:10:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:10:07 INFO - Python 2.7.3 10:10:07 INFO - Return code: 0 10:10:07 INFO - grabbing minidump binary from tooltool 10:10: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')]} 10:10:07 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 0x1e72d70>, '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 0x1e73b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e73fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:10:07 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 10:10:07 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 10:10:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:10:07 INFO - Return code: 0 10:10:07 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:10:07 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:10:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:10:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:10:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:10:07 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/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:10:07 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/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost 10:10:07 INFO - Using env: {'DISPLAY': ':0', 10:10:07 INFO - 'HOME': '/home/cltbld', 10:10:07 INFO - 'LANG': 'en_US.UTF-8', 10:10:07 INFO - 'LANGUAGE': 'en_US:en', 10:10:07 INFO - 'LOGNAME': 'cltbld', 10:10:07 INFO - 'MAIL': '/var/mail/cltbld', 10:10:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:10:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:07 INFO - 'MOZ_NO_REMOTE': '1', 10:10:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:07 INFO - 'NO_EM_RESTART': '1', 10:10:07 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:10:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:10:07 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:10:07 INFO - 'SHELL': '/bin/bash', 10:10:07 INFO - 'SHLVL': '1', 10:10:07 INFO - 'TERM': 'linux', 10:10:07 INFO - 'TMOUT': '86400', 10:10:07 INFO - 'USER': 'cltbld', 10:10:07 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664', 10:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:07 INFO - '_': '/tools/buildbot/bin/python'} 10:10:07 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/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] with output_timeout 3600 10:10:07 INFO - mozversion INFO | application_buildid: 20151124083105 10:10:07 INFO - mozversion INFO | application_changeset: d516d82f29a2636c5834c7f3c932025b8e85a8ad 10:10:07 INFO - mozversion INFO | application_display_name: Nightly 10:10:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:10:07 INFO - mozversion INFO | application_name: Firefox 10:10:07 INFO - mozversion INFO | application_remotingname: firefox 10:10:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:10:07 INFO - mozversion INFO | application_vendor: Mozilla 10:10:07 INFO - mozversion INFO | application_version: 45.0a1 10:10:07 INFO - mozversion INFO | platform_buildid: 20151124083105 10:10:07 INFO - mozversion INFO | platform_changeset: d516d82f29a2636c5834c7f3c932025b8e85a8ad 10:10:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:10:07 INFO - mozversion INFO | platform_version: 45.0a1 10:10:07 INFO - 2015-11-24 10:10:07,545 DEBUG : using testdate: 1448388607 10:10:07 INFO - 2015-11-24 10:10:07,545 DEBUG : actual date: 1448388607 10:10:07 INFO - 2015-11-24 10:10:07,553 INFO : starting webserver on 'localhost:60380' 10:10:07 INFO - 2015-11-24 10:10:07,554 INFO : Starting test suite talos-linux64-ix-066 10:10:07 INFO - 2015-11-24 10:10:07,554 INFO : Starting test dromaeo_css 10:10:07 INFO - 2015-11-24 10:10:07,554 DEBUG : operating with platform_type : linux_ 10:10:07 INFO - 2015-11-24 10:10:07,554 INFO : Initialising browser for dromaeo_css test... 10:10:07 INFO - 2015-11-24 10:10:07,569 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4SVjQr/profile http://localhost:60380/getInfo.html 10:10:12 INFO - 2015-11-24 10:10:12,556 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:10:12 INFO - 2015-11-24 10:10:12,556 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:10:12 INFO - 2015-11-24 10:10:12,556 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:10:12 INFO - 2015-11-24 10:10:12,556 DEBUG : BROWSER_OUTPUT: __metrics 10:10:12 INFO - 2015-11-24 10:10:12,644 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:13 INFO - 2015-11-24 10:10:13,889 INFO : Browser initialized. 10:10:13 INFO - 2015-11-24 10:10:13,889 INFO : Running cycle 1/1 for dromaeo_css test... 10:10:13 INFO - 2015-11-24 10:10:13,889 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4SVjQr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:10:25 INFO - 2015-11-24 10:10:25,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 140333056 10:10:25 INFO - 2015-11-24 10:10:25,683 DEBUG : BROWSER_OUTPUT: 10:11:17 INFO - 2015-11-24 10:11:17,587 DEBUG : BROWSER_OUTPUT: 1448388677582 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] 10:13:25 INFO - 2015-11-24 10:13:25,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60380/tests/dromaeo/cssquery-ext.html) 10:13:27 INFO - 2015-11-24 10:13:27,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 308125696 10:13:27 INFO - 2015-11-24 10:13:27,562 DEBUG : BROWSER_OUTPUT: 10:16:30 INFO - 2015-11-24 10:16:30,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/dromaeo/cssquery-ext.html (next: http://localhost:60380/tests/dromaeo/cssquery-jquery.html) 10:16:30 INFO - 2015-11-24 10:16:30,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 233623552 10:16:30 INFO - 2015-11-24 10:16:30,756 DEBUG : BROWSER_OUTPUT: 10:19:32 INFO - 2015-11-24 10:19:32,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60380/tests/dromaeo/cssquery-mootools.html) 10:19:33 INFO - 2015-11-24 10:19:33,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 227794944 10:19:33 INFO - 2015-11-24 10:19:33,282 DEBUG : BROWSER_OUTPUT: 10:22:35 INFO - 2015-11-24 10:22:35,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60380/tests/dromaeo/cssquery-prototype.html) 10:22:35 INFO - 2015-11-24 10:22:35,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 204521472 10:22:35 INFO - 2015-11-24 10:22:35,764 DEBUG : BROWSER_OUTPUT: 10:25:38 INFO - 2015-11-24 10:25:38,219 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60380/tests/dromaeo/cssquery-yui.html) 10:25:38 INFO - 2015-11-24 10:25:38,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 208805888 10:25:38 INFO - 2015-11-24 10:25:38,806 DEBUG : BROWSER_OUTPUT: 10:28:41 INFO - 2015-11-24 10:28:41,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/dromaeo/cssquery-yui.html (next: http://localhost:60380/tests/dromaeo/cssquery-dojo.html) 10:28:41 INFO - 2015-11-24 10:28:41,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 235679744 10:28:41 INFO - 2015-11-24 10:28:41,812 DEBUG : BROWSER_OUTPUT: 10:28:41 INFO - 2015-11-24 10:28:41,812 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:28:41 INFO - 2015-11-24 10:28:41,812 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:28:41 INFO - 2015-11-24 10:28:41,812 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:28:41 INFO - 2015-11-24 10:28:41,812 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:28:41 INFO - 2015-11-24 10:28:41,812 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3179.1893067267843;3261.8042917424973;3284.3267130238287;3304.917377065573;3316.5191047298144;5318.149096144618;5400.945990540094;5402.594805389596;5435.1847222916585;5457.863553411166;5469.316335458067;5469.453054694529;5470.370907345657;5483.945160548394;5485.890282194354;4992.600591952653;5025.14572522672;5041.092603331399;5051.772670229849;5083.059633967728;5070.7464626768515;5125.179971204608;5152.381714194302;5156.896862062757;5159.332321699552;5122.513361230677;5149.330587023682;5168.819091331804;5174.379074511064;5185.87035324118;4910.779014944301;4921.753912304406;5023.196288593844;5060.240963855451;5127.589792816566;4974.850754477371;4999.275105109775;5010.323606313137;5022.824201152978;5030.094582975063;5266.131088370453;5275.208718692227;5304.071787437221;5311.415744268127;5331.2003199519995;5752.36723960364;5836.299644042742;5859.4140585941495;5860.765569377219;5920.378360272195;5987.670678112702;6047.81296984058;6061.120373790737;6067.848303792441;6074.240719910012;5608.775648974036;5610.438956104357;5613.775448982076;5621.381648018714;5648.491635752802;5868.061110222344;5923.466887980103;6023.216981792339;6026.397360263939;6080.087986802015;5826.067829147316;5831.912521312183;5846.093855452412;5848.561357898175;5880.470757631833;5877.20171161313;5893.263342082239;5896.882062358729;5907.940920590739;5908.734106965197;5666.660000399989;5766.769329226868;5777.220075289866;5909.763609455659;5926.703664816742;5914.142449344907;5948.078047902582;5950.077737950624;5962.880742385215;6001.4298641628975;4535.909281814411;4571.679982401267;4574.08518296342;4583.083383323348;4620.861374158781;3979.144483935968;3997.200559887976;4075.2053349597136;4076.144009757984;4088.4071809587444;5605.915911261334;5608.158776183605;5617.747201375948;5618.157276408571;5620.91568626471;5965.850853728604;5968;5972.58191926561;5983.850403739854;5995;5427.3215848019;5500.28496295479;5560.388357280696;5581.5255703265675;5592.356878958891;5067.721275329818;5088.084144853888;5117.437081920985;5122.385313762298;5165.405978312467;6135.263768347827;6161.168242287324;6168.352323006109;6172.074188871795;6172.105044768484;5740.856478587902;5877.382874798084;5879.235699359227;5987.251593550806;5999.370066143167;5951.910721339097;6056.242969628796;6066.605670631395;6081.817545473643;6101.176341194059;5864.149698293809;5878.853028674317;5879.147523609138;5881.05903055509;5883.735231914488;5812.76748930055;5880;5974.133750606225;5984.700764961822;5997.610155340063;5748.338941021836;5773.595848290579;5779.537636989115;5785.0454674978155;5792.7103644818435;5767.942320576741;5781.710914454176;5783.045797443543;5783.595148339576;5792.986227410271;5652.830415087554;5690.146478028329;5693.259876216065;5695.857603559944;5702.572307077069;5786.161006653927;5811.56413269015;5814.389489103753;5819.039858423482;5969.3732158122775;5740.770369185186;5746.597738158289;5751.137329400456;5756.366799651951;5777.62445441045 10:28:41 INFO - 2015-11-24 10:28:41,816 DEBUG : BROWSER_OUTPUT: |1;ext.html;590.9556783241258;600.4175949329152;601.4466690644607;601.7653115285038;617.2839506172841;31204;38681.80659096704;40073.79963100188;40102.79948600253;40107.59892401075;42554.787226063905;42965.570344296546;43052.784736076275;43265;43357.34963975535;7569.924300756977;7722.227777222261;8719.302455803536;8807.735767926972;8827;10438.791224175511;10725.14198864089;10741.731456713567;10743.892561074406;10746.408947507884;10422.374657520535;10546;10546.894531054668;10552.155827533818;10555.525001374957;7746.225377462265;7918.604069796487;10431.739206519822;10526.578936842556;10566.418846963414;10281.074703276741;10388.220883433773;10410.063094321547;10427.374357538572;10430.634927777568;39507.20985580272;39920.401193982114;39945.60054399477;39954.20091598152;39983;3256.3975664501904;3312.834358282076;3372.6458721834347;3655.342038433081;3761.1349389640263;29944.251393715112;30364.392712145855;30817.845910770528;30964.535531967038;31337.84331078353;3739.2147648993746;3790.355639541257;3840.4047372657283;3870.4000879863665;3934.8229329680235;267751;268465.999999998;268614;269130;269518;54725;57523.71238143783;57872;58209;63007;59557.702211488664;59797.40202597919;59922.40077599168;59930.400695993354;59988.40011599915;16150.353985840435;16291.266892989845;16366.918165409335;16447.342106315853;16450.835491645168;12165;12171.939140304241;12265.325407102517;12337.444814983168;12381.442835072443;19434.12546435414;19563.60872782565;19661.72198807073;19666.901665491867;19777.110030048683;7542.509736867196;7720.189380115007;7791.259830316111;7835.2948234658015;7860.764177074697;946.2309957812548;988.7478692933256;1029.6550655530332;1039.8336266197523;1090.4275255490932;27962.161135165978;28273.858630707127;28356.291092722433;28555.143345699664;28648;945.4516380499294;980.9944806573177;1044.2951008069522;1134.7049767060623;1189.423129782055;15575.532734017997;16073.598160045858;16201.189940502927;16226;16387.754183687255;353072;358070;358075;358385;358426;53827.19259211115;54283.72858135684;54386.72806636021;54481;54483.72758136184;1219.1709637446622;1275.9489620415266;1296.2999980010688;1380.2822532282955;1402.2427888939858;29274.56088158722;30642.693573063985;32033.359332813678;32606.51090233601;32745.34509309848;43121.7843910791;44251.33622995593;49990.50009500004;50507;50731.746341269536;309333;309772;313109;313616;314045;38948;39489.802550987064;39576;39583.60416395799;40441.39337909875;44724.32913506365;44955;45077;45767.54232457633;45875;37370.25259494849;38587.421188681634;38720.612793872824;38883;39557.60442395539;38018;38060.619393805704;38244.61755382522;38634;38728.80635596804;36812.815935920145;37496.62503374931;37572.43641345327;37654.435183472815;37798;32947.34105317928;33764.662353377134;34596;34656.65343346534;34955.650443496255;25872.482550349265;26012;26016.479670406865;26281.342966425993;26445.33886652849 10:28:41 INFO - 2015-11-24 10:28:41,817 DEBUG : BROWSER_OUTPUT: |2;jquery.html;336.3877742508634;337.5763416911776;341.63615749227057;341.6941837055835;341.93845107880577;14303;14630.268486575682;16503.917480412612;16792.91603541982;18457.723134153;16069;16150.83849161508;16156.192190390462;16156.596085097879;16239.675206495864;4561.863144105682;4716;4717.127331443677;4718.339432479455;4722.527747225267;3732.944005839901;3806.8477260909667;4681.625469962411;5246.895062098775;5375.838724838241;5273.129933560957;5292.285541451894;5308.867278318035;5355.973220133913;5357.169638705987;5051.141305977974;5188.558972487343;5192.143296356116;5196.272521846944;5280.603954703393;4794.089123066641;4911.926321105187;4983.426905905795;4994.300797888299;5003.2995380646735;11840.11199160058;11950.282983021047;11983.161178717493;14461.49384771528;19524.609507809906;1820.0343628880778;2079.4489460293034;2085.3326935380683;2197.48359135603;2212.048819007826;9262.166405023512;9396.67111651089;13844.446222151102;13980.091294065853;14245.216513091777;1813.3018787766673;1861.9813801861944;1867.5704587944713;1892.1958167778776;1895.0998275819013;70715;72214;75146.62426687831;75393.24606753918;76396;15913.124778137082;15915.204239787965;15947.920260398623;15962.04227746339;16113.274902629175;24540;24774.628380574304;24891.25326240216;24916.5016699665;24919.750802492104;8932.06017998037;9591.280653950982;9637.614495420105;9666.903330966601;9694.36986595869;8258.25675689191;8289.378296627778;8304.875426868603;8362.79093022667;8375.874361884577;7906.52560846351;7931.444798864024;7980.321672657773;7999.36005119589;8101.6354264058255;1785.9374921877932;1791.4446521578093;1818.072782880714;1828.1955939386894;2218.6022805632347;912.7763697894059;925.4493576322078;932.0586207929904;939.196986576481;1016.3952448293254;10232.232582556338;10625.893741062646;10651.520681569347;16893.324267029428;17581.7362739559;414.4239507085154;415.15930241261685;415.92929202035725;418.7278269125032;427.2800331441531;5423.888102938967;5427.972860135674;5429.4027656957705;5480.7533660985355;5567.554595632339;468069;475386;475608;479108;490299;62519.6874015627;75733.621331893;77376;81078;82698.58650706828;478.23004962011134;484.59536287199876;487.07455833915844;488.27978731371655;488.28222512906683;9664.468454235084;9696.321257512189;9723.951380243054;9865.506724663595;9880.654177103766;35352.46971295381;36181;36783.81608091942;37046.71968190855;37941;47029;47427;49478.01043979028;49812.75093624509;51174.74412627913;9585.664501742405;9631.759206019906;9794.559244834141;9815.901840981498;9824.21406287481;11399.544018239509;16494.83505164933;17259.223334949707;17549.298028078734;17591.560210994827;13819.86180138226;13948.651283717581;13962;14523.419063237352;14613.707725845636;14645.707085858436;14679.55961321162;14848.85151148518;15017.924910375377;15205.771913421086;14989.700205995601;15355.23223838826;15425;15623.375064997274;15698.686026279638;9151.954240228757;9165.358424910191;9309.813803724022;9389.10803473669;9426.528673566432;9457.527123643653;9549.474778887228;10761.289679076253;14862.628434289229;14969.251537422868 10:28:41 INFO - 2015-11-24 10:28:41,821 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1303.3157592264054;1674.9665006699865;1714.5542159038655;1738.0440757583326;1740.5996620777214;6453.4837213022965;7136.500444968848;7287.27127287271;7297.781066567998;7310.817229569264;7186.964065179667;7288.489805713602;7306.305900939416;7314.195438501773;7317.158526769423;1959.7942216067322;1985.583027564206;1991.1239054815908;2218.6561083032116;2237.339984704516;2226.588081204974;2255.605269077913;2256.4697296135396;2256.8871556422196;2259.1302348595746;2157.10480150738;2179.2808373236794;2210.8894555272254;2228.5320082782637;2235.619944609412;1985.583027564206;2037.775844657094;2153.440105572555;2156.3315372234656;2183.344996501043;2145.442185031887;2167.436466518701;2170.40313913675;2172.9891350543303;2180.2042254577123;7299.854002919965;7357.632118394059;7413.518121322097;7427.888581671279;7447.7393291235085;4519.909601807978;4587.944772702263;4597.103564804865;4622.768861556909;4628.5371462853445;2998.700129986984;3017.788754787166;3039.969600304013;3041.17888170195;3180.475221588435;955.7419496735843;969.8011907558933;984.916282116021;1000.4247557654378;1015.3856916565445;9922.404655720751;9956.601735930626;9966.003399660049;9973.950130249375;9987.850182247272;4071.3892916062828;4157.48031496063;4177.164567086595;4208.305629571148;4210.789460526961;8565.443246189103;8595.5702214889;8598.5700714964;8599;8600.612972416131;4631.282151266559;4632.467266264355;4633.7683115844075;4634.930476042862;4636.652251081183;4208.452901122834;4223.176480586256;4223.72545784523;4225.661947044229;4229.851955181553;3588.1567831559564;3624.075860655516;3662.6520480554304;3671.375866102769;3678.5401824771902;1181.4033912873945;1199.7600479904054;1200.0939290835363;1212.1878341511033;1234.7653945750278;1046.419237323293;1070.9625163119254;1071.7588542577857;1198.8920997110301;1309.0247765414827;6409.294977552466;6556.4427023702565;6932.202796678446;7132.572045677276;7132.786016419515;549.1954286969609;560.1681502968089;561.4077148608176;564.2720890051869;569.1832220763135;5471.781128754885;5473.425290344536;5492.80775172875;5516.779328826882;5519;8229.835403291901;8589.226969572643;8684.2184203422;8699.956500217584;8703.43427677199;8561.44350617208;8589.957050214834;8623.094575069654;8625.13748625145;8642.827143457222;6698.631575263407;6817.5227734059135;6940.271271516418;6950.791476255821;6973.860522789516;6642.6014439133805;6676.899846502403;6677.165354330708;6679.265280819203;6680.799576012728;7542.208068152765;7758.107817601048;7785.92214077852;7792.922070779219;7910.485818421784;7749.961250193713;7771.378289736695;7818.0618325799;7851.371890248881;7883.448158628841;6318.336574659595;6438.581492202992;6448.097266382804;6476.190476190476;6499.447546958561;7092.751753688803;7144.3927266182955;7174.8565028698085;7205.891911621225;7225.5664660120565;6720.764773232913;6758.4931130166415;6759.087523184307;6808.080909077409;6875.518713689994;6630.83422914431;6644.036614690746;6713;6726.730930762715;6784.830379240559;6014.849628759316;6090.786822461193;6614.206295244601;6686.197656281277;6688.431483323972;6058.12157237207;6198.287196972406;6228.190335256388;6236.594621349598;6238.064290356301;6244.219472565929;6285.685715714288;6286.214223222098;6286.842828929313;6293.3391993841815 10:28:41 INFO - 2015-11-24 10:28:41,821 DEBUG : BROWSER_OUTPUT: |4;prototype.html;295.06905712477135;299.20710118186804;301.585320184746;304.9435854366942;306.4789857242688;5958;5994.940050599493;6077.361877002906;6099.6340219586855;6106.786262480809;5992.970035149829;5994.8801023979495;5995.5503337249775;5996.070609055592;6035.939640603593;4341.4790225172865;4540.9772951135365;4548.886277843064;4549.863504094882;4569.954300456986;4416;4419.734815911055;4479.305707615308;4514.300283456069;4516.683832131752;4427.9557204427865;4449.84425545106;4458.71018383804;4459.509453960078;4462.687611867171;4288.656907447428;4368.672349573794;4399.318105693591;4448.4884238312525;4449.5995360417555;3878.0886491674432;3899.863504777319;3906.667933225679;3906.902327441808;3911.1004468972296;5731.742071606787;5733.283339582552;5734.225879506297;5739.139129130622;5754.482096611283;5230.08473517133;5234.18870075139;5240.292560504321;5241;5245.134552798783;6203.1005504202085;6339.936600633981;6349.52378571609;6373.203349581302;6427.614343139427;4259.957400425987;4263.744175349489;4265.232258193524;4268.786560671954;4273.829046838154;6615.106960560359;6683.933160668428;6685.76599819004;6690.431313338372;6694.531382803157;4231.217224813419;4337.696361254745;4341.761203133858;4345.9130817383475;4347.217500849877;4389.692721509464;4396.868093957187;4399.450068741407;4400.603945644907;4404.8458303959205;5179.067767801832;5183.2743415921805;5183.948160518346;5189.844304670866;5197.7401129943355;6480.870382592416;6481.351864813481;6486.4162225398995;6487.805365839033;6497.707603157869;1523.2307684619195;1527.8548537888882;1532.073095777061;1548.620587955958;1550.6045958280565;977.8777652793401;1013.469660812179;1015.5277795824977;1019.3079488049801;1019.5157300282307;6225.190725205694;6239.875202495925;6240.157578726814;6249.187605611241;6253.874922501524;6686.1642294713165;6694.09629699994;6694.832629184212;6699.5310328276555;6700;6191.288001879841;6203.596766210182;6220.69365433255;6231.968840155861;6241.500679945593;3515.5605549306338;3534.1871369585137;3535.1338921964284;3566.4828599853395;3607.260511595117;6842.6578671066245;6861.142357205349;6902.171739391305;6902.344277293649;6903.1716194057035;6862.725490980305;6872.934695122264;6883.174019117638;6884.105066341343;6884.414824739853;6772.390484856386;6881.793546193622;6907.34380233877;6914.654267286615;6918.204406493217;6642.13652225227;6652.7006284716335;6656.567323123982;6662.100616416916;6713.362230588086;6618.106555614931;6631.1379520662;6632.635205063768;6635.402813746786;6643.169603799525;6737.3599508046655;6903.447724182154;6909.516333856582;6910.792676219721;6919.827004324932;4380.3210502372185;4397.758123303249;4407.757573333497;4409.206342858316;4423.982484028627;6678.799636010927;6722.596644201363;6724.462043036643;6733.360330768569;6734.73061077571;6370.1718776558755;6513.120728701565;6518.413342799171;6571.638559879252;6575.112359831553;6532.05285233648;6536.150300460909;6539.542232043711;6543.280239173782;6563.540552161494;6414.486841052611;6436.388543088399;6436.6459844707115;6441.098246245436;6450.161479007887;6358.554901156875;6490.928996715489;6561.179852518435;6572.112764776885;6592.307807680125;6353.52348573868;6414.967925160345;6417.39034791694;6421.614703117828;6422.518311126591 10:28:41 INFO - 2015-11-24 10:28:41,824 DEBUG : BROWSER_OUTPUT: |5;yui.html;793.480270422873;817.8814071959566;834.4062839975647;865.1002956924799;879.9472031678104;12702.936485317572;12894.806577901316;12926.22442653439;12940.029497787657;12940.482380704772;12731.745365092693;12849.03632227582;12854.035947303943;12862.807057894139;12878.80681789774;679.51414738462;686.6875571614928;811.0470197517908;813.7477382011566;822.7038266224155;820.6143112737034;824.7814329202766;826.8677011678133;829.5686243153557;829.7676650537829;711.989320160198;860.5052095045343;862.9223369896708;865.0484467086186;865.1737590600961;705.4885208224048;710.7761055267574;711.3064761857199;713.564725517434;842.9452085614415;635.9841003974891;636.2619361540637;636.4494712074069;637.7863415755727;639.4660458517144;12685.682857928534;12829.23024618526;12862.228266303959;12923;12929.418176182095;12332.506699732;12705.301208433533;12829.55096571625;12904.548340808027;13718.794218086736;10118.797624047551;10333.534990925426;10519.158467322672;10520.684379468628;10529.875425814924;3559.9110022249392;3691.464737613058;3711.5917249102577;3790.5451345838674;3850.0567360996456;43452.78273608643;43743.34384984228;49818.25272620914;50372;50473.24290135651;10072.647457338959;10120.949395252977;10176.473528970713;10225.59097636101;10553.208509361828;19002.809971900104;19084.90457547731;19102.904485477484;19112.2355105797;19129.521761955784;7154.427645788429;7155.284471552803;7274.454415918827;7295.124585049722;7391.445641576904;3717.9070523236596;3735.850565977385;3920.0591857954455;3986.142979259473;3987.960120398817;3088.660247372787;3093.381323735262;3109.657937626859;3111.144435280316;3118.345147519001;530.9628326017219;544.727636181909;545.9044667183307;545.9563234941195;550.8953298873201;640.9111653471422;656.9704363303663;662.1061566884667;667.813012356541;691.920429150644;8687.131286871389;8829.867551986725;8843.911560884437;8933.571641346389;9032.503212323385;584.8917950179231;592.5585438848;677.9457643388517;683;707.504746677328;3765.3975363942186;3916.4516967624554;4070.4708387909973;4144.70987030911;4186.434831297796;60430.697846511364;60750.69624651937;60835.69582152061;61034.38965610376;61113.38886611166;48128;49204;49422.25866612004;50026.49973500219;50034.24948625774;46587;46735.29897051547;46962.76518617385;47203.999999999316;48170.759146204044;8735.475871447734;8861;9047;9091.499967501852;9249.722508324761;35497.290054199286;35569.28861422809;36284.81857590695;36402.27195456023;36407.817960910026;42670;46296.53703463057;47472;47587;48632.270515943;11096.167787416138;11205.103591712807;11251.481050058137;11259.362480404241;11336.6032188873;12587.811182832082;12601.558945436866;12612.810807837706;13379.331033448483;13390.995675324584;10843.24097313212;11253.887461125283;11373.260738052;11798.882011179778;11918.225315354473;11309.095272378354;11549.826752598885;11589.478473468545;11630.825537616773;12026.398680065786;11109.669952508293;11441.656750297505;11646.35945022998;12078.879211207775;12151.270923744603;9572.76068098303;9653.276004299565;9746.463944483121;10102.747431314276;10206.132478739093;9095.727128186165;9892.45591492446;9946.502674866373;10022;10047.748806279902 10:28:41 INFO - 2015-11-24 10:28:41,825 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:28:41 INFO - 2015-11-24 10:28:41,825 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:28:41 INFO - 2015-11-24 10:28:41,825 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1798 10:28:41 INFO - 2015-11-24 10:28:41,826 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:28:41 INFO - 2015-11-24 10:28:41,826 DEBUG : BROWSER_OUTPUT: __startTimestamp1448389721809__endTimestamp 10:28:41 INFO - 2015-11-24 10:28:41,826 DEBUG : BROWSER_OUTPUT: 10:28:41 INFO - 2015-11-24 10:28:41,826 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:28:41 INFO - 2015-11-24 10:28:41,827 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:28:41 INFO - 2015-11-24 10:28:41,827 DEBUG : BROWSER_OUTPUT: 10:28:41 INFO - 2015-11-24 10:28:41,827 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5497.37 Median:5740.86 stddev:611.18 (10.6%) stddev-sans-first:585.37 10:28:41 INFO - 2015-11-24 10:28:41,827 DEBUG : BROWSER_OUTPUT: Values: 3179.2 3261.8 3284.3 3304.9 3316.5 5318.1 5400.9 5402.6 5435.2 5457.9 5469.3 5469.5 5470.4 5483.9 5485.9 4992.6 5025.1 5041.1 5051.8 5083.1 5070.7 5125.2 5152.4 5156.9 5159.3 5122.5 5149.3 5168.8 5174.4 5185.9 4910.8 4921.8 5023.2 5060.2 5127.6 4974.9 4999.3 5010.3 5022.8 5030.1 5266.1 5275.2 5304.1 5311.4 5331.2 5752.4 5836.3 5859.4 5860.8 5920.4 5987.7 6047.8 6061.1 6067.8 6074.2 5608.8 5610.4 5613.8 5621.4 5648.5 5868.1 5923.5 6023.2 6026.4 6080.1 5826.1 5831.9 5846.1 5848.6 5880.5 5877.2 5893.3 5896.9 5907.9 5908.7 5666.7 5766.8 5777.2 5909.8 5926.7 5914.1 5948.1 5950.1 5962.9 6001.4 4535.9 4571.7 4574.1 4583.1 4620.9 3979.1 3997.2 4075.2 4076.1 4088.4 5605.9 5608.2 5617.7 5618.2 5620.9 5965.9 5968.0 5972.6 5983.9 5995.0 5427.3 5500.3 5560.4 5581.5 5592.4 5067.7 5088.1 5117.4 5122.4 5165.4 6135.3 6161.2 6168.4 6172.1 6172.1 5740.9 5877.4 5879.2 5987.3 5999.4 5951.9 6056.2 6066.6 6081.8 6101.2 5864.1 5878.9 5879.1 5881.1 5883.7 5812.8 5880.0 5974.1 5984.7 5997.6 5748.3 5773.6 5779.5 5785.0 5792.7 5767.9 5781.7 5783.0 5783.6 5793.0 5652.8 5690.1 5693.3 5695.9 5702.6 5786.2 5811.6 5814.4 5819.0 5969.4 5740.8 5746.6 5751.1 5756.4 5777.6 10:28:41 INFO - 2015-11-24 10:28:41,828 DEBUG : BROWSER_OUTPUT: 10:28:41 INFO - 2015-11-24 10:28:41,828 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48938.63 Median:358230.00 stddev:82260.39 (23.0%) stddev-sans-first:82411.05 10:28:41 INFO - 2015-11-24 10:28:41,828 DEBUG : BROWSER_OUTPUT: Values: 591.0 600.4 601.4 601.8 617.3 31204.0 38681.8 40073.8 40102.8 40107.6 42554.8 42965.6 43052.8 43265.0 43357.3 7569.9 7722.2 8719.3 8807.7 8827.0 10438.8 10725.1 10741.7 10743.9 10746.4 10422.4 10546.0 10546.9 10552.2 10555.5 7746.2 7918.6 10431.7 10526.6 10566.4 10281.1 10388.2 10410.1 10427.4 10430.6 39507.2 39920.4 39945.6 39954.2 39983.0 3256.4 3312.8 3372.6 3655.3 3761.1 29944.3 30364.4 30817.8 30964.5 31337.8 3739.2 3790.4 3840.4 3870.4 3934.8 267751.0 268466.0 268614.0 269130.0 269518.0 54725.0 57523.7 57872.0 58209.0 63007.0 59557.7 59797.4 59922.4 59930.4 59988.4 16150.4 16291.3 16366.9 16447.3 16450.8 12165.0 12171.9 12265.3 12337.4 12381.4 19434.1 19563.6 19661.7 19666.9 19777.1 7542.5 7720.2 7791.3 7835.3 7860.8 946.2 988.7 1029.7 1039.8 1090.4 27962.2 28273.9 28356.3 28555.1 28648.0 945.5 981.0 1044.3 1134.7 1189.4 15575.5 16073.6 16201.2 16226.0 16387.8 353072.0 358070.0 358075.0 358385.0 358426.0 53827.2 54283.7 54386.7 54481.0 54483.7 1219.2 1275.9 1296.3 1380.3 1402.2 29274.6 30642.7 32033.4 32606.5 32745.3 43121.8 44251.3 49990.5 50507.0 50731.7 309333.0 309772.0 313109.0 313616.0 314045.0 38948.0 39489.8 39576.0 39583.6 40441.4 44724.3 44955.0 45077.0 45767.5 45875.0 37370.3 38587.4 38720.6 38883.0 39557.6 38018.0 38060.6 38244.6 38634.0 38728.8 36812.8 37496.6 37572.4 37654.4 37798.0 32947.3 33764.7 34596.0 34656.7 34955.7 25872.5 26012.0 26016.5 26281.3 26445.3 10:28:41 INFO - 2015-11-24 10:28:41,829 DEBUG : BROWSER_OUTPUT: 10:28:41 INFO - 2015-11-24 10:28:41,829 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27521.71 Median:236375.31 stddev:78334.81 (33.1%) stddev-sans-first:78527.97 10:28:41 INFO - 2015-11-24 10:28:41,830 DEBUG : BROWSER_OUTPUT: Values: 336.4 337.6 341.6 341.7 341.9 14303.0 14630.3 16503.9 16792.9 18457.7 16069.0 16150.8 16156.2 16156.6 16239.7 4561.9 4716.0 4717.1 4718.3 4722.5 3732.9 3806.8 4681.6 5246.9 5375.8 5273.1 5292.3 5308.9 5356.0 5357.2 5051.1 5188.6 5192.1 5196.3 5280.6 4794.1 4911.9 4983.4 4994.3 5003.3 11840.1 11950.3 11983.2 14461.5 19524.6 1820.0 2079.4 2085.3 2197.5 2212.0 9262.2 9396.7 13844.4 13980.1 14245.2 1813.3 1862.0 1867.6 1892.2 1895.1 70715.0 72214.0 75146.6 75393.2 76396.0 15913.1 15915.2 15947.9 15962.0 16113.3 24540.0 24774.6 24891.3 24916.5 24919.8 8932.1 9591.3 9637.6 9666.9 9694.4 8258.3 8289.4 8304.9 8362.8 8375.9 7906.5 7931.4 7980.3 7999.4 8101.6 1785.9 1791.4 1818.1 1828.2 2218.6 912.8 925.4 932.1 939.2 1016.4 10232.2 10625.9 10651.5 16893.3 17581.7 414.4 415.2 415.9 418.7 427.3 5423.9 5428.0 5429.4 5480.8 5567.6 468069.0 475386.0 475608.0 479108.0 490299.0 62519.7 75733.6 77376.0 81078.0 82698.6 478.2 484.6 487.1 488.3 488.3 9664.5 9696.3 9724.0 9865.5 9880.7 35352.5 36181.0 36783.8 37046.7 37941.0 47029.0 47427.0 49478.0 49812.8 51174.7 9585.7 9631.8 9794.6 9815.9 9824.2 11399.5 16494.8 17259.2 17549.3 17591.6 13819.9 13948.7 13962.0 14523.4 14613.7 14645.7 14679.6 14848.9 15017.9 15205.8 14989.7 15355.2 15425.0 15623.4 15698.7 9152.0 9165.4 9309.8 9389.1 9426.5 9457.5 9549.5 10761.3 14862.6 14969.3 10:28:41 INFO - 2015-11-24 10:28:41,830 DEBUG : BROWSER_OUTPUT: 10:28:41 INFO - 2015-11-24 10:28:41,831 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5154.99 Median:6285.95 stddev:2619.35 (41.7%) stddev-sans-first:2610.69 10:28:41 INFO - 2015-11-24 10:28:41,832 DEBUG : BROWSER_OUTPUT: Values: 1303.3 1675.0 1714.6 1738.0 1740.6 6453.5 7136.5 7287.3 7297.8 7310.8 7187.0 7288.5 7306.3 7314.2 7317.2 1959.8 1985.6 1991.1 2218.7 2237.3 2226.6 2255.6 2256.5 2256.9 2259.1 2157.1 2179.3 2210.9 2228.5 2235.6 1985.6 2037.8 2153.4 2156.3 2183.3 2145.4 2167.4 2170.4 2173.0 2180.2 7299.9 7357.6 7413.5 7427.9 7447.7 4519.9 4587.9 4597.1 4622.8 4628.5 2998.7 3017.8 3040.0 3041.2 3180.5 955.7 969.8 984.9 1000.4 1015.4 9922.4 9956.6 9966.0 9974.0 9987.9 4071.4 4157.5 4177.2 4208.3 4210.8 8565.4 8595.6 8598.6 8599.0 8600.6 4631.3 4632.5 4633.8 4634.9 4636.7 4208.5 4223.2 4223.7 4225.7 4229.9 3588.2 3624.1 3662.7 3671.4 3678.5 1181.4 1199.8 1200.1 1212.2 1234.8 1046.4 1071.0 1071.8 1198.9 1309.0 6409.3 6556.4 6932.2 7132.6 7132.8 549.2 560.2 561.4 564.3 569.2 5471.8 5473.4 5492.8 5516.8 5519.0 8229.8 8589.2 8684.2 8700.0 8703.4 8561.4 8590.0 8623.1 8625.1 8642.8 6698.6 6817.5 6940.3 6950.8 6973.9 6642.6 6676.9 6677.2 6679.3 6680.8 7542.2 7758.1 7785.9 7792.9 7910.5 7750.0 7771.4 7818.1 7851.4 7883.4 6318.3 6438.6 6448.1 6476.2 6499.4 7092.8 7144.4 7174.9 7205.9 7225.6 6720.8 6758.5 6759.1 6808.1 6875.5 6630.8 6644.0 6713.0 6726.7 6784.8 6014.8 6090.8 6614.2 6686.2 6688.4 6058.1 6198.3 6228.2 6236.6 6238.1 6244.2 6285.7 6286.2 6286.8 6293.3 10:28:41 INFO - 2015-11-24 10:28:41,832 DEBUG : BROWSER_OUTPUT: 10:28:41 INFO - 2015-11-24 10:28:41,832 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5342.19 Median:6203.35 stddev:1679.63 (27.1%) stddev-sans-first:1641.06 10:28:41 INFO - 2015-11-24 10:28:41,832 DEBUG : BROWSER_OUTPUT: Values: 295.1 299.2 301.6 304.9 306.5 5958.0 5994.9 6077.4 6099.6 6106.8 5993.0 5994.9 5995.6 5996.1 6035.9 4341.5 4541.0 4548.9 4549.9 4570.0 4416.0 4419.7 4479.3 4514.3 4516.7 4428.0 4449.8 4458.7 4459.5 4462.7 4288.7 4368.7 4399.3 4448.5 4449.6 3878.1 3899.9 3906.7 3906.9 3911.1 5731.7 5733.3 5734.2 5739.1 5754.5 5230.1 5234.2 5240.3 5241.0 5245.1 6203.1 6339.9 6349.5 6373.2 6427.6 4260.0 4263.7 4265.2 4268.8 4273.8 6615.1 6683.9 6685.8 6690.4 6694.5 4231.2 4337.7 4341.8 4345.9 4347.2 4389.7 4396.9 4399.5 4400.6 4404.8 5179.1 5183.3 5183.9 5189.8 5197.7 6480.9 6481.4 6486.4 6487.8 6497.7 1523.2 1527.9 1532.1 1548.6 1550.6 977.9 1013.5 1015.5 1019.3 1019.5 6225.2 6239.9 6240.2 6249.2 6253.9 6686.2 6694.1 6694.8 6699.5 6700.0 6191.3 6203.6 6220.7 6232.0 6241.5 3515.6 3534.2 3535.1 3566.5 3607.3 6842.7 6861.1 6902.2 6902.3 6903.2 6862.7 6872.9 6883.2 6884.1 6884.4 6772.4 6881.8 6907.3 6914.7 6918.2 6642.1 6652.7 6656.6 6662.1 6713.4 6618.1 6631.1 6632.6 6635.4 6643.2 6737.4 6903.4 6909.5 6910.8 6919.8 4380.3 4397.8 4407.8 4409.2 4424.0 6678.8 6722.6 6724.5 6733.4 6734.7 6370.2 6513.1 6518.4 6571.6 6575.1 6532.1 6536.2 6539.5 6543.3 6563.5 6414.5 6436.4 6436.6 6441.1 6450.2 6358.6 6490.9 6561.2 6572.1 6592.3 6353.5 6415.0 6417.4 6421.6 6422.5 10:28:41 INFO - 2015-11-24 10:28:41,834 DEBUG : BROWSER_OUTPUT: 10:28:41 INFO - 2015-11-24 10:28:41,834 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13986.36 Median:43598.06 stddev:16255.10 (37.3%) stddev-sans-first:16270.51 10:28:41 INFO - 2015-11-24 10:28:41,834 DEBUG : BROWSER_OUTPUT: Values: 793.5 817.9 834.4 865.1 879.9 12702.9 12894.8 12926.2 12940.0 12940.5 12731.7 12849.0 12854.0 12862.8 12878.8 679.5 686.7 811.0 813.7 822.7 820.6 824.8 826.9 829.6 829.8 712.0 860.5 862.9 865.0 865.2 705.5 710.8 711.3 713.6 842.9 636.0 636.3 636.4 637.8 639.5 12685.7 12829.2 12862.2 12923.0 12929.4 12332.5 12705.3 12829.6 12904.5 13718.8 10118.8 10333.5 10519.2 10520.7 10529.9 3559.9 3691.5 3711.6 3790.5 3850.1 43452.8 43743.3 49818.3 50372.0 50473.2 10072.6 10120.9 10176.5 10225.6 10553.2 19002.8 19084.9 19102.9 19112.2 19129.5 7154.4 7155.3 7274.5 7295.1 7391.4 3717.9 3735.9 3920.1 3986.1 3988.0 3088.7 3093.4 3109.7 3111.1 3118.3 531.0 544.7 545.9 546.0 550.9 640.9 657.0 662.1 667.8 691.9 8687.1 8829.9 8843.9 8933.6 9032.5 584.9 592.6 677.9 683.0 707.5 3765.4 3916.5 4070.5 4144.7 4186.4 60430.7 60750.7 60835.7 61034.4 61113.4 48128.0 49204.0 49422.3 50026.5 50034.2 46587.0 46735.3 46962.8 47204.0 48170.8 8735.5 8861.0 9047.0 9091.5 9249.7 35497.3 35569.3 36284.8 36402.3 36407.8 42670.0 46296.5 47472.0 47587.0 48632.3 11096.2 11205.1 11251.5 11259.4 11336.6 12587.8 12601.6 12612.8 13379.3 13391.0 10843.2 11253.9 11373.3 11798.9 11918.2 11309.1 11549.8 11589.5 11630.8 12026.4 11109.7 11441.7 11646.4 12078.9 12151.3 9572.8 9653.3 9746.5 10102.7 10206.1 9095.7 9892.5 9946.5 10022.0 10047.7 10:28:41 INFO - 2015-11-24 10:28:41,834 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:28:41 INFO - 2015-11-24 10:28:41,834 DEBUG : BROWSER_OUTPUT: 10:28:42 INFO - 2015-11-24 10:28:42,473 INFO : Browser exited with error code: 0 10:28:42 INFO - 2015-11-24 10:28:42,494 INFO : Completed test dromaeo_css (00:18:34) 10:28:42 INFO - 2015-11-24 10:28:42,494 INFO : Starting test kraken 10:28:42 INFO - 2015-11-24 10:28:42,494 DEBUG : operating with platform_type : linux_ 10:28:42 INFO - 2015-11-24 10:28:42,494 INFO : Initialising browser for kraken test... 10:28:42 INFO - 2015-11-24 10:28:42,500 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3g_BPi/profile http://localhost:60380/getInfo.html 10:28:46 INFO - 2015-11-24 10:28:46,456 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:28:46 INFO - 2015-11-24 10:28:46,456 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:28:46 INFO - 2015-11-24 10:28:46,456 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:28:46 INFO - 2015-11-24 10:28:46,456 DEBUG : BROWSER_OUTPUT: __metrics 10:28:46 INFO - 2015-11-24 10:28:46,573 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:28:47 INFO - 2015-11-24 10:28:47,970 INFO : Browser initialized. 10:28:47 INFO - 2015-11-24 10:28:47,971 INFO : Running cycle 1/1 for kraken test... 10:28:47 INFO - 2015-11-24 10:28:47,971 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3g_BPi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:28:59 INFO - 2015-11-24 10:28:59,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 140496896 10:28:59 INFO - 2015-11-24 10:28:59,763 DEBUG : BROWSER_OUTPUT: 10:29:02 INFO - 2015-11-24 10:29:02,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60380/tests/kraken/driver.html?testName=audio-beat-detection) 10:29:02 INFO - 2015-11-24 10:29:02,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 180011008 10:29:02 INFO - 2015-11-24 10:29:02,799 DEBUG : BROWSER_OUTPUT: 10:29:05 INFO - 2015-11-24 10:29:05,399 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60380/tests/kraken/driver.html?testName=audio-dft) 10:29:05 INFO - 2015-11-24 10:29:05,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 168353792 10:29:05 INFO - 2015-11-24 10:29:05,973 DEBUG : BROWSER_OUTPUT: 10:29:08 INFO - 2015-11-24 10:29:08,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60380/tests/kraken/driver.html?testName=audio-fft) 10:29:09 INFO - 2015-11-24 10:29:09,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 151539712 10:29:09 INFO - 2015-11-24 10:29:09,407 DEBUG : BROWSER_OUTPUT: 10:29:11 INFO - 2015-11-24 10:29:11,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60380/tests/kraken/driver.html?testName=audio-oscillator) 10:29:11 INFO - 2015-11-24 10:29:11,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 154394624 10:29:11 INFO - 2015-11-24 10:29:11,932 DEBUG : BROWSER_OUTPUT: 10:29:14 INFO - 2015-11-24 10:29:14,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60380/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:29:14 INFO - 2015-11-24 10:29:14,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 155852800 10:29:14 INFO - 2015-11-24 10:29:14,696 DEBUG : BROWSER_OUTPUT: 10:29:17 INFO - 2015-11-24 10:29:17,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60380/tests/kraken/driver.html?testName=imaging-darkroom) 10:29:18 INFO - 2015-11-24 10:29:18,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 156672000 10:29:18 INFO - 2015-11-24 10:29:18,153 DEBUG : BROWSER_OUTPUT: 10:29:21 INFO - 2015-11-24 10:29:21,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60380/tests/kraken/driver.html?testName=imaging-desaturate) 10:29:22 INFO - 2015-11-24 10:29:22,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 157716480 10:29:22 INFO - 2015-11-24 10:29:22,129 DEBUG : BROWSER_OUTPUT: 10:29:24 INFO - 2015-11-24 10:29:24,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60380/tests/kraken/driver.html?testName=json-parse-financial) 10:29:25 INFO - 2015-11-24 10:29:25,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 158154752 10:29:25 INFO - 2015-11-24 10:29:25,453 DEBUG : BROWSER_OUTPUT: 10:29:27 INFO - 2015-11-24 10:29:27,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60380/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:29:27 INFO - 2015-11-24 10:29:27,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 168968192 10:29:27 INFO - 2015-11-24 10:29:27,596 DEBUG : BROWSER_OUTPUT: 10:29:29 INFO - 2015-11-24 10:29:29,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60380/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:29:30 INFO - 2015-11-24 10:29:30,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 167108608 10:29:30 INFO - 2015-11-24 10:29:30,008 DEBUG : BROWSER_OUTPUT: 10:29:32 INFO - 2015-11-24 10:29:32,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60380/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:29:32 INFO - 2015-11-24 10:29:32,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 177819648 10:29:32 INFO - 2015-11-24 10:29:32,625 DEBUG : BROWSER_OUTPUT: 10:29:34 INFO - 2015-11-24 10:29:34,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:29:35 INFO - 2015-11-24 10:29:35,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 184647680 10:29:35 INFO - 2015-11-24 10:29:35,580 DEBUG : BROWSER_OUTPUT: 10:29:38 INFO - 2015-11-24 10:29:38,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:29:38 INFO - 2015-11-24 10:29:38,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 179466240 10:29:38 INFO - 2015-11-24 10:29:38,695 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60380/tests/kraken/driver.html?testName=ai-astar) 10:29:40 INFO - 2015-11-24 10:29:40,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 239407104 10:29:40 INFO - 2015-11-24 10:29:40,619 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,623 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:29:40 INFO - 2015-11-24 10:29:40,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:29:40 INFO - 2015-11-24 10:29:40,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:29:40 INFO - 2015-11-24 10:29:40,623 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:29:40 INFO - 2015-11-24 10:29:40,623 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;103;107;109;109;98;110;108;100 10:29:40 INFO - 2015-11-24 10:29:40,624 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;124;148;159;131;156;159;129;165;124 10:29:40 INFO - 2015-11-24 10:29:40,624 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;160;160;162;161;161;161;159;161 10:29:40 INFO - 2015-11-24 10:29:40,624 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;84;94;70;71;71;100;96;71 10:29:40 INFO - 2015-11-24 10:29:40,624 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;140;93;94;93;144;92;93;146 10:29:40 INFO - 2015-11-24 10:29:40,624 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;111;109;109;109;109;109;109;110;108 10:29:40 INFO - 2015-11-24 10:29:40,624 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;146;146;145;145;145;146 10:29:40 INFO - 2015-11-24 10:29:40,624 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;96;95;95;95;95;94 10:29:40 INFO - 2015-11-24 10:29:40,624 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;59;58;59;59;60;59;60;63;57 10:29:40 INFO - 2015-11-24 10:29:40,625 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;68;69;69;69;70;68;69;69 10:29:40 INFO - 2015-11-24 10:29:40,625 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;86;85;84;84;85;84;84;83 10:29:40 INFO - 2015-11-24 10:29:40,625 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;115;122;114;121;121;116;115;122;120 10:29:40 INFO - 2015-11-24 10:29:40,625 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;154;152;160;138;139;162;150;151;138 10:29:40 INFO - 2015-11-24 10:29:40,625 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;66;67;65;69;66;65;67;66 10:29:40 INFO - 2015-11-24 10:29:40,625 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:29:40 INFO - 2015-11-24 10:29:40,625 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:29:40 INFO - 2015-11-24 10:29:40,626 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,905 10:29:40 INFO - 2015-11-24 10:29:40,626 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:29:40 INFO - 2015-11-24 10:29:40,626 DEBUG : BROWSER_OUTPUT: __startTimestamp1448389780621__endTimestamp 10:29:40 INFO - 2015-11-24 10:29:40,626 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,629 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:29:40 INFO - 2015-11-24 10:29:40,629 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:29:40 INFO - 2015-11-24 10:29:40,629 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,629 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.50 Median:109.50 stddev:4.55 (4.2%) stddev-sans-first:4.65 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 103.0 107.0 109.0 109.0 98.0 110.0 108.0 100.0 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.60 Median:153.50 stddev:15.95 (10.4%) stddev-sans-first:16.75 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: Values: 151.0 124.0 148.0 159.0 131.0 156.0 159.0 129.0 165.0 124.0 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 160.0 160.0 162.0 161.0 161.0 161.0 159.0 161.0 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:72.00 stddev:12.20 (16.9%) stddev-sans-first:12.58 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 84.0 94.0 70.0 71.0 71.0 100.0 96.0 71.0 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.00 Median:93.00 stddev:24.43 (26.3%) stddev-sans-first:25.22 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 140.0 93.0 94.0 93.0 144.0 92.0 93.0 146.0 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,630 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 108.0 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 94.0 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.40 Median:59.50 stddev:1.58 (2.7%) stddev-sans-first:1.66 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: Values: 60.0 59.0 58.0 59.0 59.0 60.0 59.0 60.0 63.0 57.0 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 69.0 69.0 69.0 70.0 68.0 69.0 69.0 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 10:29:40 INFO - 2015-11-24 10:29:40,631 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 86.0 85.0 84.0 84.0 85.0 84.0 84.0 83.0 10:29:40 INFO - 2015-11-24 10:29:40,632 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,632 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:121.00 stddev:3.97 (3.3%) stddev-sans-first:3.36 10:29:40 INFO - 2015-11-24 10:29:40,632 DEBUG : BROWSER_OUTPUT: Values: 126.0 115.0 122.0 114.0 121.0 121.0 116.0 115.0 122.0 120.0 10:29:40 INFO - 2015-11-24 10:29:40,632 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,632 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:151.50 stddev:9.12 (6.0%) stddev-sans-first:9.15 10:29:40 INFO - 2015-11-24 10:29:40,632 DEBUG : BROWSER_OUTPUT: Values: 140.0 154.0 152.0 160.0 138.0 139.0 162.0 150.0 151.0 138.0 10:29:40 INFO - 2015-11-24 10:29:40,632 DEBUG : BROWSER_OUTPUT: 10:29:40 INFO - 2015-11-24 10:29:40,632 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 10:29:40 INFO - 2015-11-24 10:29:40,632 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 66.0 67.0 65.0 69.0 66.0 65.0 67.0 66.0 10:29:40 INFO - 2015-11-24 10:29:40,632 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:29:40 INFO - 2015-11-24 10:29:40,632 DEBUG : BROWSER_OUTPUT: 10:29:41 INFO - 2015-11-24 10:29:41,472 INFO : Browser exited with error code: 0 10:29:41 INFO - 2015-11-24 10:29:41,523 INFO : Completed test kraken (00:00:59) 10:29:41 INFO - 2015-11-24 10:29:41,524 INFO : Starting test v8_7 10:29:41 INFO - 2015-11-24 10:29:41,524 DEBUG : operating with platform_type : linux_ 10:29:41 INFO - 2015-11-24 10:29:41,524 INFO : Initialising browser for v8_7 test... 10:29:41 INFO - 2015-11-24 10:29:41,530 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp67_HR8/profile http://localhost:60380/getInfo.html 10:29:45 INFO - 2015-11-24 10:29:45,518 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:29:45 INFO - 2015-11-24 10:29:45,518 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:29:45 INFO - 2015-11-24 10:29:45,518 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:29:45 INFO - 2015-11-24 10:29:45,518 DEBUG : BROWSER_OUTPUT: __metrics 10:29:45 INFO - 2015-11-24 10:29:45,667 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:29:47 INFO - 2015-11-24 10:29:46,999 INFO : Browser initialized. 10:29:47 INFO - 2015-11-24 10:29:47,000 INFO : Running cycle 1/1 for v8_7 test... 10:29:47 INFO - 2015-11-24 10:29:47,000 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp67_HR8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:29:58 INFO - 2015-11-24 10:29:58,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 140611584 10:29:58 INFO - 2015-11-24 10:29:58,756 DEBUG : BROWSER_OUTPUT: 10:30:20 INFO - 2015-11-24 10:30:20,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60380/tests/v8_7/run.html (next: http://localhost:60380/tests/v8_7/run.html) 10:30:20 INFO - 2015-11-24 10:30:20,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 568664064 10:30:20 INFO - 2015-11-24 10:30:20,471 DEBUG : BROWSER_OUTPUT: 10:30:20 INFO - 2015-11-24 10:30:20,472 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:30:20 INFO - 2015-11-24 10:30:20,472 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: |0;Richards;190.2587519025875 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.4012441679627 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: |2;Encrypt;286.368843069874 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5005 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1964.6365422396857 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: |5;Earley;756.0422960725075 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: |6;Boyer;12370.37037037037 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: |7;RegExp;26102.5641025641 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: |8;Splay;633.6696090794452 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:30:20 INFO - 2015-11-24 10:30:20,473 DEBUG : BROWSER_OUTPUT: __startTimestamp1448389820471__endTimestamp 10:30:20 INFO - 2015-11-24 10:30:20,474 DEBUG : BROWSER_OUTPUT: 10:30:20 INFO - 2015-11-24 10:30:20,474 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:30:20 INFO - 2015-11-24 10:30:20,474 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:30:20 INFO - 2015-11-24 10:30:20,474 DEBUG : BROWSER_OUTPUT: 10:30:20 INFO - 2015-11-24 10:30:20,474 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:190.26 Median:190.26 stddev:0.00 (0.0%) 10:30:20 INFO - 2015-11-24 10:30:20,474 DEBUG : BROWSER_OUTPUT: Values: 190.3 10:30:20 INFO - 2015-11-24 10:30:20,474 DEBUG : BROWSER_OUTPUT: 10:30:20 INFO - 2015-11-24 10:30:20,474 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.40 Median:194.40 stddev:0.00 (0.0%) 10:30:20 INFO - 2015-11-24 10:30:20,474 DEBUG : BROWSER_OUTPUT: Values: 194.4 10:30:20 INFO - 2015-11-24 10:30:20,474 DEBUG : BROWSER_OUTPUT: 10:30:20 INFO - 2015-11-24 10:30:20,475 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:286.37 Median:286.37 stddev:0.00 (0.0%) 10:30:20 INFO - 2015-11-24 10:30:20,475 DEBUG : BROWSER_OUTPUT: Values: 286.4 10:30:20 INFO - 2015-11-24 10:30:20,475 DEBUG : BROWSER_OUTPUT: 10:30:20 INFO - 2015-11-24 10:30:20,476 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5005.00 Median:5005.00 stddev:0.00 (0.0%) 10:30:20 INFO - 2015-11-24 10:30:20,476 DEBUG : BROWSER_OUTPUT: Values: 5005.0 10:30:20 INFO - 2015-11-24 10:30:20,476 DEBUG : BROWSER_OUTPUT: 10:30:20 INFO - 2015-11-24 10:30:20,476 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1964.64 Median:1964.64 stddev:0.00 (0.0%) 10:30:20 INFO - 2015-11-24 10:30:20,476 DEBUG : BROWSER_OUTPUT: Values: 1964.6 10:30:20 INFO - 2015-11-24 10:30:20,477 DEBUG : BROWSER_OUTPUT: 10:30:20 INFO - 2015-11-24 10:30:20,477 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:756.04 Median:756.04 stddev:0.00 (0.0%) 10:30:20 INFO - 2015-11-24 10:30:20,477 DEBUG : BROWSER_OUTPUT: Values: 756.0 10:30:20 INFO - 2015-11-24 10:30:20,477 DEBUG : BROWSER_OUTPUT: 10:30:20 INFO - 2015-11-24 10:30:20,477 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 10:30:20 INFO - 2015-11-24 10:30:20,477 DEBUG : BROWSER_OUTPUT: Values: 12370.4 10:30:20 INFO - 2015-11-24 10:30:20,477 DEBUG : BROWSER_OUTPUT: 10:30:20 INFO - 2015-11-24 10:30:20,477 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26102.56 Median:26102.56 stddev:0.00 (0.0%) 10:30:20 INFO - 2015-11-24 10:30:20,478 DEBUG : BROWSER_OUTPUT: Values: 26102.6 10:30:20 INFO - 2015-11-24 10:30:20,478 DEBUG : BROWSER_OUTPUT: 10:30:20 INFO - 2015-11-24 10:30:20,478 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:633.67 Median:633.67 stddev:0.00 (0.0%) 10:30:20 INFO - 2015-11-24 10:30:20,478 DEBUG : BROWSER_OUTPUT: Values: 633.7 10:30:20 INFO - 2015-11-24 10:30:20,478 DEBUG : BROWSER_OUTPUT: 10:30:20 INFO - 2015-11-24 10:30:20,478 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 10:30:20 INFO - 2015-11-24 10:30:20,478 DEBUG : BROWSER_OUTPUT: Values: 4835.7 10:30:20 INFO - 2015-11-24 10:30:20,479 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:30:20 INFO - 2015-11-24 10:30:20,479 DEBUG : BROWSER_OUTPUT: 10:30:21 INFO - 2015-11-24 10:30:21,328 INFO : Browser exited with error code: 0 10:30:21 INFO - 2015-11-24 10:30:21,345 INFO : Completed test v8_7 (00:00:39) 10:30:21 INFO - 2015-11-24 10:30:21,401 INFO : Completed test suite (00:20:13) 10:30:21 INFO - 2015-11-24 10:30:21,401 DEBUG : Working with test: dromaeo_css 10:30:21 INFO - 2015-11-24 10:30:21,401 DEBUG : Generating results file: dromaeo_css 10:30:21 INFO - 2015-11-24 10:30:21,402 DEBUG : Working with test: kraken 10:30:21 INFO - 2015-11-24 10:30:21,402 DEBUG : Generating results file: kraken 10:30:21 INFO - 2015-11-24 10:30:21,403 INFO : javascript benchmark 10:30:21 INFO - 2015-11-24 10:30:21,403 DEBUG : Working with test: v8_7 10:30:21 INFO - 2015-11-24 10:30:21,403 DEBUG : Generating results file: v8_7 10:30:21 INFO - 2015-11-24 10:30:21,403 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:30:21 INFO - 2015-11-24 10:30:21,554 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 10:30:21 INFO - 2015-11-24 10:30:21,555 DEBUG : process_Request line: dromaeo_css 6970.47 graph.html#tests=[[72,64,35]] 10:30:21 INFO - 2015-11-24 10:30:21,555 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:30:21 INFO - 2015-11-24 10:30:21,600 DEBUG : process_Request line: kraken 1496.40 graph.html#tests=[[232,64,35]] 10:30:21 INFO - 2015-11-24 10:30:21,601 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:30:21 INFO - 2015-11-24 10:30:21,630 DEBUG : process_Request line: v8_7 19509.00 graph.html#tests=[[230,64,35]] 10:30:21 INFO - 2015-11-24 10:30:21,631 INFO : javascript benchmark 10:30:21 INFO - 2015-11-24 10:30:21,635 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3179.1893067267843, 3261.8042917424973, 3284.3267130238287, 3304.917377065573, 3316.5191047298144, 5318.149096144618, 5400.945990540094, 5402.594805389596, 5435.1847222916585, 5457.863553411166, 5469.316335458067, 5469.453054694529, 5470.370907345657, 5483.945160548394, 5485.890282194354, 4992.600591952653, 5025.14572522672, 5041.092603331399, 5051.772670229849, 5083.059633967728, 5070.7464626768515, 5125.179971204608, 5152.381714194302, 5156.896862062757, 5159.332321699552, 5122.513361230677, 5149.330587023682, 5168.819091331804, 5174.379074511064, 5185.87035324118, 4910.779014944301, 4921.753912304406, 5023.196288593844, 5060.240963855451, 5127.589792816566, 4974.850754477371, 4999.275105109775, 5010.323606313137, 5022.824201152978, 5030.094582975063, 5266.131088370453, 5275.208718692227, 5304.071787437221, 5311.415744268127, 5331.2003199519995, 5752.36723960364, 5836.299644042742, 5859.4140585941495, 5860.765569377219, 5920.378360272195, 5987.670678112702, 6047.81296984058, 6061.120373790737, 6067.848303792441, 6074.240719910012, 5608.775648974036, 5610.438956104357, 5613.775448982076, 5621.381648018714, 5648.491635752802, 5868.061110222344, 5923.466887980103, 6023.216981792339, 6026.397360263939, 6080.087986802015, 5826.067829147316, 5831.912521312183, 5846.093855452412, 5848.561357898175, 5880.470757631833, 5877.20171161313, 5893.263342082239, 5896.882062358729, 5907.940920590739, 5908.734106965197, 5666.660000399989, 5766.769329226868, 5777.220075289866, 5909.763609455659, 5926.703664816742, 5914.142449344907, 5948.078047902582, 5950.077737950624, 5962.880742385215, 6001.4298641628975, 4535.909281814411, 4571.679982401267, 4574.08518296342, 4583.083383323348, 4620.861374158781, 3979.144483935968, 3997.200559887976, 4075.2053349597136, 4076.144009757984, 4088.4071809587444, 5605.915911261334, 5608.158776183605, 5617.747201375948, 5618.157276408571, 5620.91568626471, 5965.850853728604, 5968.0, 5972.58191926561, 5983.850403739854, 5995.0, 5427.3215848019, 5500.28496295479, 5560.388357280696, 5581.5255703265675, 5592.356878958891, 5067.721275329818, 5088.084144853888, 5117.437081920985, 5122.385313762298, 5165.405978312467, 6135.263768347827, 6161.168242287324, 6168.352323006109, 6172.074188871795, 6172.105044768484, 5740.856478587902, 5877.382874798084, 5879.235699359227, 5987.251593550806, 5999.370066143167, 5951.910721339097, 6056.242969628796, 6066.605670631395, 6081.817545473643, 6101.176341194059, 5864.149698293809, 5878.853028674317, 5879.147523609138, 5881.05903055509, 5883.735231914488, 5812.76748930055, 5880.0, 5974.133750606225, 5984.700764961822, 5997.610155340063, 5748.338941021836, 5773.595848290579, 5779.537636989115, 5785.0454674978155, 5792.7103644818435, 5767.942320576741, 5781.710914454176, 5783.045797443543, 5783.595148339576, 5792.986227410271, 5652.830415087554, 5690.146478028329, 5693.259876216065, 5695.857603559944, 5702.572307077069, 5786.161006653927, 5811.56413269015, 5814.389489103753, 5819.039858423482, 5969.3732158122775, 5740.770369185186, 5746.597738158289, 5751.137329400456, 5756.366799651951, 5777.62445441045], "unit": "ms", "name": "dojo.html", "value": 5457.2548735906685}, {"lowerIsBetter": false, "replicates": [590.9556783241258, 600.4175949329152, 601.4466690644607, 601.7653115285038, 617.2839506172841, 31204.0, 38681.80659096704, 40073.79963100188, 40102.79948600253, 40107.59892401075, 42554.787226063905, 42965.570344296546, 43052.784736076275, 43265.0, 43357.34963975535, 7569.924300756977, 7722.227777222261, 8719.302455803536, 8807.735767926972, 8827.0, 10438.791224175511, 10725.14198864089, 10741.731456713567, 10743.892561074406, 10746.408947507884, 10422.374657520535, 10546.0, 10546.894531054668, 10552.155827533818, 10555.525001374957, 7746.225377462265, 7918.604069796487, 10431.739206519822, 10526.578936842556, 10566.418846963414, 10281.074703276741, 10388.220883433773, 10410.063094321547, 10427.374357538572, 10430.634927777568, 39507.20985580272, 39920.401193982114, 39945.60054399477, 39954.20091598152, 39983.0, 3256.3975664501904, 3312.834358282076, 3372.6458721834347, 3655.342038433081, 3761.1349389640263, 29944.251393715112, 30364.392712145855, 30817.845910770528, 30964.535531967038, 31337.84331078353, 3739.2147648993746, 3790.355639541257, 3840.4047372657283, 3870.4000879863665, 3934.8229329680235, 267751.0, 268465.999999998, 268614.0, 269130.0, 269518.0, 54725.0, 57523.71238143783, 57872.0, 58209.0, 63007.0, 59557.702211488664, 59797.40202597919, 59922.40077599168, 59930.400695993354, 59988.40011599915, 16150.353985840435, 16291.266892989845, 16366.918165409335, 16447.342106315853, 16450.835491645168, 12165.0, 12171.939140304241, 12265.325407102517, 12337.444814983168, 12381.442835072443, 19434.12546435414, 19563.60872782565, 19661.72198807073, 19666.901665491867, 19777.110030048683, 7542.509736867196, 7720.189380115007, 7791.259830316111, 7835.2948234658015, 7860.764177074697, 946.2309957812548, 988.7478692933256, 1029.6550655530332, 1039.8336266197523, 1090.4275255490932, 27962.161135165978, 28273.858630707127, 28356.291092722433, 28555.143345699664, 28648.0, 945.4516380499294, 980.9944806573177, 1044.2951008069522, 1134.7049767060623, 1189.423129782055, 15575.532734017997, 16073.598160045858, 16201.189940502927, 16226.0, 16387.754183687255, 353072.0, 358070.0, 358075.0, 358385.0, 358426.0, 53827.19259211115, 54283.72858135684, 54386.72806636021, 54481.0, 54483.72758136184, 1219.1709637446622, 1275.9489620415266, 1296.2999980010688, 1380.2822532282955, 1402.2427888939858, 29274.56088158722, 30642.693573063985, 32033.359332813678, 32606.51090233601, 32745.34509309848, 43121.7843910791, 44251.33622995593, 49990.50009500004, 50507.0, 50731.746341269536, 309333.0, 309772.0, 313109.0, 313616.0, 314045.0, 38948.0, 39489.802550987064, 39576.0, 39583.60416395799, 40441.39337909875, 44724.32913506365, 44955.0, 45077.0, 45767.54232457633, 45875.0, 37370.25259494849, 38587.421188681634, 38720.612793872824, 38883.0, 39557.60442395539, 38018.0, 38060.619393805704, 38244.61755382522, 38634.0, 38728.80635596804, 36812.815935920145, 37496.62503374931, 37572.43641345327, 37654.435183472815, 37798.0, 32947.34105317928, 33764.662353377134, 34596.0, 34656.65343346534, 34955.650443496255, 25872.482550349265, 26012.0, 26016.479670406865, 26281.342966425993, 26445.33886652849], "unit": "ms", "name": "ext.html", "value": 19379.256156808806}, {"lowerIsBetter": false, "replicates": [336.3877742508634, 337.5763416911776, 341.63615749227057, 341.6941837055835, 341.93845107880577, 14303.0, 14630.268486575682, 16503.917480412612, 16792.91603541982, 18457.723134153, 16069.0, 16150.83849161508, 16156.192190390462, 16156.596085097879, 16239.675206495864, 4561.863144105682, 4716.0, 4717.127331443677, 4718.339432479455, 4722.527747225267, 3732.944005839901, 3806.8477260909667, 4681.625469962411, 5246.895062098775, 5375.838724838241, 5273.129933560957, 5292.285541451894, 5308.867278318035, 5355.973220133913, 5357.169638705987, 5051.141305977974, 5188.558972487343, 5192.143296356116, 5196.272521846944, 5280.603954703393, 4794.089123066641, 4911.926321105187, 4983.426905905795, 4994.300797888299, 5003.2995380646735, 11840.11199160058, 11950.282983021047, 11983.161178717493, 14461.49384771528, 19524.609507809906, 1820.0343628880778, 2079.4489460293034, 2085.3326935380683, 2197.48359135603, 2212.048819007826, 9262.166405023512, 9396.67111651089, 13844.446222151102, 13980.091294065853, 14245.216513091777, 1813.3018787766673, 1861.9813801861944, 1867.5704587944713, 1892.1958167778776, 1895.0998275819013, 70715.0, 72214.0, 75146.62426687831, 75393.24606753918, 76396.0, 15913.124778137082, 15915.204239787965, 15947.920260398623, 15962.04227746339, 16113.274902629175, 24540.0, 24774.628380574304, 24891.25326240216, 24916.5016699665, 24919.750802492104, 8932.06017998037, 9591.280653950982, 9637.614495420105, 9666.903330966601, 9694.36986595869, 8258.25675689191, 8289.378296627778, 8304.875426868603, 8362.79093022667, 8375.874361884577, 7906.52560846351, 7931.444798864024, 7980.321672657773, 7999.36005119589, 8101.6354264058255, 1785.9374921877932, 1791.4446521578093, 1818.072782880714, 1828.1955939386894, 2218.6022805632347, 912.7763697894059, 925.4493576322078, 932.0586207929904, 939.196986576481, 1016.3952448293254, 10232.232582556338, 10625.893741062646, 10651.520681569347, 16893.324267029428, 17581.7362739559, 414.4239507085154, 415.15930241261685, 415.92929202035725, 418.7278269125032, 427.2800331441531, 5423.888102938967, 5427.972860135674, 5429.4027656957705, 5480.7533660985355, 5567.554595632339, 468069.0, 475386.0, 475608.0, 479108.0, 490299.0, 62519.6874015627, 75733.621331893, 77376.0, 81078.0, 82698.58650706828, 478.23004962011134, 484.59536287199876, 487.07455833915844, 488.27978731371655, 488.28222512906683, 9664.468454235084, 9696.321257512189, 9723.951380243054, 9865.506724663595, 9880.654177103766, 35352.46971295381, 36181.0, 36783.81608091942, 37046.71968190855, 37941.0, 47029.0, 47427.0, 49478.01043979028, 49812.75093624509, 51174.74412627913, 9585.664501742405, 9631.759206019906, 9794.559244834141, 9815.901840981498, 9824.21406287481, 11399.544018239509, 16494.83505164933, 17259.223334949707, 17549.298028078734, 17591.560210994827, 13819.86180138226, 13948.651283717581, 13962.0, 14523.419063237352, 14613.707725845636, 14645.707085858436, 14679.55961321162, 14848.85151148518, 15017.924910375377, 15205.771913421086, 14989.700205995601, 15355.23223838826, 15425.0, 15623.375064997274, 15698.686026279638, 9151.954240228757, 9165.358424910191, 9309.813803724022, 9389.10803473669, 9426.528673566432, 9457.527123643653, 9549.474778887228, 10761.289679076253, 14862.628434289229, 14969.251537422868], "unit": "ms", "name": "jquery.html", "value": 8506.570192006615}, {"lowerIsBetter": false, "replicates": [1303.3157592264054, 1674.9665006699865, 1714.5542159038655, 1738.0440757583326, 1740.5996620777214, 6453.4837213022965, 7136.500444968848, 7287.27127287271, 7297.781066567998, 7310.817229569264, 7186.964065179667, 7288.489805713602, 7306.305900939416, 7314.195438501773, 7317.158526769423, 1959.7942216067322, 1985.583027564206, 1991.1239054815908, 2218.6561083032116, 2237.339984704516, 2226.588081204974, 2255.605269077913, 2256.4697296135396, 2256.8871556422196, 2259.1302348595746, 2157.10480150738, 2179.2808373236794, 2210.8894555272254, 2228.5320082782637, 2235.619944609412, 1985.583027564206, 2037.775844657094, 2153.440105572555, 2156.3315372234656, 2183.344996501043, 2145.442185031887, 2167.436466518701, 2170.40313913675, 2172.9891350543303, 2180.2042254577123, 7299.854002919965, 7357.632118394059, 7413.518121322097, 7427.888581671279, 7447.7393291235085, 4519.909601807978, 4587.944772702263, 4597.103564804865, 4622.768861556909, 4628.5371462853445, 2998.700129986984, 3017.788754787166, 3039.969600304013, 3041.17888170195, 3180.475221588435, 955.7419496735843, 969.8011907558933, 984.916282116021, 1000.4247557654378, 1015.3856916565445, 9922.404655720751, 9956.601735930626, 9966.003399660049, 9973.950130249375, 9987.850182247272, 4071.3892916062828, 4157.48031496063, 4177.164567086595, 4208.305629571148, 4210.789460526961, 8565.443246189103, 8595.5702214889, 8598.5700714964, 8599.0, 8600.612972416131, 4631.282151266559, 4632.467266264355, 4633.7683115844075, 4634.930476042862, 4636.652251081183, 4208.452901122834, 4223.176480586256, 4223.72545784523, 4225.661947044229, 4229.851955181553, 3588.1567831559564, 3624.075860655516, 3662.6520480554304, 3671.375866102769, 3678.5401824771902, 1181.4033912873945, 1199.7600479904054, 1200.0939290835363, 1212.1878341511033, 1234.7653945750278, 1046.419237323293, 1070.9625163119254, 1071.7588542577857, 1198.8920997110301, 1309.0247765414827, 6409.294977552466, 6556.4427023702565, 6932.202796678446, 7132.572045677276, 7132.786016419515, 549.1954286969609, 560.1681502968089, 561.4077148608176, 564.2720890051869, 569.1832220763135, 5471.781128754885, 5473.425290344536, 5492.80775172875, 5516.779328826882, 5519.0, 8229.835403291901, 8589.226969572643, 8684.2184203422, 8699.956500217584, 8703.43427677199, 8561.44350617208, 8589.957050214834, 8623.094575069654, 8625.13748625145, 8642.827143457222, 6698.631575263407, 6817.5227734059135, 6940.271271516418, 6950.791476255821, 6973.860522789516, 6642.6014439133805, 6676.899846502403, 6677.165354330708, 6679.265280819203, 6680.799576012728, 7542.208068152765, 7758.107817601048, 7785.92214077852, 7792.922070779219, 7910.485818421784, 7749.961250193713, 7771.378289736695, 7818.0618325799, 7851.371890248881, 7883.448158628841, 6318.336574659595, 6438.581492202992, 6448.097266382804, 6476.190476190476, 6499.447546958561, 7092.751753688803, 7144.3927266182955, 7174.8565028698085, 7205.891911621225, 7225.5664660120565, 6720.764773232913, 6758.4931130166415, 6759.087523184307, 6808.080909077409, 6875.518713689994, 6630.83422914431, 6644.036614690746, 6713.0, 6726.730930762715, 6784.830379240559, 6014.849628759316, 6090.786822461193, 6614.206295244601, 6686.197656281277, 6688.431483323972, 6058.12157237207, 6198.287196972406, 6228.190335256388, 6236.594621349598, 6238.064290356301, 6244.219472565929, 6285.685715714288, 6286.214223222098, 6286.842828929313, 6293.3391993841815], "unit": "ms", "name": "mootools.html", "value": 4218.88207720292}, {"lowerIsBetter": false, "replicates": [295.06905712477135, 299.20710118186804, 301.585320184746, 304.9435854366942, 306.4789857242688, 5958.0, 5994.940050599493, 6077.361877002906, 6099.6340219586855, 6106.786262480809, 5992.970035149829, 5994.8801023979495, 5995.5503337249775, 5996.070609055592, 6035.939640603593, 4341.4790225172865, 4540.9772951135365, 4548.886277843064, 4549.863504094882, 4569.954300456986, 4416.0, 4419.734815911055, 4479.305707615308, 4514.300283456069, 4516.683832131752, 4427.9557204427865, 4449.84425545106, 4458.71018383804, 4459.509453960078, 4462.687611867171, 4288.656907447428, 4368.672349573794, 4399.318105693591, 4448.4884238312525, 4449.5995360417555, 3878.0886491674432, 3899.863504777319, 3906.667933225679, 3906.902327441808, 3911.1004468972296, 5731.742071606787, 5733.283339582552, 5734.225879506297, 5739.139129130622, 5754.482096611283, 5230.08473517133, 5234.18870075139, 5240.292560504321, 5241.0, 5245.134552798783, 6203.1005504202085, 6339.936600633981, 6349.52378571609, 6373.203349581302, 6427.614343139427, 4259.957400425987, 4263.744175349489, 4265.232258193524, 4268.786560671954, 4273.829046838154, 6615.106960560359, 6683.933160668428, 6685.76599819004, 6690.431313338372, 6694.531382803157, 4231.217224813419, 4337.696361254745, 4341.761203133858, 4345.9130817383475, 4347.217500849877, 4389.692721509464, 4396.868093957187, 4399.450068741407, 4400.603945644907, 4404.8458303959205, 5179.067767801832, 5183.2743415921805, 5183.948160518346, 5189.844304670866, 5197.7401129943355, 6480.870382592416, 6481.351864813481, 6486.4162225398995, 6487.805365839033, 6497.707603157869, 1523.2307684619195, 1527.8548537888882, 1532.073095777061, 1548.620587955958, 1550.6045958280565, 977.8777652793401, 1013.469660812179, 1015.5277795824977, 1019.3079488049801, 1019.5157300282307, 6225.190725205694, 6239.875202495925, 6240.157578726814, 6249.187605611241, 6253.874922501524, 6686.1642294713165, 6694.09629699994, 6694.832629184212, 6699.5310328276555, 6700.0, 6191.288001879841, 6203.596766210182, 6220.69365433255, 6231.968840155861, 6241.500679945593, 3515.5605549306338, 3534.1871369585137, 3535.1338921964284, 3566.4828599853395, 3607.260511595117, 6842.6578671066245, 6861.142357205349, 6902.171739391305, 6902.344277293649, 6903.1716194057035, 6862.725490980305, 6872.934695122264, 6883.174019117638, 6884.105066341343, 6884.414824739853, 6772.390484856386, 6881.793546193622, 6907.34380233877, 6914.654267286615, 6918.204406493217, 6642.13652225227, 6652.7006284716335, 6656.567323123982, 6662.100616416916, 6713.362230588086, 6618.106555614931, 6631.1379520662, 6632.635205063768, 6635.402813746786, 6643.169603799525, 6737.3599508046655, 6903.447724182154, 6909.516333856582, 6910.792676219721, 6919.827004324932, 4380.3210502372185, 4397.758123303249, 4407.757573333497, 4409.206342858316, 4423.982484028627, 6678.799636010927, 6722.596644201363, 6724.462043036643, 6733.360330768569, 6734.73061077571, 6370.1718776558755, 6513.120728701565, 6518.413342799171, 6571.638559879252, 6575.112359831553, 6532.05285233648, 6536.150300460909, 6539.542232043711, 6543.280239173782, 6563.540552161494, 6414.486841052611, 6436.388543088399, 6436.6459844707115, 6441.098246245436, 6450.161479007887, 6358.554901156875, 6490.928996715489, 6561.179852518435, 6572.112764776885, 6592.307807680125, 6353.52348573868, 6414.967925160345, 6417.39034791694, 6421.614703117828, 6422.518311126591], "unit": "ms", "name": "prototype.html", "value": 4776.552604512091}, {"lowerIsBetter": false, "replicates": [793.480270422873, 817.8814071959566, 834.4062839975647, 865.1002956924799, 879.9472031678104, 12702.936485317572, 12894.806577901316, 12926.22442653439, 12940.029497787657, 12940.482380704772, 12731.745365092693, 12849.03632227582, 12854.035947303943, 12862.807057894139, 12878.80681789774, 679.51414738462, 686.6875571614928, 811.0470197517908, 813.7477382011566, 822.7038266224155, 820.6143112737034, 824.7814329202766, 826.8677011678133, 829.5686243153557, 829.7676650537829, 711.989320160198, 860.5052095045343, 862.9223369896708, 865.0484467086186, 865.1737590600961, 705.4885208224048, 710.7761055267574, 711.3064761857199, 713.564725517434, 842.9452085614415, 635.9841003974891, 636.2619361540637, 636.4494712074069, 637.7863415755727, 639.4660458517144, 12685.682857928534, 12829.23024618526, 12862.228266303959, 12923.0, 12929.418176182095, 12332.506699732, 12705.301208433533, 12829.55096571625, 12904.548340808027, 13718.794218086736, 10118.797624047551, 10333.534990925426, 10519.158467322672, 10520.684379468628, 10529.875425814924, 3559.9110022249392, 3691.464737613058, 3711.5917249102577, 3790.5451345838674, 3850.0567360996456, 43452.78273608643, 43743.34384984228, 49818.25272620914, 50372.0, 50473.24290135651, 10072.647457338959, 10120.949395252977, 10176.473528970713, 10225.59097636101, 10553.208509361828, 19002.809971900104, 19084.90457547731, 19102.904485477484, 19112.2355105797, 19129.521761955784, 7154.427645788429, 7155.284471552803, 7274.454415918827, 7295.124585049722, 7391.445641576904, 3717.9070523236596, 3735.850565977385, 3920.0591857954455, 3986.142979259473, 3987.960120398817, 3088.660247372787, 3093.381323735262, 3109.657937626859, 3111.144435280316, 3118.345147519001, 530.9628326017219, 544.727636181909, 545.9044667183307, 545.9563234941195, 550.8953298873201, 640.9111653471422, 656.9704363303663, 662.1061566884667, 667.813012356541, 691.920429150644, 8687.131286871389, 8829.867551986725, 8843.911560884437, 8933.571641346389, 9032.503212323385, 584.8917950179231, 592.5585438848, 677.9457643388517, 683.0, 707.504746677328, 3765.3975363942186, 3916.4516967624554, 4070.4708387909973, 4144.70987030911, 4186.434831297796, 60430.697846511364, 60750.69624651937, 60835.69582152061, 61034.38965610376, 61113.38886611166, 48128.0, 49204.0, 49422.25866612004, 50026.49973500219, 50034.24948625774, 46587.0, 46735.29897051547, 46962.76518617385, 47203.999999999316, 48170.759146204044, 8735.475871447734, 8861.0, 9047.0, 9091.499967501852, 9249.722508324761, 35497.290054199286, 35569.28861422809, 36284.81857590695, 36402.27195456023, 36407.817960910026, 42670.0, 46296.53703463057, 47472.0, 47587.0, 48632.270515943, 11096.167787416138, 11205.103591712807, 11251.481050058137, 11259.362480404241, 11336.6032188873, 12587.811182832082, 12601.558945436866, 12612.810807837706, 13379.331033448483, 13390.995675324584, 10843.24097313212, 11253.887461125283, 11373.260738052, 11798.882011179778, 11918.225315354473, 11309.095272378354, 11549.826752598885, 11589.478473468545, 11630.825537616773, 12026.398680065786, 11109.669952508293, 11441.656750297505, 11646.35945022998, 12078.879211207775, 12151.270923744603, 9572.76068098303, 9653.276004299565, 9746.463944483121, 10102.747431314276, 10206.132478739093, 9095.727128186165, 9892.45591492446, 9946.502674866373, 10022.0, 10047.748806279902], "unit": "ms", "name": "yui.html", "value": 6326.3618844285}], "name": "dromaeo_css", "value": 6970.473089654088}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 103.0, 107.0, 109.0, 109.0, 98.0, 110.0, 108.0, 100.0], "unit": "ms", "name": "ai-astar", "value": 106.5}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 148.0, 159.0, 131.0, 156.0, 159.0, 129.0, 165.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 160.0, 162.0, 161.0, 161.0, 161.0, 159.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 84.0, 94.0, 70.0, 71.0, 71.0, 100.0, 96.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 140.0, 93.0, 94.0, 93.0, 144.0, 92.0, 93.0, 146.0], "unit": "ms", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 108.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 58.0, 59.0, 59.0, 60.0, 59.0, 60.0, 63.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 69.0, 69.0, 69.0, 70.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 86.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [126.0, 115.0, 122.0, 114.0, 121.0, 121.0, 116.0, 115.0, 122.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [140.0, 154.0, 152.0, 160.0, 138.0, 139.0, 162.0, 150.0, 151.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 67.0, 65.0, 69.0, 66.0, 65.0, 67.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1496.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [190.2587519025875], "unit": "score", "name": "Richards", "value": 185.54731199999992}, {"lowerIsBetter": false, "replicates": [194.4012441679627], "unit": "score", "name": "DeltaBlue", "value": 340.110992}, {"lowerIsBetter": false, "replicates": [286.368843069874], "unit": "score", "name": "Encrypt", "value": 929.5040519999998}, {"lowerIsBetter": false, "replicates": [5005.0], "unit": "score", "name": "Decrypt", "value": 53.18301698301701}, {"lowerIsBetter": false, "replicates": [1964.6365422396857], "unit": "score", "name": "RayTrace", "value": 376.654401}, {"lowerIsBetter": false, "replicates": [756.0422960725075], "unit": "score", "name": "Earley", "value": 881.5154965034969}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [26102.5641025641], "unit": "score", "name": "RegExp", "value": 34.90021119842827}, {"lowerIsBetter": false, "replicates": [633.6696090794452], "unit": "score", "name": "Splay", "value": 128.60171741293536}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19508.99947696932}]} 10:30:21 INFO - RETURN: dromaeo_css: 6970.47 10:30:21 INFO - RETURN: kraken: 1496.40 10:30:21 INFO - RETURN: v8_7: 19509.00 10:30:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19509.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1496.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6970.47"}}} 10:30:21 INFO - Return code: 0 10:30:21 INFO - # TBPL SUCCESS # 10:30:21 INFO - Running post-action listener: _resource_record_post_action 10:30:21 INFO - Running post-run listener: _resource_record_post_run 10:30:22 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 20480; Write bytes: 496373760; Read time: 32; Write time: 490732 10:30:22 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 164052992; Read time: 0; Write time: 209784 10:30:22 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 20480; Write bytes: 332316672; Read time: 32; Write time: 280524 10:30:22 INFO - Running post-run listener: _upload_blobber_files 10:30:22 INFO - Blob upload gear active. 10:30:22 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:30:22 INFO - Copying logs to upload dir... 10:30:22 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.407369 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-24 10:30:22.729776) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 10:30:22.736839) ========= 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=004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010037 build_url: 'https://queue.taskcluster.net/v1/task/_8oY2oQRTB-CF-w-iV9-9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 10:30:22.796833) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:30:22.797215) ========= 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=004b26eee9c3b360c8654f40000001e1-1448388558.752151-1099896664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:30:22.846863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 10:30:22.847651) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 10:30:22.847939) ========= ========= Total master_lag: 0.19 =========