builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1447954249.64 results: success (0) buildid: 20151119065326 builduid: 3fcf9953c55f45268bec00dfe185599f revision: a523d4c7efe2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.639726) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.640191) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.640474) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006396 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.660000) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.660326) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.668108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.668403) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004361 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.716945) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.717259) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.717625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.717894) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 09:30:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 16.9M=0.001s 2015-11-19 09:30:50 (16.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197721 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.927613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.927921) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018520 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.977190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:49.977571) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a523d4c7efe2 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a523d4c7efe2 --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=76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 09:30:50,241 Setting DEBUG logging. 2015-11-19 09:30:50,241 attempt 1/10 2015-11-19 09:30:50,241 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a523d4c7efe2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 09:30:50,499 unpacking tar archive at: mozilla-central-a523d4c7efe2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.504777 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:50.495516) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:50.495824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:50.505612) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:50.506028) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:50.506515) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-19 09:30:50.506794) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:30:50 INFO - MultiFileLogger online at 20151119 09:30:50 in /builds/slave/test-pgo 09:30:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:30:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:30:50 INFO - {'append_to_log': False, 09:30:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:30:50 INFO - 'blob_upload_branch': 'Firefox', 09:30:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:30:50 INFO - 'branch': 'Firefox', 09:30:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:30:50 INFO - 'config_files': ('talos/linux_config.py',), 09:30:50 INFO - 'default_actions': ('clobber', 09:30:50 INFO - 'read-buildbot-config', 09:30:50 INFO - 'download-and-extract', 09:30:50 INFO - 'populate-webroot', 09:30:50 INFO - 'create-virtualenv', 09:30:50 INFO - 'install', 09:30:50 INFO - 'run-tests'), 09:30:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:30:50 INFO - 'download_minidump_stackwalk': True, 09:30:50 INFO - 'download_symbols': 'ondemand', 09:30:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:30:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:30:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:30:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:30:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:30:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:30:50 INFO - 'installer_path': 'installer.exe', 09:30:50 INFO - 'log_level': 'info', 09:30:50 INFO - 'log_name': 'talos', 09:30:50 INFO - 'log_to_console': True, 09:30:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:30:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:30:50 INFO - 'opt_config_files': (), 09:30:50 INFO - 'pip_index': False, 09:30:50 INFO - 'sps_profile': False, 09:30:50 INFO - 'sps_profile_interval': 0, 09:30:50 INFO - 'suite': 'dromaeojs', 09:30:50 INFO - 'system_bits': '64', 09:30:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:30:50 INFO - 'title': 'talos-linux64-ix-011', 09:30:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:30:50 INFO - 'use_talos_json': True, 09:30:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:30:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:30:50 INFO - 'work_dir': 'build'} 09:30:50 INFO - ##### 09:30:50 INFO - ##### Running clobber step. 09:30:50 INFO - ##### 09:30:50 INFO - Running pre-action listener: _resource_record_pre_action 09:30:50 INFO - Running main action method: clobber 09:30:50 INFO - rmtree: /builds/slave/test-pgo/build 09:30:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:30:51 INFO - Running post-action listener: _resource_record_post_action 09:30:51 INFO - ##### 09:30:51 INFO - ##### Running read-buildbot-config step. 09:30:51 INFO - ##### 09:30:51 INFO - Running pre-action listener: _resource_record_pre_action 09:30:51 INFO - Running main action method: read_buildbot_config 09:30:51 INFO - Using buildbot properties: 09:30:51 INFO - { 09:30:51 INFO - "properties": { 09:30:51 INFO - "buildnumber": 567, 09:30:51 INFO - "product": "firefox", 09:30:51 INFO - "script_repo_revision": "production", 09:30:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:30:51 INFO - "repository": "", 09:30:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 09:30:51 INFO - "buildid": "20151119065326", 09:30:51 INFO - "slavename": "talos-linux64-ix-011", 09:30:51 INFO - "stage_platform": "linux64-pgo", 09:30:51 INFO - "basedir": "/builds/slave/test-pgo", 09:30:51 INFO - "nightly_build": "True", 09:30:51 INFO - "project": "", 09:30:51 INFO - "platform": "ubuntu64_hw", 09:30:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:30:51 INFO - "slavebuilddir": "test", 09:30:51 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:30:51 INFO - "branch": "mozilla-central", 09:30:51 INFO - "repo_path": "mozilla-central", 09:30:51 INFO - "pgo_build": "True", 09:30:51 INFO - "builduid": "3fcf9953c55f45268bec00dfe185599f", 09:30:51 INFO - "revision": "a523d4c7efe2" 09:30:51 INFO - }, 09:30:51 INFO - "sourcestamp": { 09:30:51 INFO - "repository": "", 09:30:51 INFO - "hasPatch": false, 09:30:51 INFO - "project": "", 09:30:51 INFO - "branch": "mozilla-central-linux64-pgo-talos", 09:30:51 INFO - "changes": [ 09:30:51 INFO - { 09:30:51 INFO - "category": null, 09:30:51 INFO - "files": [ 09:30:51 INFO - { 09:30:51 INFO - "url": null, 09:30:51 INFO - "name": "https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:30:51 INFO - } 09:30:51 INFO - ], 09:30:51 INFO - "repository": "", 09:30:51 INFO - "rev": "a523d4c7efe2", 09:30:51 INFO - "who": "sendchange", 09:30:51 INFO - "when": 1447953887, 09:30:51 INFO - "number": 6683862, 09:30:51 INFO - "comments": "", 09:30:51 INFO - "project": "", 09:30:51 INFO - "at": "Thu 19 Nov 2015 09:24:47", 09:30:51 INFO - "branch": "mozilla-central-linux64-pgo-talos", 09:30:51 INFO - "revlink": "", 09:30:51 INFO - "properties": [ 09:30:51 INFO - [ 09:30:51 INFO - "buildid", 09:30:51 INFO - "20151119065326", 09:30:51 INFO - "Change" 09:30:51 INFO - ], 09:30:51 INFO - [ 09:30:51 INFO - "builduid", 09:30:51 INFO - "3fcf9953c55f45268bec00dfe185599f", 09:30:51 INFO - "Change" 09:30:51 INFO - ], 09:30:51 INFO - [ 09:30:51 INFO - "nightly_build", 09:30:51 INFO - "True", 09:30:51 INFO - "Change" 09:30:51 INFO - ], 09:30:51 INFO - [ 09:30:51 INFO - "pgo_build", 09:30:51 INFO - "True", 09:30:51 INFO - "Change" 09:30:51 INFO - ] 09:30:51 INFO - ], 09:30:51 INFO - "revision": "a523d4c7efe2" 09:30:51 INFO - } 09:30:51 INFO - ], 09:30:51 INFO - "revision": "a523d4c7efe2" 09:30:51 INFO - } 09:30:51 INFO - } 09:30:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:30:51 INFO - Running post-action listener: _resource_record_post_action 09:30:51 INFO - ##### 09:30:51 INFO - ##### Running download-and-extract step. 09:30:51 INFO - ##### 09:30:51 INFO - Running pre-action listener: _resource_record_pre_action 09:30:51 INFO - Running main action method: download_and_extract 09:30:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:51 INFO - https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:30:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/test_packages.json 09:30:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/test_packages.json 09:30:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:30:51 INFO - Downloaded 1302 bytes. 09:30:51 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:30:51 INFO - Using the following test package requirements: 09:30:51 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:30:51 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:30:51 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:51 INFO - u'jsshell-linux-x86_64.zip'], 09:30:51 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:30:51 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:30:52 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:30:52 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:30:52 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:30:52 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:30:52 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:30:52 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:30: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')]} 09:30:52 INFO - https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:30:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:30:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:30:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/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 09:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/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 09:30:53 INFO - Downloaded 22521079 bytes. 09:30:53 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 09:30:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:30:53 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 09:30:54 INFO - Return code: 0 09:30:54 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 09:30:54 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')]} 09:30:54 INFO - https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:30:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:30:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:30:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/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 09:30:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/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 09:31:00 INFO - Downloaded 22521079 bytes. 09:31:00 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 09:31:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:31:00 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 09:31:01 INFO - Return code: 0 09:31:01 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')]} 09:31:01 INFO - https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:31:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/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 09:31:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/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 09:31:02 INFO - Downloaded 11130997 bytes. 09:31:02 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 09:31:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:02 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 09:31:02 INFO - Return code: 0 09:31:02 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')]} 09:31:02 INFO - https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:31:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:31:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:31:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/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 09:31:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWhcG3fsRnS9LLoBlUZAnw/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 09:31:04 INFO - Downloaded 57334512 bytes. 09:31:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:31:04 INFO - mkdir: /builds/slave/test-pgo/properties 09:31:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:31:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:31:04 INFO - Contents: 09:31:04 INFO - build_url:https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:31:04 INFO - Running post-action listener: _resource_record_post_action 09:31:04 INFO - Running post-action listener: set_extra_try_arguments 09:31:04 INFO - ##### 09:31:04 INFO - ##### Running populate-webroot step. 09:31:04 INFO - ##### 09:31:04 INFO - Running pre-action listener: _resource_record_pre_action 09:31:04 INFO - Running main action method: populate_webroot 09:31:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:31:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:31:04 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:31:04 INFO - '../fennec_ids.txt'], 09:31:04 INFO - 'tests': ['tcheck2']}, 09:31:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:31:04 INFO - '--tppagecycles', 09:31:04 INFO - '7'], 09:31:04 INFO - 'tests': ['tsvgm']}}, 09:31:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:31:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:31:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:31:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:31:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:31:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:31:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:04 INFO - 'talos_options': ['--e10s'], 09:31:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:04 INFO - 'tests': ['damp', 'tps']}, 09:31:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:04 INFO - 'talos_options': ['--e10s'], 09:31:04 INFO - 'tests': ['damp', 'tps']}, 09:31:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:31:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:31:04 INFO - 'other': {'tests': ['a11yr', 09:31:04 INFO - 'ts_paint', 09:31:04 INFO - 'tpaint', 09:31:04 INFO - 'sessionrestore', 09:31:04 INFO - 'sessionrestore_no_auto_restore']}, 09:31:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:31:04 INFO - 'tests': ['a11yr', 09:31:04 INFO - 'ts_paint', 09:31:04 INFO - 'tpaint', 09:31:04 INFO - 'sessionrestore', 09:31:04 INFO - 'sessionrestore_no_auto_restore']}, 09:31:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:31:04 INFO - 'tests': ['a11yr', 09:31:04 INFO - 'ts_paint', 09:31:04 INFO - 'tpaint', 09:31:04 INFO - 'sessionrestore', 09:31:04 INFO - 'sessionrestore_no_auto_restore']}, 09:31:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:31:04 INFO - 'tests': ['a11yr', 09:31:04 INFO - 'ts_paint', 09:31:04 INFO - 'tpaint', 09:31:04 INFO - 'sessionrestore', 09:31:04 INFO - 'sessionrestore_no_auto_restore']}, 09:31:04 INFO - 'other_l64': {'tests': ['a11yr', 09:31:04 INFO - 'ts_paint', 09:31:04 INFO - 'tpaint', 09:31:04 INFO - 'sessionrestore', 09:31:04 INFO - 'sessionrestore_no_auto_restore']}, 09:31:04 INFO - 'other_nol64': {'tests': ['a11yr', 09:31:04 INFO - 'ts_paint', 09:31:04 INFO - 'tpaint', 09:31:04 INFO - 'sessionrestore', 09:31:04 INFO - 'sessionrestore_no_auto_restore']}, 09:31:04 INFO - 'svgr': {'tests': ['tsvgx', 09:31:04 INFO - 'tsvgr_opacity', 09:31:04 INFO - 'tart', 09:31:04 INFO - 'tscrollx', 09:31:04 INFO - 'cart']}, 09:31:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:31:04 INFO - 'tests': ['tsvgx', 09:31:04 INFO - 'tsvgr_opacity', 09:31:04 INFO - 'tart', 09:31:04 INFO - 'tscrollx', 09:31:04 INFO - 'cart']}, 09:31:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:04 INFO - 'tests': ['tp5o']}, 09:31:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:04 INFO - 'talos_options': ['--e10s'], 09:31:04 INFO - 'tests': ['tp5o']}, 09:31:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:04 INFO - 'talos_options': ['--xperf_path', 09:31:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:04 INFO - 'tests': ['tp5n']}, 09:31:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:04 INFO - 'talos_options': ['--e10s', 09:31:04 INFO - '--xperf_path', 09:31:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:04 INFO - 'tests': ['tp5n']}}, 09:31:04 INFO - 'talos.zip': {'path': '', 09:31:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:31:04 INFO - Running post-action listener: _resource_record_post_action 09:31:04 INFO - ##### 09:31:04 INFO - ##### Running create-virtualenv step. 09:31:04 INFO - ##### 09:31:04 INFO - Running pre-action listener: _resource_record_pre_action 09:31:04 INFO - Running main action method: create_virtualenv 09:31:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:31:04 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 09:31:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:31:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:31:04 INFO - Using real prefix '/usr' 09:31:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:31:04 INFO - Installing distribute.............................................................................................................................................................................................done. 09:31:06 INFO - Installing pip.................done. 09:31:06 INFO - Return code: 0 09:31:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2ca03bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ed70>, '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 0x126fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ffb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', '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 09:31:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:31:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:31:06 INFO - Using env: {'DISPLAY': ':0', 09:31:06 INFO - 'HOME': '/home/cltbld', 09:31:06 INFO - 'LANG': 'en_US.UTF-8', 09:31:06 INFO - 'LANGUAGE': 'en_US:en', 09:31:06 INFO - 'LOGNAME': 'cltbld', 09:31:06 INFO - 'MAIL': '/var/mail/cltbld', 09:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:06 INFO - 'MOZ_NO_REMOTE': '1', 09:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:06 INFO - 'NO_EM_RESTART': '1', 09:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:06 INFO - 'SHELL': '/bin/bash', 09:31:06 INFO - 'SHLVL': '1', 09:31:06 INFO - 'TERM': 'linux', 09:31:06 INFO - 'TMOUT': '86400', 09:31:06 INFO - 'USER': 'cltbld', 09:31:06 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', 09:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:06 INFO - '_': '/tools/buildbot/bin/python'} 09:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:06 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 09:31:06 INFO - Cleaning up... 09:31:06 INFO - Return code: 0 09:31:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe2ca03bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ed70>, '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 0x126fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ffb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', '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 09:31:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:31:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:31:06 INFO - Using env: {'DISPLAY': ':0', 09:31:06 INFO - 'HOME': '/home/cltbld', 09:31:06 INFO - 'LANG': 'en_US.UTF-8', 09:31:06 INFO - 'LANGUAGE': 'en_US:en', 09:31:06 INFO - 'LOGNAME': 'cltbld', 09:31:06 INFO - 'MAIL': '/var/mail/cltbld', 09:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:06 INFO - 'MOZ_NO_REMOTE': '1', 09:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:06 INFO - 'NO_EM_RESTART': '1', 09:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:06 INFO - 'SHELL': '/bin/bash', 09:31:06 INFO - 'SHLVL': '1', 09:31:06 INFO - 'TERM': 'linux', 09:31:06 INFO - 'TMOUT': '86400', 09:31:06 INFO - 'USER': 'cltbld', 09:31:06 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', 09:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:06 INFO - '_': '/tools/buildbot/bin/python'} 09:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:07 INFO - Downloading/unpacking psutil>=0.7.1 09:31:07 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 09:31:07 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 09:31:07 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 09:31:07 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 09:31:07 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 09:31:07 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 09:31:08 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:31:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:31:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:31:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:08 INFO - Installing collected packages: psutil 09:31:08 INFO - Running setup.py install for psutil 09:31:09 INFO - building 'psutil._psutil_linux' extension 09:31:09 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 09:31:09 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 09:31:09 INFO - building 'psutil._psutil_posix' extension 09:31:09 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 09:31:09 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 09:31:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:09 INFO - Successfully installed psutil 09:31:09 INFO - Cleaning up... 09:31:09 INFO - Return code: 0 09:31:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:09 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 0x7fe2ca03bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ed70>, '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 0x126fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ffb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', '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 09:31:09 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 09:31:09 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 09:31:09 INFO - Using env: {'DISPLAY': ':0', 09:31:09 INFO - 'HOME': '/home/cltbld', 09:31:09 INFO - 'LANG': 'en_US.UTF-8', 09:31:09 INFO - 'LANGUAGE': 'en_US:en', 09:31:09 INFO - 'LOGNAME': 'cltbld', 09:31:09 INFO - 'MAIL': '/var/mail/cltbld', 09:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:09 INFO - 'MOZ_NO_REMOTE': '1', 09:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:09 INFO - 'NO_EM_RESTART': '1', 09:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:09 INFO - 'SHELL': '/bin/bash', 09:31:09 INFO - 'SHLVL': '1', 09:31:09 INFO - 'TERM': 'linux', 09:31:09 INFO - 'TMOUT': '86400', 09:31:09 INFO - 'USER': 'cltbld', 09:31:09 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', 09:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:09 INFO - '_': '/tools/buildbot/bin/python'} 09:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:31:09 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 09:31:09 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 09:31:09 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 09:31:09 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 09:31:09 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 09:31:09 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 09:31:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:31:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:31:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:31:11 INFO - Installing collected packages: mozsystemmonitor 09:31:11 INFO - Running setup.py install for mozsystemmonitor 09:31:11 INFO - Successfully installed mozsystemmonitor 09:31:11 INFO - Cleaning up... 09:31:11 INFO - Return code: 0 09:31:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:11 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 0x7fe2ca03bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ed70>, '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 0x126fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ffb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', '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 09:31:11 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 09:31:11 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 09:31:11 INFO - Using env: {'DISPLAY': ':0', 09:31:11 INFO - 'HOME': '/home/cltbld', 09:31:11 INFO - 'LANG': 'en_US.UTF-8', 09:31:11 INFO - 'LANGUAGE': 'en_US:en', 09:31:11 INFO - 'LOGNAME': 'cltbld', 09:31:11 INFO - 'MAIL': '/var/mail/cltbld', 09:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:11 INFO - 'MOZ_NO_REMOTE': '1', 09:31:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:11 INFO - 'NO_EM_RESTART': '1', 09:31:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:11 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:11 INFO - 'SHELL': '/bin/bash', 09:31:11 INFO - 'SHLVL': '1', 09:31:11 INFO - 'TERM': 'linux', 09:31:11 INFO - 'TMOUT': '86400', 09:31:11 INFO - 'USER': 'cltbld', 09:31:11 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', 09:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:11 INFO - '_': '/tools/buildbot/bin/python'} 09:31:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:11 INFO - Downloading/unpacking blobuploader==1.2.4 09:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:13 INFO - Downloading blobuploader-1.2.4.tar.gz 09:31:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:31:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:31:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:31:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:31:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:14 INFO - Downloading docopt-0.6.1.tar.gz 09:31:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:31:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:31:14 INFO - Installing collected packages: blobuploader, requests, docopt 09:31:14 INFO - Running setup.py install for blobuploader 09:31:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:31:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:31:14 INFO - Running setup.py install for requests 09:31:14 INFO - Running setup.py install for docopt 09:31:14 INFO - Successfully installed blobuploader requests docopt 09:31:14 INFO - Cleaning up... 09:31:14 INFO - Return code: 0 09:31:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:31:14 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')]} 09:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:14 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')]} 09:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:14 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 0x7fe2ca03bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ed70>, '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 0x126fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ffb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', '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 09:31:14 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 09:31:14 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 09:31:14 INFO - Using env: {'DISPLAY': ':0', 09:31:14 INFO - 'HOME': '/home/cltbld', 09:31:14 INFO - 'LANG': 'en_US.UTF-8', 09:31:14 INFO - 'LANGUAGE': 'en_US:en', 09:31:14 INFO - 'LOGNAME': 'cltbld', 09:31:14 INFO - 'MAIL': '/var/mail/cltbld', 09:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:14 INFO - 'MOZ_NO_REMOTE': '1', 09:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:14 INFO - 'NO_EM_RESTART': '1', 09:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:14 INFO - 'SHELL': '/bin/bash', 09:31:14 INFO - 'SHLVL': '1', 09:31:14 INFO - 'TERM': 'linux', 09:31:14 INFO - 'TMOUT': '86400', 09:31:14 INFO - 'USER': 'cltbld', 09:31:14 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', 09:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:14 INFO - '_': '/tools/buildbot/bin/python'} 09:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:31:14 INFO - Running setup.py (path:/tmp/pip-USDa8n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:31:15 INFO - Running setup.py (path:/tmp/pip-T55mtN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:31:15 INFO - Running setup.py (path:/tmp/pip-AhIQxX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:31:15 INFO - Running setup.py (path:/tmp/pip-fPhNQ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:31:15 INFO - Running setup.py (path:/tmp/pip-Z7iLfB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:31:15 INFO - Running setup.py (path:/tmp/pip-YKgOmU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:31:15 INFO - Running setup.py (path:/tmp/pip-2x17ev-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:31:15 INFO - Running setup.py (path:/tmp/pip-IL0ZRg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:31:15 INFO - Running setup.py (path:/tmp/pip-_CBR0Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:31:15 INFO - Running setup.py (path:/tmp/pip-qOF_HO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:31:15 INFO - Running setup.py (path:/tmp/pip-jWTFe2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:31:15 INFO - Running setup.py (path:/tmp/pip-2Sqklz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:31:15 INFO - Running setup.py (path:/tmp/pip-JZ1QAR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:31:15 INFO - Running setup.py (path:/tmp/pip-HOLCNe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:31:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:31:15 INFO - Running setup.py (path:/tmp/pip-W_8nYX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:31:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:31:16 INFO - Running setup.py (path:/tmp/pip-nW4a4q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:31:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:31:16 INFO - Running setup.py (path:/tmp/pip-mpOvG2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:31:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:31:16 INFO - Running setup.py install for manifestparser 09:31:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:31:16 INFO - Running setup.py install for mozcrash 09:31:16 INFO - Running setup.py install for mozdebug 09:31:16 INFO - Running setup.py install for mozdevice 09:31:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:31:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:31:16 INFO - Running setup.py install for mozfile 09:31:16 INFO - Running setup.py install for mozhttpd 09:31:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:31:16 INFO - Running setup.py install for mozinfo 09:31:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:31:16 INFO - Running setup.py install for mozInstall 09:31:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:31:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:31:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:31:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:31:16 INFO - Running setup.py install for mozleak 09:31:17 INFO - Running setup.py install for mozlog 09:31:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:31:17 INFO - Running setup.py install for moznetwork 09:31:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:31:17 INFO - Running setup.py install for mozprocess 09:31:17 INFO - Running setup.py install for mozprofile 09:31:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:31:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:31:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:31:17 INFO - Running setup.py install for mozrunner 09:31:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:31:17 INFO - Running setup.py install for mozscreenshot 09:31:17 INFO - Running setup.py install for moztest 09:31:17 INFO - Running setup.py install for mozversion 09:31:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:31:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:31:17 INFO - Cleaning up... 09:31:17 INFO - Return code: 0 09:31:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fe2ca03bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ed70>, '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 0x126fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ffb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', '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 09:31:17 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 09:31:17 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 09:31:17 INFO - Using env: {'DISPLAY': ':0', 09:31:17 INFO - 'HOME': '/home/cltbld', 09:31:17 INFO - 'LANG': 'en_US.UTF-8', 09:31:17 INFO - 'LANGUAGE': 'en_US:en', 09:31:17 INFO - 'LOGNAME': 'cltbld', 09:31:17 INFO - 'MAIL': '/var/mail/cltbld', 09:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:17 INFO - 'MOZ_NO_REMOTE': '1', 09:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:17 INFO - 'NO_EM_RESTART': '1', 09:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:17 INFO - 'SHELL': '/bin/bash', 09:31:17 INFO - 'SHLVL': '1', 09:31:17 INFO - 'TERM': 'linux', 09:31:17 INFO - 'TMOUT': '86400', 09:31:17 INFO - 'USER': 'cltbld', 09:31:17 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', 09:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:17 INFO - '_': '/tools/buildbot/bin/python'} 09:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:31:18 INFO - Running setup.py (path:/tmp/pip-1hMhjM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:31:18 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)) 09:31:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:31:18 INFO - Running setup.py (path:/tmp/pip-2Mb8AI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:31:18 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)) 09:31:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:31:18 INFO - Running setup.py (path:/tmp/pip-7ErIVg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:31:18 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)) 09:31:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:31:18 INFO - Running setup.py (path:/tmp/pip-BKYYA4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:31:18 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)) 09:31:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:31:18 INFO - Running setup.py (path:/tmp/pip-EEisrS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:31:18 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)) 09:31:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:31:18 INFO - Running setup.py (path:/tmp/pip-MBwHs6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:31:18 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)) 09:31:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:31:18 INFO - Running setup.py (path:/tmp/pip-TYztDP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:31:18 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)) 09:31:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:31:18 INFO - Running setup.py (path:/tmp/pip-Kh8OOb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:31:18 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)) 09:31:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:31:18 INFO - Running setup.py (path:/tmp/pip-bBE4jJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:31:18 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)) 09:31:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:31:18 INFO - Running setup.py (path:/tmp/pip-SfYzwq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:31:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:31:18 INFO - Running setup.py (path:/tmp/pip-XrHLLV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:31:18 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)) 09:31:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:31:18 INFO - Running setup.py (path:/tmp/pip-96awKm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:31:19 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)) 09:31:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:31:19 INFO - Running setup.py (path:/tmp/pip-_tnO1K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:31:19 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)) 09:31:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:31:19 INFO - Running setup.py (path:/tmp/pip-vbEg3r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:31:19 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)) 09:31:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:31:19 INFO - Running setup.py (path:/tmp/pip-4Y83kX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:31:19 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)) 09:31:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:31:19 INFO - Running setup.py (path:/tmp/pip-_xObch-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:31:19 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)) 09:31:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:31:19 INFO - Running setup.py (path:/tmp/pip-lRBUGg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:31:19 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)) 09:31:19 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)) 09:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:31:19 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)) 09:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:31:19 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)) 09:31:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:21 INFO - Downloading blessings-1.5.1.tar.gz 09:31:21 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 09:31:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:31:21 INFO - Installing collected packages: blessings 09:31:21 INFO - Running setup.py install for blessings 09:31:21 INFO - Successfully installed blessings 09:31:21 INFO - Cleaning up... 09:31:21 INFO - Return code: 0 09:31:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:31:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:31:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:31:21 INFO - Reading from file tmpfile_stdout 09:31:21 INFO - Current package versions: 09:31:21 INFO - argparse == 1.2.1 09:31:21 INFO - blessings == 1.5.1 09:31:21 INFO - blobuploader == 1.2.4 09:31:21 INFO - docopt == 0.6.1 09:31:21 INFO - manifestparser == 1.1 09:31:21 INFO - mozInstall == 1.12 09:31:21 INFO - mozcrash == 0.16 09:31:21 INFO - mozdebug == 0.1 09:31:21 INFO - mozdevice == 0.47 09:31:21 INFO - mozfile == 1.2 09:31:21 INFO - mozhttpd == 0.7 09:31:21 INFO - mozinfo == 0.9 09:31:21 INFO - mozleak == 0.1 09:31:21 INFO - mozlog == 3.0 09:31:21 INFO - moznetwork == 0.27 09:31:21 INFO - mozprocess == 0.22 09:31:21 INFO - mozprofile == 0.27 09:31:21 INFO - mozrunner == 6.11 09:31:21 INFO - mozscreenshot == 0.1 09:31:21 INFO - mozsystemmonitor == 0.0 09:31:21 INFO - moztest == 0.7 09:31:21 INFO - mozversion == 1.4 09:31:21 INFO - psutil == 3.1.1 09:31:21 INFO - requests == 1.2.3 09:31:21 INFO - wsgiref == 0.1.2 09:31:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:21 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 0x7fe2ca03bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ed70>, '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 0x126fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ffb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', '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 09:31:21 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 09:31:21 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 09:31:21 INFO - Using env: {'DISPLAY': ':0', 09:31:21 INFO - 'HOME': '/home/cltbld', 09:31:21 INFO - 'LANG': 'en_US.UTF-8', 09:31:21 INFO - 'LANGUAGE': 'en_US:en', 09:31:21 INFO - 'LOGNAME': 'cltbld', 09:31:21 INFO - 'MAIL': '/var/mail/cltbld', 09:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:21 INFO - 'MOZ_NO_REMOTE': '1', 09:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:21 INFO - 'NO_EM_RESTART': '1', 09:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:21 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:21 INFO - 'SHELL': '/bin/bash', 09:31:21 INFO - 'SHLVL': '1', 09:31:21 INFO - 'TERM': 'linux', 09:31:21 INFO - 'TMOUT': '86400', 09:31:21 INFO - 'USER': 'cltbld', 09:31:21 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', 09:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:21 INFO - '_': '/tools/buildbot/bin/python'} 09:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:21 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)) 09:31:21 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)) 09:31:21 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)) 09:31:21 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)) 09:31:21 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)) 09:31:21 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)) 09:31:21 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)) 09:31:21 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)) 09:31:21 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)) 09:31:21 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)) 09:31:21 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)) 09:31:21 INFO - Cleaning up... 09:31:21 INFO - Return code: 0 09:31:21 INFO - Running post-action listener: _resource_record_post_action 09:31:21 INFO - Running post-action listener: _start_resource_monitoring 09:31:21 INFO - Starting resource monitoring. 09:31:21 INFO - ##### 09:31:21 INFO - ##### Running install step. 09:31:21 INFO - ##### 09:31:21 INFO - Running pre-action listener: _resource_record_pre_action 09:31:21 INFO - Running main action method: install 09:31:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:31:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:31:22 INFO - Reading from file tmpfile_stdout 09:31:22 INFO - Detecting whether we're running mozinstall >=1.0... 09:31:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:31:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:31:22 INFO - Reading from file tmpfile_stdout 09:31:22 INFO - Output received: 09:31:22 INFO - Usage: mozinstall [options] installer 09:31:22 INFO - Options: 09:31:22 INFO - -h, --help show this help message and exit 09:31:22 INFO - -d DEST, --destination=DEST 09:31:22 INFO - Directory to install application into. [default: 09:31:22 INFO - "/builds/slave/test-pgo"] 09:31:22 INFO - --app=APP Application being installed. [default: firefox] 09:31:22 INFO - mkdir: /builds/slave/test-pgo/build/application 09:31:22 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'] 09:31:22 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 09:31:36 INFO - Reading from file tmpfile_stdout 09:31:36 INFO - Output received: 09:31:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:31:36 INFO - Running post-action listener: _resource_record_post_action 09:31:36 INFO - ##### 09:31:36 INFO - ##### Running run-tests step. 09:31:36 INFO - ##### 09:31:36 INFO - Running pre-action listener: _resource_record_pre_action 09:31:36 INFO - Running main action method: run_tests 09:31:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:31:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:31:36 INFO - Python 2.7.3 09:31:36 INFO - Return code: 0 09:31:36 INFO - grabbing minidump binary from tooltool 09:31:36 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')]} 09:31:36 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 0x126ed70>, '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 0x126fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ffb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:31:36 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 09:31:36 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 09:31:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:31:36 INFO - Return code: 0 09:31:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:31:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:31:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:31:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:31:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:31:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:31:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 09:31:36 INFO - Using env: {'DISPLAY': ':0', 09:31:36 INFO - 'HOME': '/home/cltbld', 09:31:36 INFO - 'LANG': 'en_US.UTF-8', 09:31:36 INFO - 'LANGUAGE': 'en_US:en', 09:31:36 INFO - 'LOGNAME': 'cltbld', 09:31:36 INFO - 'MAIL': '/var/mail/cltbld', 09:31:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:31:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:36 INFO - 'MOZ_NO_REMOTE': '1', 09:31:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:36 INFO - 'NO_EM_RESTART': '1', 09:31:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:36 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:31:36 INFO - 'SHELL': '/bin/bash', 09:31:36 INFO - 'SHLVL': '1', 09:31:36 INFO - 'TERM': 'linux', 09:31:36 INFO - 'TMOUT': '86400', 09:31:36 INFO - 'USER': 'cltbld', 09:31:36 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515', 09:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:36 INFO - '_': '/tools/buildbot/bin/python'} 09:31:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 09:31:36 INFO - mozversion INFO | application_buildid: 20151119065326 09:31:36 INFO - mozversion INFO | application_changeset: a523d4c7efe2f43dd6b25a176c07b729918d550f 09:31:36 INFO - mozversion INFO | application_display_name: Nightly 09:31:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:31:36 INFO - mozversion INFO | application_name: Firefox 09:31:36 INFO - mozversion INFO | application_remotingname: firefox 09:31:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 09:31:36 INFO - mozversion INFO | application_vendor: Mozilla 09:31:36 INFO - mozversion INFO | application_version: 45.0a1 09:31:36 INFO - mozversion INFO | platform_buildid: 20151119065326 09:31:36 INFO - mozversion INFO | platform_changeset: a523d4c7efe2f43dd6b25a176c07b729918d550f 09:31:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 09:31:36 INFO - mozversion INFO | platform_version: 45.0a1 09:31:36 INFO - 2015-11-19 09:31:36,955 DEBUG : using testdate: 1447954296 09:31:36 INFO - 2015-11-19 09:31:36,955 DEBUG : actual date: 1447954296 09:31:36 INFO - 2015-11-19 09:31:36,963 INFO : starting webserver on 'localhost:51679' 09:31:36 INFO - 2015-11-19 09:31:36,964 INFO : Starting test suite talos-linux64-ix-011 09:31:36 INFO - 2015-11-19 09:31:36,964 INFO : Starting test dromaeo_css 09:31:36 INFO - 2015-11-19 09:31:36,964 DEBUG : operating with platform_type : linux_ 09:31:36 INFO - 2015-11-19 09:31:36,964 INFO : Initialising browser for dromaeo_css test... 09:31:36 INFO - 2015-11-19 09:31:36,971 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqhwCzp/profile http://localhost:51679/getInfo.html 09:31:43 INFO - 2015-11-19 09:31:43,457 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:31:43 INFO - 2015-11-19 09:31:43,457 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:31:43 INFO - 2015-11-19 09:31:43,457 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:31:43 INFO - 2015-11-19 09:31:43,457 DEBUG : BROWSER_OUTPUT: __metrics 09:31:43 INFO - 2015-11-19 09:31:43,606 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:31:44 INFO - 2015-11-19 09:31:44,942 INFO : Browser initialized. 09:31:44 INFO - 2015-11-19 09:31:44,943 INFO : Running cycle 1/1 for dromaeo_css test... 09:31:44 INFO - 2015-11-19 09:31:44,943 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqhwCzp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:31:56 INFO - 2015-11-19 09:31:56,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 141664256 09:31:56 INFO - 2015-11-19 09:31:56,641 DEBUG : BROWSER_OUTPUT: 09:32:47 INFO - 2015-11-19 09:32:47,291 DEBUG : BROWSER_OUTPUT: 1447954367286 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] 09:34:57 INFO - 2015-11-19 09:34:57,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51679/tests/dromaeo/cssquery-ext.html) 09:34:58 INFO - 2015-11-19 09:34:58,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 252801024 09:34:58 INFO - 2015-11-19 09:34:58,456 DEBUG : BROWSER_OUTPUT: 09:38:00 INFO - 2015-11-19 09:38:00,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/dromaeo/cssquery-ext.html (next: http://localhost:51679/tests/dromaeo/cssquery-jquery.html) 09:38:01 INFO - 2015-11-19 09:38:01,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 219217920 09:38:01 INFO - 2015-11-19 09:38:01,496 DEBUG : BROWSER_OUTPUT: 09:41:03 INFO - 2015-11-19 09:41:03,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51679/tests/dromaeo/cssquery-mootools.html) 09:41:03 INFO - 2015-11-19 09:41:03,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 213196800 09:41:03 INFO - 2015-11-19 09:41:03,937 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-11-19 09:44:05,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51679/tests/dromaeo/cssquery-prototype.html) 09:44:06 INFO - 2015-11-19 09:44:06,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 196685824 09:44:06 INFO - 2015-11-19 09:44:06,353 DEBUG : BROWSER_OUTPUT: 09:47:08 INFO - 2015-11-19 09:47:08,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51679/tests/dromaeo/cssquery-yui.html) 09:47:09 INFO - 2015-11-19 09:47:09,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 201596928 09:47:09 INFO - 2015-11-19 09:47:09,390 DEBUG : BROWSER_OUTPUT: 09:50:12 INFO - 2015-11-19 09:50:12,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/dromaeo/cssquery-yui.html (next: http://localhost:51679/tests/dromaeo/cssquery-dojo.html) 09:50:12 INFO - 2015-11-19 09:50:12,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 265969664 09:50:12 INFO - 2015-11-19 09:50:12,567 DEBUG : BROWSER_OUTPUT: 09:50:12 INFO - 2015-11-19 09:50:12,567 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:50:12 INFO - 2015-11-19 09:50:12,567 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:50:12 INFO - 2015-11-19 09:50:12,567 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:50:12 INFO - 2015-11-19 09:50:12,567 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:50:12 INFO - 2015-11-19 09:50:12,568 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3146.323540438806;3218.9195270118257;3258.820764857932;3273.2307907641716;3284.8357582120902;5099.413567439746;5225.163973764198;5351.785928562857;5433.320834895638;5486.094794358926;5297.12597421425;5340;5340.172273297645;5363.463653634634;5486.890262194754;4914.778834952427;4929.309896614477;4946.332245146913;4976.178930476485;4980.676256043345;4729.668923175379;4975.875603109933;5001.649884508086;5042.369703787027;5072.72100034498;4840.806367745286;4909.091818013661;4955.479674634147;4958.033183529214;4960.454350021495;4962.131626965267;4980.5019498049905;4995.225740010304;5005.89988200234;5034.09386310464;4709.152352576535;4806.639502037361;4954.653174277802;4959.231319145538;4994.725290109042;5206;5247.737613119367;5254.4220135785035;5276.815311464119;5279.181726832308;5768.3654797972185;5770.538356931435;5774.105013722879;5782.45066718661;5809.82570522885;5571.916421253684;5700.173474846166;5751.884962300773;5770.6249093808765;5770.9422905770825;5400.21696853954;5410.323709536308;5413.864653383657;5414.485623865766;5422.024035673578;5864.296284445809;5872.119182122716;5878.676672783038;5881.558883083786;5885.764569417175;5512.751926163332;5595.496405323541;5598.048331783525;5623.465770751772;5674.687892165971;5782.479576838105;5805.390434004453;5816.214811000461;5816.592838501264;5820.534357251409;5711.457411545896;5766.884662306814;5770.942290577124;5777.19119323295;5784.479396854304;5569.443055694398;5693.686847223443;5769.942300577024;5776.595638305278;5786.074228123564;4421.7346959181905;4439.511653718088;4441.0673758511075;4442.711223770445;4503.324501324828;3991.7405368650943;3996.760194388346;4002.139539998914;4036.1524079942956;4042.2723909696538;5230.450802665741;5503.944960550423;5518.641288316247;5519.889602207933;5522.66863988162;5749.712514374264;5772.595918285764;5801.158831969341;5893;5927.2590926134235;5501.504864562128;5510.641808282448;5517.917231241535;5519.475649813261;5519.751611177427;4863.7324947128245;5042.899142017139;5074.720890350993;5076.923846142311;5122.436531981479;5809.157672137517;5899.115132730125;5900.291964964146;5926.733297001645;5986.970065149646;5733.455321744427;5738.713064346849;5755.482006619424;5789.536837052941;5810.767569297181;5875.14810352488;5912.320083190488;5917.644941303535;5923.614965027259;5925.229720136354;5497.285352904097;5658.717064146694;5672.546196304368;5673.517750991212;5693.886122277614;5689.061304884648;5751.769929202785;5814.3604203538425;5832.737526811388;5909.438603332676;5642.040853054908;5645.209670646031;5646.774129034792;5648.322201335702;5651.265335506522;5333.759980800795;5509.586780991362;5646.463585959327;5648.406917273627;5652.180433837153;5424.674519528841;5483.862903427446;5493.697846618475;5532.087205611029;5593.440655934537;5690.658560486218;5698.715064246854;5738.053221218619;5738.569607279387;5772.711364431846;5407.270018547603;5437.564994800327;5601.719914004365;5604.85987850307;5613.635113717595 09:50:12 INFO - 2015-11-19 09:50:12,570 DEBUG : BROWSER_OUTPUT: |1;ext.html;577.9075347944329;579.744912238615;582.1616871704746;586.0388962102151;609.0407608017374;31494.68505314949;32547.186320341974;40412.39381409278;41419;41431;43368.566314336924;44023.11953760923;44027.559724402745;44056.77971610145;44080.89797755058;7397.334239918407;8633.223009929121;8804.075572064938;8816.515091669955;8821.16198961101;7563.848723025564;7615.086189657249;7661.157272699998;7664.041994750656;10476.1095306899;10399.844002339933;10406.739831504197;10448.373097614129;10505.789884202311;10506.106980906632;10466.895331046706;10556.261061725681;10562.102221311197;10586.206034547362;10588.841167382496;7669.0797104347275;7833.1775163608145;7838.451308408414;10487.632932847313;10765.461726913623;41128.58871411307;41601.1679766406;41670.79164604157;41676;41689.37465938013;3280.6391296957318;3281.2289112058647;3518.309468639215;3617.366960781879;3952.2777653241446;31030.844845775853;31487.37025259482;31815;32098.518522222184;32789.18027049319;3599.190182208982;3640.5449318835144;3662.1943172502274;3678.503402040717;3797.2974999625158;284648;285578;287117.9999999979;287345;287793;54712;55817.441825582035;61540.69229653823;61734.69132654308;61881.38118618756;68561;69389.30610693828;69541.30458695449;69651.65174174096;69674;15510.30203640839;15581.844181558266;15613.14127722986;15676.372945082068;15724.528264152093;11754.471048802825;11756.706082347839;11776.234544754563;11777.587784427504;11804.645860624196;20168.890711010743;20590.58818823615;21037.78962210389;21136.47158821011;21206.78793212079;8075.192480751995;8455.534945578052;8490.15098490146;8505.787355316166;8510.531920744295;842.2377748137945;1004.3421558878946;1029.696239609317;1055.4247934875511;1127.3405058041137;28468.71531284702;28890.133296001153;29037.709622903923;29068.563971540443;29247;1022.1822541966545;1023.3501726403787;1119.5409881948362;1122.1135303110614;1134.9092072634335;14849.92575037118;14874.107553546823;14949.476768313274;15097.3206205721;15124.924375378052;322898;325228;328499;328940;329482;53263;53828.46171538234;53946.7302663492;54005.729971349894;54090.45909540854;1321.2799024531653;1342.6039318401095;1343.3014832287156;1346.3672074125145;1353.4045020191083;27506.862465687544;28132.57801132944;28159.859200703864;28420.431591367644;28520.85739571372;47543.04913901772;47948.36284004413;47957.5204247967;47958.28062579134;47960.76019620019;303428;303740;304581;305249;307264;29978.25054373658;31797.36405271928;32232.35535289234;32392.83803580967;32613.18467038343;39781.2043759129;40529.59470405258;41006;41163.38254926239;50782.74608626933;37913.4312985311;38516.42225366566;38553.61446385612;38728;39336.60663393444;33013.66986330202;33257;38425.23149536938;39364.2127157461;39396.40905386479;37386.252274954895;37689;37935;38186.42720359141;38196.236075278895;30904.845475772476;31923;34344.82827585946;34435.31129377449;34976.82511587426;26514.337141571614;26538.734612653625;26539.33651658724;26570.335741606614;26760.866195668896 09:50:12 INFO - 2015-11-19 09:50:12,574 DEBUG : BROWSER_OUTPUT: |2;jquery.html;347.82434870390466;349.4461278872987;349.7953697087204;350.2924093331471;351.3885838640765;14494.275286235672;14897.851021489809;16699;17018.14909254537;17755.73366399505;16916.154192290367;16934.915325423386;17009.659806803855;17365.826341736578;17366.47900562985;5204.635675502716;5313.0967735485065;5324.520793128618;5330.253764472957;5331.973340133313;3958.782266975315;4062.370332598437;5313.574914006889;5855.180274761537;5996.460318571328;5913.113033045056;5933.940660593382;5937.168796368512;5953.70231488426;5959.16571679963;5536.667799931997;5570.442955704418;5588.497035266805;5591.161325801122;5596.188552659842;5260.263563101169;5305.124654432014;5319.946800532022;5327.413984461706;5342.54588359986;21387;21705;21845.453863653376;21984;21997.780022199735;1959.0106995966946;2097.3498215553227;2113.0913707105938;2203.636399993999;2245.2702871566808;13265.801012984813;13540.729185416236;13549.661258468519;13667.111637743614;13737.519186828513;1812.3475548802421;1830.569816093217;1865.766779152606;1878.605492846504;1897.5351038995395;59677;61743.99999999955;61759.691201543705;62270.377296227365;62615;9628;9834.459104749307;10092.596296148073;10093.646722364681;10154.898451015542;12928.418221180069;12930.676733081747;12975.286359250333;12975.480980760853;12984.675383115498;7777.222277772291;7803.375729941591;7812.375009999187;7901.486403383877;7984.68061277554;7718.228177182349;7718.382529397635;7725.8454830903065;7777.805554861174;7787.610619469004;5892.764289428461;6027.60820546663;6030.879382412327;6039.78860739872;6042.274927008699;1621.2542230573831;1663.1019249605079;1670.0564181237562;1715.3567412220418;1767.7083281258706;383.9808009599509;385.9656121594099;400.79759721341117;407.38484887819016;992.9851052234222;10436;10539.683809485728;10725.463726813628;10800.837987430195;10864.837027444595;412.08928268526296;415.8399016378716;427.9144171165779;432.91125319309464;434.8695391382636;5758.848230353862;5836.708164591753;5972.850678733066;5979.491743201789;5986.132010858489;512721;517830;520400.5919881657;523683;542640;73198.34008299564;79564;81016.18983810204;81772.59113704393;82232.29954652055;575.5108158065694;585.6193474241777;588.3381196154412;590.3181824992141;591.6154499575224;10697;11236;11416.714582135513;11716.88283117192;11923.523059077539;37079.62920370762;37084.44373334456;37522.624773751915;38781.41827872528;39302.80348598239;45477.31784023308;46593.76703116598;48069;49478.50521494739;49607.503924960285;6870.20992585859;6967.163940327193;7026.086608740831;7033.402160816388;7041.823954401181;12562.937185314015;12743.171693839871;12791;12947.741045179233;13159.078864479394;11219.831702524305;11310.886891131313;11333.489992950503;11437.656870293904;11525.538978441104;10643.627473038407;11125.888741112485;11127.443627818739;11132.833007504732;11256.549738010388;11288.379139147097;11324.547018119183;11497.82753258685;11585.710357241136;11631.88368116342;6895.207051188977;6941.0629565010095;6953.33943275388;6970.372666460043;6972.4073453757;11049;11228.775424491629;11381.089512839118;11387.715307117389;11506.194566380607 09:50:12 INFO - 2015-11-19 09:50:12,574 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1350.1021820489375;1410.7037522120354;1454.1565891782764;1586.3416682076938;1756.0956107604577;6457.677116144192;7100.254473280303;7136.143662760476;7148.714051437936;7157.534760240581;7467.551946883177;7548.471606987499;7557.2820582044615;7575;7578.280063393969;1944.7763507196642;1976.0317444452187;1977.3968939473455;2232.854864433815;2264.4338915271182;2248.763879792623;2282.018731945263;2284.4517315844246;2285.3715228312262;2285.9657105143438;2219.1234462387347;2221.6445368741006;2270.6366981283;2271;2271.0234599122373;1930.8841469511804;1953.2870502266712;2138.347803919804;2193.407779899434;2259.53679495703;2237.686723858661;2249.966250506244;2260.9095636174534;2260.9886950565306;2261.412032871449;7516;7573.129090154647;7574.3183113520045;7575.696972121109;7575.848483030309;4538.863834084983;4580.267157254823;4591.311303304497;4600.033992861503;4619.076184763027;3079.676633953425;3148.3860647173583;3187.932042765676;3195.872165113393;3238.5789847319934;1053.7154968158554;1072.81225785488;1099.8075336816025;1104.2491106047885;1148.5004023249912;10308.278420510567;10434.478276086242;10447.582096716122;10464.895351046544;10479.84280235797;4190.979045104816;4206.642435393026;4295.140971805589;4297.205017071852;4308.375285583573;8450.154984501623;8585.098564650747;8588.484690918565;8598.914010859811;8602.268807151337;4644.907101857944;4645.86062418128;4647.395838540968;4648.86053418398;4652.139354219413;4273.7008409411665;4277.550857160016;4312.956870431255;4326.178026175016;4327.6970612057485;3318.070940136766;3365.0746044837865;3372.1738174147;3381;3404.965950340465;1014.7564584499667;1027.1012863744224;1038.8909164537765;1058.6718117383637;1061.2518174686827;1319.188698950158;1330.8070329802124;1343.0934119469514;1347.3600039980931;1359.8436179839446;6646.601203927683;6757.459403247728;7107.82230444243;7335.7432489862595;7337.74317898871;700.1772916822713;707.2043950555625;710.4813486155033;713.2546488918988;725.3725527418745;5528.198411230349;5546.057170281062;5546.528545073714;5563.916541251884;5569.387367389584;8933.508657023796;9031.096890310917;9134.040925702839;9163.49600771964;9251.629934802668;9172.495512746864;9226.86159707605;9234.445933244027;9282.72151835446;9338.95330523343;7045.8238544035785;7197.712091516385;7204.207537170907;7228.9999999998945;7237.167725711505;6931.584104953719;6933.3066693332285;6933.445324374139;6946.16646002483;6969.477289203229;8044.758657240292;8180;8203.138670439517;8215.753527394188;8321.625526851185;8224.835503289782;8388.245057944814;8399.992000959925;8499.74500764978;8515.48907065578;6447.3552644735155;6502.187226596676;6503.219613646393;6518.348165183634;6552.705128269335;7428.517146385468;7450.96274518624;7466.216047314953;7466.589337586485;7474.663640136098;6914.239433662193;7008.369246767816;7020.7542736004;7115.288471152843;7131.750388736369;6835.077264569419;6851.760188393382;6936.306369363225;6946.2011868635755;6950.79147625572;6003.669798161143;6569.967150164219;6966.9303306966285;6987.056747339044;7032.542884712478;6435.517336199898;6449.5485316027425;6478.838029049123;6479.157709497735;6493.935060649333;6479.157709497924;6507.316731743288;6514.771982980573;6530.314316996647;6548 09:50:12 INFO - 2015-11-19 09:50:12,575 DEBUG : BROWSER_OUTPUT: |4;prototype.html;313.7568384502012;316.5963396669246;318.1886190214953;323.4533638151524;328.453125545966;5887.23465949427;5958.8808223835495;5985.610935289209;5999.880002399949;6008.339082700911;5784.3058832940005;5911.113333000052;5932.644041357522;5937.168796368512;5949.7025148742605;4591.563801438858;4593.862184134465;4596.172688915994;4599.425071866017;4601.964557974463;4344.304911214206;4425.66807489438;4484.573965473275;4583.03756211196;4590.449146102473;4541.636669066484;4569.109023740372;4571.9314210286875;4573.748443835604;4583;4563.338315944186;4578.908421831561;4579.793909274091;4586.885327866797;4592.563706447882;4022.2357752027315;4023.155137421145;4024.577419370953;4030.496187976503;4030.8992275193064;5559.9444005559835;5649.689267090308;5676.2620859288445;5705.286839145107;5713.942860571383;5249.685018898878;5262.605304602132;5265.7893684252585;5272.920906186372;5274.55166310864;6037.698115094272;6334.334894836022;6339.873202535923;6340.682965851689;6344;4137.482814648169;4286.978565107154;4376.015396535754;4377.474703035656;4382.276924307485;6531.836704082389;6532.150820393318;6582.144321238208;6589.538732288742;6617.404433600999;4450;4454.799534020977;4454.955450445519;4457.286834106528;4457.68796184264;4422.20400327944;4505.391772110788;4509.774511274423;4513.50351461339;4528.366028755977;5232.058229518647;5245.895082098336;5246.580273578104;5248.107821670325;5252.868678282997;6332.588381755171;6377.426031657174;6377.74489020434;6379.521535884827;6387.968060159669;1574.5827355750735;1600.6718622682322;1603.4147536149221;1603.5109291666154;1604.3181647799638;1001.6944831826218;1023.5803320638652;1033.3128469567653;1045.0855501436242;1046.49768111307;6177.166082578884;6187.659678717714;6189.84525386869;6190.442860142519;6191.845203869849;6534.771283005072;6534.934650653433;6544.70548825304;6552.9344706553275;6575.473962083021;6046;6183.628982261079;6186;6187.84530386744;6190.102435146879;3522.894313170609;3544.858205671796;3548.946765798515;3552.982235088808;3554.662307080823;6796.35434633709;6797.5581587196675;6800.52396332252;6804.319568043156;6813.965930170417;6565.048068030204;6689.163854518185;6693.423032132567;6697.966510167418;6701.798946031627;6769;6781.559198652072;6785.1518560179975;6795.082663840417;6803.115594972721;6346.714397852015;6493.935060649333;6496.9025464617125;6497.350264973465;6502.804915852532;6337.936620633919;6490.058941453557;6498.740050397932;6519.185101862267;6522.15212022434;6849;6850.246472888078;6859.759908403182;6868.347506986828;6876.037354770237;4413.271810151289;4508.774561271989;4513;4515.729056256635;4519.141363140992;6521.6087034776165;6545.21457425112;6580.7038683260325;6589.868202636017;6594.538382313192;6406.903896441464;6411.903821442776;6415.711292991733;6416.294207637063;6427.55007149495;6257.4681152102585;6397.568923808923;6408.551401401857;6411.358864113551;6419.679016049272;6286.65423401699;6287.622742635456;6291.528135389955;6295.276043255084;6298.338674439301;6441.227052753512;6445.516586255956;6445.903311450238;6449.806505804833;6450.870982580416;6178.62928224308;6267.717952692231;6300.810975670737;6301.275353334242;6304.148939893055 09:50:12 INFO - 2015-11-19 09:50:12,575 DEBUG : BROWSER_OUTPUT: |5;yui.html;759.5974133709134;779.9025121859768;857.1813917708589;862.5687156421789;863.4258218284841;14235.43058277669;14371.993960422775;14399.64000899978;14443.711125777478;14448.638784030405;13678.863211367883;13782;13797;13808.930955345235;13810.447582096704;693.9791806245821;702.3222590200455;828.5898480252268;833.8457385383723;851.9574021298941;820.7209548753423;833.4374297349295;833.5998720614109;836.8786525953733;837.7235512280932;875.9737207883742;877.1579283887476;877.5831480046991;878.1043335797483;879.5470332778624;724.8948902409147;732.4140687450046;873.6854732296337;879.564615515324;886.3175354976632;648.8215740671305;652.0154566604414;652.4030512081487;652.517137318381;653.0074287083606;12401.25592464455;12826.358682065953;12841;12842.229466232056;12866.742665146645;10491.055804977588;12385.62843114708;12792.424340904681;12871.163374380636;13145.802812957718;10064.245181611408;10069.496525173785;10266.281360304782;10276.486175691185;10343.79312413755;3101.1936896407096;3154.57413249213;3169.4770362890094;3240.481522956339;3243.61076670801;44518.777406113084;44929.55070449286;44938.32592511115;45546.544534554894;46346.53653463456;10609.89390106089;10624.618799556009;10629.893701063045;11063.22557420989;11474.54101835934;19958.50103747389;19967.500812479804;20028.399148025583;20039.398818035483;20064.69902951457;7739.380849532136;7931.365490760725;7949.841003179904;7975.1626079262005;7983.321417679446;4245.5542168072525;4280.807363668642;4342.261815491374;4417.558244175557;4489.663275254369;3203.8077715337154;3229.3218424130728;3230.466972949484;3231.74146068314;3233.725133363643;476.754471447205;479.46060681733053;482.2693619166965;483.5164835164835;490.7938665760389;598.1954271504819;629.5372900917822;657.8223879552494;661.8874791285493;669.2332242878707;8078.474899131537;8124.512529248264;8465.619047142893;8666.306695464347;8957.328200384996;455.8040042781569;522.950319719626;540.8566729816602;556.5686592890461;564.1453198404421;3821.2551699334253;3869.342211823997;3899.4735710678697;3917.353636649978;3965.1871366369824;58138.418615814146;59181;59278.70360648255;59563.40436595665;59598.40401596015;53392;53549.46450535523;54256.72871635616;54366.18450723242;54387;47207.76396118066;48348.27477587769;48393.75803120962;48796.75601621969;48818;7430.814229644302;7670.693172273047;7710.691572337044;7957.681692732226;8096.959515202387;34457.13857153491;34463.483047753805;35960.28079438449;36992.81503592465;38015;47696.284555731;48088;49914.50085499098;50373.49626503688;51015.89841015869;10505.68482945513;10626.787464250827;10840.783184336111;11025.889741102486;11288.604898828502;11511.654650360502;11529.135314851252;11749.060075194135;12106;12123.939380303042;10662.8933710665;10685.198610104118;11041.834372484258;11366.545338186379;11503.94248028788;10705.518251678537;10810.67567972962;11003.22977391575;11039.061679757311;11043.226974111734;9653.924406252689;10344.844827327746;10369.222308327056;10377.84433233487;10380.532876020749;9473.52632368365;9605.231581473605;9677.177439917687;9811.656592019244;10059.39643621385;8603.78187117276;8663.176998185163;8740.21338079576;9090.13643703847;9160.816783664422 09:50:12 INFO - 2015-11-19 09:50:12,575 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:50:12 INFO - 2015-11-19 09:50:12,575 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:50:12 INFO - 2015-11-19 09:50:12,575 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,910 09:50:12 INFO - 2015-11-19 09:50:12,575 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:50:12 INFO - 2015-11-19 09:50:12,575 DEBUG : BROWSER_OUTPUT: __startTimestamp1447955412564__endTimestamp 09:50:12 INFO - 2015-11-19 09:50:12,576 DEBUG : BROWSER_OUTPUT: 09:50:12 INFO - 2015-11-19 09:50:12,576 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:50:12 INFO - 2015-11-19 09:50:12,576 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:50:12 INFO - 2015-11-19 09:50:12,576 DEBUG : BROWSER_OUTPUT: 09:50:12 INFO - 2015-11-19 09:50:12,576 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5359.34 Median:5519.89 stddev:579.19 (10.5%) stddev-sans-first:554.33 09:50:12 INFO - 2015-11-19 09:50:12,577 DEBUG : BROWSER_OUTPUT: Values: 3146.3 3218.9 3258.8 3273.2 3284.8 5099.4 5225.2 5351.8 5433.3 5486.1 5297.1 5340.0 5340.2 5363.5 5486.9 4914.8 4929.3 4946.3 4976.2 4980.7 4729.7 4975.9 5001.6 5042.4 5072.7 4840.8 4909.1 4955.5 4958.0 4960.5 4962.1 4980.5 4995.2 5005.9 5034.1 4709.2 4806.6 4954.7 4959.2 4994.7 5206.0 5247.7 5254.4 5276.8 5279.2 5768.4 5770.5 5774.1 5782.5 5809.8 5571.9 5700.2 5751.9 5770.6 5770.9 5400.2 5410.3 5413.9 5414.5 5422.0 5864.3 5872.1 5878.7 5881.6 5885.8 5512.8 5595.5 5598.0 5623.5 5674.7 5782.5 5805.4 5816.2 5816.6 5820.5 5711.5 5766.9 5770.9 5777.2 5784.5 5569.4 5693.7 5769.9 5776.6 5786.1 4421.7 4439.5 4441.1 4442.7 4503.3 3991.7 3996.8 4002.1 4036.2 4042.3 5230.5 5503.9 5518.6 5519.9 5522.7 5749.7 5772.6 5801.2 5893.0 5927.3 5501.5 5510.6 5517.9 5519.5 5519.8 4863.7 5042.9 5074.7 5076.9 5122.4 5809.2 5899.1 5900.3 5926.7 5987.0 5733.5 5738.7 5755.5 5789.5 5810.8 5875.1 5912.3 5917.6 5923.6 5925.2 5497.3 5658.7 5672.5 5673.5 5693.9 5689.1 5751.8 5814.4 5832.7 5909.4 5642.0 5645.2 5646.8 5648.3 5651.3 5333.8 5509.6 5646.5 5648.4 5652.2 5424.7 5483.9 5493.7 5532.1 5593.4 5690.7 5698.7 5738.1 5738.6 5772.7 5407.3 5437.6 5601.7 5604.9 5613.6 09:50:12 INFO - 2015-11-19 09:50:12,577 DEBUG : BROWSER_OUTPUT: 09:50:12 INFO - 2015-11-19 09:50:12,577 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48261.41 Median:328719.50 stddev:80131.62 (24.4%) stddev-sans-first:80276.43 09:50:12 INFO - 2015-11-19 09:50:12,577 DEBUG : BROWSER_OUTPUT: Values: 577.9 579.7 582.2 586.0 609.0 31494.7 32547.2 40412.4 41419.0 41431.0 43368.6 44023.1 44027.6 44056.8 44080.9 7397.3 8633.2 8804.1 8816.5 8821.2 7563.8 7615.1 7661.2 7664.0 10476.1 10399.8 10406.7 10448.4 10505.8 10506.1 10466.9 10556.3 10562.1 10586.2 10588.8 7669.1 7833.2 7838.5 10487.6 10765.5 41128.6 41601.2 41670.8 41676.0 41689.4 3280.6 3281.2 3518.3 3617.4 3952.3 31030.8 31487.4 31815.0 32098.5 32789.2 3599.2 3640.5 3662.2 3678.5 3797.3 284648.0 285578.0 287118.0 287345.0 287793.0 54712.0 55817.4 61540.7 61734.7 61881.4 68561.0 69389.3 69541.3 69651.7 69674.0 15510.3 15581.8 15613.1 15676.4 15724.5 11754.5 11756.7 11776.2 11777.6 11804.6 20168.9 20590.6 21037.8 21136.5 21206.8 8075.2 8455.5 8490.2 8505.8 8510.5 842.2 1004.3 1029.7 1055.4 1127.3 28468.7 28890.1 29037.7 29068.6 29247.0 1022.2 1023.4 1119.5 1122.1 1134.9 14849.9 14874.1 14949.5 15097.3 15124.9 322898.0 325228.0 328499.0 328940.0 329482.0 53263.0 53828.5 53946.7 54005.7 54090.5 1321.3 1342.6 1343.3 1346.4 1353.4 27506.9 28132.6 28159.9 28420.4 28520.9 47543.0 47948.4 47957.5 47958.3 47960.8 303428.0 303740.0 304581.0 305249.0 307264.0 29978.3 31797.4 32232.4 32392.8 32613.2 39781.2 40529.6 41006.0 41163.4 50782.7 37913.4 38516.4 38553.6 38728.0 39336.6 33013.7 33257.0 38425.2 39364.2 39396.4 37386.3 37689.0 37935.0 38186.4 38196.2 30904.8 31923.0 34344.8 34435.3 34976.8 26514.3 26538.7 26539.3 26570.3 26760.9 09:50:12 INFO - 2015-11-19 09:50:12,577 DEBUG : BROWSER_OUTPUT: 09:50:12 INFO - 2015-11-19 09:50:12,577 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27728.89 Median:2179.79 stddev:85735.78 (3933.2%) stddev-sans-first:85951.64 09:50:12 INFO - 2015-11-19 09:50:12,578 DEBUG : BROWSER_OUTPUT: Values: 347.8 349.4 349.8 350.3 351.4 14494.3 14897.9 16699.0 17018.1 17755.7 16916.2 16934.9 17009.7 17365.8 17366.5 5204.6 5313.1 5324.5 5330.3 5332.0 3958.8 4062.4 5313.6 5855.2 5996.5 5913.1 5933.9 5937.2 5953.7 5959.2 5536.7 5570.4 5588.5 5591.2 5596.2 5260.3 5305.1 5319.9 5327.4 5342.5 21387.0 21705.0 21845.5 21984.0 21997.8 1959.0 2097.3 2113.1 2203.6 2245.3 13265.8 13540.7 13549.7 13667.1 13737.5 1812.3 1830.6 1865.8 1878.6 1897.5 59677.0 61744.0 61759.7 62270.4 62615.0 9628.0 9834.5 10092.6 10093.6 10154.9 12928.4 12930.7 12975.3 12975.5 12984.7 7777.2 7803.4 7812.4 7901.5 7984.7 7718.2 7718.4 7725.8 7777.8 7787.6 5892.8 6027.6 6030.9 6039.8 6042.3 1621.3 1663.1 1670.1 1715.4 1767.7 384.0 386.0 400.8 407.4 993.0 10436.0 10539.7 10725.5 10800.8 10864.8 412.1 415.8 427.9 432.9 434.9 5758.8 5836.7 5972.9 5979.5 5986.1 512721.0 517830.0 520400.6 523683.0 542640.0 73198.3 79564.0 81016.2 81772.6 82232.3 575.5 585.6 588.3 590.3 591.6 10697.0 11236.0 11416.7 11716.9 11923.5 37079.6 37084.4 37522.6 38781.4 39302.8 45477.3 46593.8 48069.0 49478.5 49607.5 6870.2 6967.2 7026.1 7033.4 7041.8 12562.9 12743.2 12791.0 12947.7 13159.1 11219.8 11310.9 11333.5 11437.7 11525.5 10643.6 11125.9 11127.4 11132.8 11256.5 11288.4 11324.5 11497.8 11585.7 11631.9 6895.2 6941.1 6953.3 6970.4 6972.4 11049.0 11228.8 11381.1 11387.7 11506.2 09:50:12 INFO - 2015-11-19 09:50:12,578 DEBUG : BROWSER_OUTPUT: 09:50:12 INFO - 2015-11-19 09:50:12,578 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5315.46 Median:6479.00 stddev:2750.93 (42.5%) stddev-sans-first:2742.50 09:50:12 INFO - 2015-11-19 09:50:12,579 DEBUG : BROWSER_OUTPUT: Values: 1350.1 1410.7 1454.2 1586.3 1756.1 6457.7 7100.3 7136.1 7148.7 7157.5 7467.6 7548.5 7557.3 7575.0 7578.3 1944.8 1976.0 1977.4 2232.9 2264.4 2248.8 2282.0 2284.5 2285.4 2286.0 2219.1 2221.6 2270.6 2271.0 2271.0 1930.9 1953.3 2138.3 2193.4 2259.5 2237.7 2250.0 2260.9 2261.0 2261.4 7516.0 7573.1 7574.3 7575.7 7575.8 4538.9 4580.3 4591.3 4600.0 4619.1 3079.7 3148.4 3187.9 3195.9 3238.6 1053.7 1072.8 1099.8 1104.2 1148.5 10308.3 10434.5 10447.6 10464.9 10479.8 4191.0 4206.6 4295.1 4297.2 4308.4 8450.2 8585.1 8588.5 8598.9 8602.3 4644.9 4645.9 4647.4 4648.9 4652.1 4273.7 4277.6 4313.0 4326.2 4327.7 3318.1 3365.1 3372.2 3381.0 3405.0 1014.8 1027.1 1038.9 1058.7 1061.3 1319.2 1330.8 1343.1 1347.4 1359.8 6646.6 6757.5 7107.8 7335.7 7337.7 700.2 707.2 710.5 713.3 725.4 5528.2 5546.1 5546.5 5563.9 5569.4 8933.5 9031.1 9134.0 9163.5 9251.6 9172.5 9226.9 9234.4 9282.7 9339.0 7045.8 7197.7 7204.2 7229.0 7237.2 6931.6 6933.3 6933.4 6946.2 6969.5 8044.8 8180.0 8203.1 8215.8 8321.6 8224.8 8388.2 8400.0 8499.7 8515.5 6447.4 6502.2 6503.2 6518.3 6552.7 7428.5 7451.0 7466.2 7466.6 7474.7 6914.2 7008.4 7020.8 7115.3 7131.8 6835.1 6851.8 6936.3 6946.2 6950.8 6003.7 6570.0 6966.9 6987.1 7032.5 6435.5 6449.5 6478.8 6479.2 6493.9 6479.2 6507.3 6514.8 6530.3 6548.0 09:50:12 INFO - 2015-11-19 09:50:12,579 DEBUG : BROWSER_OUTPUT: 09:50:12 INFO - 2015-11-19 09:50:12,579 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5308.18 Median:6041.85 stddev:1613.76 (26.7%) stddev-sans-first:1574.15 09:50:12 INFO - 2015-11-19 09:50:12,580 DEBUG : BROWSER_OUTPUT: Values: 313.8 316.6 318.2 323.5 328.5 5887.2 5958.9 5985.6 5999.9 6008.3 5784.3 5911.1 5932.6 5937.2 5949.7 4591.6 4593.9 4596.2 4599.4 4602.0 4344.3 4425.7 4484.6 4583.0 4590.4 4541.6 4569.1 4571.9 4573.7 4583.0 4563.3 4578.9 4579.8 4586.9 4592.6 4022.2 4023.2 4024.6 4030.5 4030.9 5559.9 5649.7 5676.3 5705.3 5713.9 5249.7 5262.6 5265.8 5272.9 5274.6 6037.7 6334.3 6339.9 6340.7 6344.0 4137.5 4287.0 4376.0 4377.5 4382.3 6531.8 6532.2 6582.1 6589.5 6617.4 4450.0 4454.8 4455.0 4457.3 4457.7 4422.2 4505.4 4509.8 4513.5 4528.4 5232.1 5245.9 5246.6 5248.1 5252.9 6332.6 6377.4 6377.7 6379.5 6388.0 1574.6 1600.7 1603.4 1603.5 1604.3 1001.7 1023.6 1033.3 1045.1 1046.5 6177.2 6187.7 6189.8 6190.4 6191.8 6534.8 6534.9 6544.7 6552.9 6575.5 6046.0 6183.6 6186.0 6187.8 6190.1 3522.9 3544.9 3548.9 3553.0 3554.7 6796.4 6797.6 6800.5 6804.3 6814.0 6565.0 6689.2 6693.4 6698.0 6701.8 6769.0 6781.6 6785.2 6795.1 6803.1 6346.7 6493.9 6496.9 6497.4 6502.8 6337.9 6490.1 6498.7 6519.2 6522.2 6849.0 6850.2 6859.8 6868.3 6876.0 4413.3 4508.8 4513.0 4515.7 4519.1 6521.6 6545.2 6580.7 6589.9 6594.5 6406.9 6411.9 6415.7 6416.3 6427.6 6257.5 6397.6 6408.6 6411.4 6419.7 6286.7 6287.6 6291.5 6295.3 6298.3 6441.2 6445.5 6445.9 6449.8 6450.9 6178.6 6267.7 6300.8 6301.3 6304.1 09:50:12 INFO - 2015-11-19 09:50:12,580 DEBUG : BROWSER_OUTPUT: 09:50:12 INFO - 2015-11-19 09:50:12,580 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14031.50 Median:46777.15 stddev:16558.75 (35.4%) stddev-sans-first:16575.21 09:50:12 INFO - 2015-11-19 09:50:12,581 DEBUG : BROWSER_OUTPUT: Values: 759.6 779.9 857.2 862.6 863.4 14235.4 14372.0 14399.6 14443.7 14448.6 13678.9 13782.0 13797.0 13808.9 13810.4 694.0 702.3 828.6 833.8 852.0 820.7 833.4 833.6 836.9 837.7 876.0 877.2 877.6 878.1 879.5 724.9 732.4 873.7 879.6 886.3 648.8 652.0 652.4 652.5 653.0 12401.3 12826.4 12841.0 12842.2 12866.7 10491.1 12385.6 12792.4 12871.2 13145.8 10064.2 10069.5 10266.3 10276.5 10343.8 3101.2 3154.6 3169.5 3240.5 3243.6 44518.8 44929.6 44938.3 45546.5 46346.5 10609.9 10624.6 10629.9 11063.2 11474.5 19958.5 19967.5 20028.4 20039.4 20064.7 7739.4 7931.4 7949.8 7975.2 7983.3 4245.6 4280.8 4342.3 4417.6 4489.7 3203.8 3229.3 3230.5 3231.7 3233.7 476.8 479.5 482.3 483.5 490.8 598.2 629.5 657.8 661.9 669.2 8078.5 8124.5 8465.6 8666.3 8957.3 455.8 523.0 540.9 556.6 564.1 3821.3 3869.3 3899.5 3917.4 3965.2 58138.4 59181.0 59278.7 59563.4 59598.4 53392.0 53549.5 54256.7 54366.2 54387.0 47207.8 48348.3 48393.8 48796.8 48818.0 7430.8 7670.7 7710.7 7957.7 8097.0 34457.1 34463.5 35960.3 36992.8 38015.0 47696.3 48088.0 49914.5 50373.5 51015.9 10505.7 10626.8 10840.8 11025.9 11288.6 11511.7 11529.1 11749.1 12106.0 12123.9 10662.9 10685.2 11041.8 11366.5 11503.9 10705.5 10810.7 11003.2 11039.1 11043.2 9653.9 10344.8 10369.2 10377.8 10380.5 9473.5 9605.2 9677.2 9811.7 10059.4 8603.8 8663.2 8740.2 9090.1 9160.8 09:50:12 INFO - 2015-11-19 09:50:12,581 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:50:12 INFO - 2015-11-19 09:50:12,581 DEBUG : BROWSER_OUTPUT: 09:50:13 INFO - 2015-11-19 09:50:13,325 INFO : Browser exited with error code: 0 09:50:13 INFO - 2015-11-19 09:50:13,346 INFO : Completed test dromaeo_css (00:18:36) 09:50:13 INFO - 2015-11-19 09:50:13,346 INFO : Starting test kraken 09:50:13 INFO - 2015-11-19 09:50:13,347 DEBUG : operating with platform_type : linux_ 09:50:13 INFO - 2015-11-19 09:50:13,347 INFO : Initialising browser for kraken test... 09:50:13 INFO - 2015-11-19 09:50:13,353 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJSC741/profile http://localhost:51679/getInfo.html 09:50:18 INFO - 2015-11-19 09:50:18,000 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:50:18 INFO - 2015-11-19 09:50:18,000 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:50:18 INFO - 2015-11-19 09:50:18,000 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:50:18 INFO - 2015-11-19 09:50:18,000 DEBUG : BROWSER_OUTPUT: __metrics 09:50:18 INFO - 2015-11-19 09:50:18,169 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:50:19 INFO - 2015-11-19 09:50:19,722 INFO : Browser initialized. 09:50:19 INFO - 2015-11-19 09:50:19,723 INFO : Running cycle 1/1 for kraken test... 09:50:19 INFO - 2015-11-19 09:50:19,723 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJSC741/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:50:31 INFO - 2015-11-19 09:50:31,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 141991936 09:50:31 INFO - 2015-11-19 09:50:31,481 DEBUG : BROWSER_OUTPUT: 09:50:33 INFO - 2015-11-19 09:50:33,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51679/tests/kraken/driver.html?testName=audio-beat-detection) 09:50:34 INFO - 2015-11-19 09:50:34,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 179945472 09:50:34 INFO - 2015-11-19 09:50:34,502 DEBUG : BROWSER_OUTPUT: 09:50:37 INFO - 2015-11-19 09:50:37,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51679/tests/kraken/driver.html?testName=audio-dft) 09:50:37 INFO - 2015-11-19 09:50:37,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 169074688 09:50:37 INFO - 2015-11-19 09:50:37,640 DEBUG : BROWSER_OUTPUT: 09:50:40 INFO - 2015-11-19 09:50:40,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51679/tests/kraken/driver.html?testName=audio-fft) 09:50:41 INFO - 2015-11-19 09:50:41,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 150069248 09:50:41 INFO - 2015-11-19 09:50:41,064 DEBUG : BROWSER_OUTPUT: 09:50:43 INFO - 2015-11-19 09:50:43,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51679/tests/kraken/driver.html?testName=audio-oscillator) 09:50:43 INFO - 2015-11-19 09:50:43,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 154435584 09:50:43 INFO - 2015-11-19 09:50:43,597 DEBUG : BROWSER_OUTPUT: 09:50:45 INFO - 2015-11-19 09:50:45,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51679/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:50:46 INFO - 2015-11-19 09:50:46,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 155373568 09:50:46 INFO - 2015-11-19 09:50:46,318 DEBUG : BROWSER_OUTPUT: 09:50:49 INFO - 2015-11-19 09:50:49,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51679/tests/kraken/driver.html?testName=imaging-darkroom) 09:50:49 INFO - 2015-11-19 09:50:49,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 155090944 09:50:49 INFO - 2015-11-19 09:50:49,765 DEBUG : BROWSER_OUTPUT: 09:50:53 INFO - 2015-11-19 09:50:53,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51679/tests/kraken/driver.html?testName=imaging-desaturate) 09:50:53 INFO - 2015-11-19 09:50:53,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 157347840 09:50:53 INFO - 2015-11-19 09:50:53,730 DEBUG : BROWSER_OUTPUT: 09:50:56 INFO - 2015-11-19 09:50:56,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51679/tests/kraken/driver.html?testName=json-parse-financial) 09:50:57 INFO - 2015-11-19 09:50:57,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 156217344 09:50:57 INFO - 2015-11-19 09:50:57,046 DEBUG : BROWSER_OUTPUT: 09:50:58 INFO - 2015-11-19 09:50:58,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51679/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:50:59 INFO - 2015-11-19 09:50:59,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 165662720 09:50:59 INFO - 2015-11-19 09:50:59,176 DEBUG : BROWSER_OUTPUT: 09:51:00 INFO - 2015-11-19 09:51:00,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:51:01 INFO - 2015-11-19 09:51:01,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 164888576 09:51:01 INFO - 2015-11-19 09:51:01,587 DEBUG : BROWSER_OUTPUT: 09:51:03 INFO - 2015-11-19 09:51:03,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:51:04 INFO - 2015-11-19 09:51:04,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 169017344 09:51:04 INFO - 2015-11-19 09:51:04,240 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-19 09:51:06,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:51:07 INFO - 2015-11-19 09:51:07,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 177811456 09:51:07 INFO - 2015-11-19 09:51:07,187 DEBUG : BROWSER_OUTPUT: 09:51:09 INFO - 2015-11-19 09:51:09,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:51:10 INFO - 2015-11-19 09:51:10,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 177623040 09:51:10 INFO - 2015-11-19 09:51:10,318 DEBUG : BROWSER_OUTPUT: 09:51:11 INFO - 2015-11-19 09:51:11,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51679/tests/kraken/driver.html?testName=ai-astar) 09:51:12 INFO - 2015-11-19 09:51:12,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 235892736 09:51:12 INFO - 2015-11-19 09:51:12,225 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,225 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:51:12 INFO - 2015-11-19 09:51:12,225 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:51:12 INFO - 2015-11-19 09:51:12,225 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:51:12 INFO - 2015-11-19 09:51:12,225 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:51:12 INFO - 2015-11-19 09:51:12,225 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;104;109;110;111;99;109;108;109 09:51:12 INFO - 2015-11-19 09:51:12,225 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;123;155;162;125;146;146;125;160;124 09:51:12 INFO - 2015-11-19 09:51:12,225 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;160;161;160;159;159;163;168;161 09:51:12 INFO - 2015-11-19 09:51:12,226 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;86;90;72;72;79;96;90;72 09:51:12 INFO - 2015-11-19 09:51:12,226 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;89;137;90;90;90;138;89;89;139 09:51:12 INFO - 2015-11-19 09:51:12,226 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;109;109;110;109 09:51:12 INFO - 2015-11-19 09:51:12,226 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;144;145;145;145;145;145;145;145;145 09:51:12 INFO - 2015-11-19 09:51:12,226 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;96;101;96;96;95 09:51:12 INFO - 2015-11-19 09:51:12,226 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;58;61;59;61;58;67;56;57 09:51:12 INFO - 2015-11-19 09:51:12,226 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;67;68;69;68;68;68;69 09:51:12 INFO - 2015-11-19 09:51:12,226 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;85;86;87;85;84;85;86;92 09:51:12 INFO - 2015-11-19 09:51:12,226 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;131;115;117;122;117;121;114;114;116 09:51:12 INFO - 2015-11-19 09:51:12,227 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;150;149;148;150;139;149;150;151;147 09:51:12 INFO - 2015-11-19 09:51:12,227 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;64;67;65;66;65;65;65;65 09:51:12 INFO - 2015-11-19 09:51:12,227 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:51:12 INFO - 2015-11-19 09:51:12,227 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:51:12 INFO - 2015-11-19 09:51:12,227 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,933 09:51:12 INFO - 2015-11-19 09:51:12,227 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:51:12 INFO - 2015-11-19 09:51:12,227 DEBUG : BROWSER_OUTPUT: __startTimestamp1447955472219__endTimestamp 09:51:12 INFO - 2015-11-19 09:51:12,227 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,228 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:51:12 INFO - 2015-11-19 09:51:12,228 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:51:12 INFO - 2015-11-19 09:51:12,228 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,228 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:3.53 (3.2%) stddev-sans-first:3.75 09:51:12 INFO - 2015-11-19 09:51:12,228 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 104.0 109.0 110.0 111.0 99.0 109.0 108.0 109.0 09:51:12 INFO - 2015-11-19 09:51:12,228 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,228 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.40 Median:147.00 stddev:15.71 (10.7%) stddev-sans-first:16.48 09:51:12 INFO - 2015-11-19 09:51:12,228 DEBUG : BROWSER_OUTPUT: Values: 148.0 123.0 155.0 162.0 125.0 146.0 146.0 125.0 160.0 124.0 09:51:12 INFO - 2015-11-19 09:51:12,229 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,230 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:2.63 (1.6%) stddev-sans-first:2.79 09:51:12 INFO - 2015-11-19 09:51:12,230 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 160.0 161.0 160.0 159.0 159.0 163.0 168.0 161.0 09:51:12 INFO - 2015-11-19 09:51:12,230 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,230 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:82.50 stddev:9.50 (11.5%) stddev-sans-first:9.62 09:51:12 INFO - 2015-11-19 09:51:12,230 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 86.0 90.0 72.0 72.0 79.0 96.0 90.0 72.0 09:51:12 INFO - 2015-11-19 09:51:12,231 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,231 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.00 Median:89.00 stddev:23.47 (26.4%) stddev-sans-first:24.26 09:51:12 INFO - 2015-11-19 09:51:12,231 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 137.0 90.0 90.0 90.0 138.0 89.0 89.0 139.0 09:51:12 INFO - 2015-11-19 09:51:12,231 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,231 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:51:12 INFO - 2015-11-19 09:51:12,231 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 09:51:12 INFO - 2015-11-19 09:51:12,231 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,231 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 09:51:12 INFO - 2015-11-19 09:51:12,232 DEBUG : BROWSER_OUTPUT: Values: 145.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 09:51:12 INFO - 2015-11-19 09:51:12,232 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,232 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.70 (1.8%) stddev-sans-first:1.80 09:51:12 INFO - 2015-11-19 09:51:12,232 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 96.0 101.0 96.0 96.0 95.0 09:51:12 INFO - 2015-11-19 09:51:12,232 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,232 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.50 Median:59.00 stddev:3.06 (5.2%) stddev-sans-first:3.24 09:51:12 INFO - 2015-11-19 09:51:12,232 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 58.0 61.0 59.0 61.0 58.0 67.0 56.0 57.0 09:51:12 INFO - 2015-11-19 09:51:12,232 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,232 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 09:51:12 INFO - 2015-11-19 09:51:12,233 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 67.0 68.0 69.0 68.0 68.0 68.0 69.0 09:51:12 INFO - 2015-11-19 09:51:12,233 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,233 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.50 stddev:2.63 (3.1%) stddev-sans-first:2.45 09:51:12 INFO - 2015-11-19 09:51:12,233 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 85.0 86.0 87.0 85.0 84.0 85.0 86.0 92.0 09:51:12 INFO - 2015-11-19 09:51:12,233 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,233 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:117.50 stddev:5.15 (4.4%) stddev-sans-first:5.46 09:51:12 INFO - 2015-11-19 09:51:12,233 DEBUG : BROWSER_OUTPUT: Values: 118.0 131.0 115.0 117.0 122.0 117.0 121.0 114.0 114.0 116.0 09:51:12 INFO - 2015-11-19 09:51:12,233 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,233 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:149.50 stddev:4.09 (2.7%) stddev-sans-first:3.62 09:51:12 INFO - 2015-11-19 09:51:12,234 DEBUG : BROWSER_OUTPUT: Values: 141.0 150.0 149.0 148.0 150.0 139.0 149.0 150.0 151.0 147.0 09:51:12 INFO - 2015-11-19 09:51:12,234 DEBUG : BROWSER_OUTPUT: 09:51:12 INFO - 2015-11-19 09:51:12,234 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 09:51:12 INFO - 2015-11-19 09:51:12,234 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 64.0 67.0 65.0 66.0 65.0 65.0 65.0 65.0 09:51:12 INFO - 2015-11-19 09:51:12,234 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:51:12 INFO - 2015-11-19 09:51:12,234 DEBUG : BROWSER_OUTPUT: 09:51:13 INFO - 2015-11-19 09:51:13,366 INFO : Browser exited with error code: 0 09:51:13 INFO - 2015-11-19 09:51:13,416 INFO : Completed test kraken (00:01:00) 09:51:13 INFO - 2015-11-19 09:51:13,417 INFO : Starting test v8_7 09:51:13 INFO - 2015-11-19 09:51:13,417 DEBUG : operating with platform_type : linux_ 09:51:13 INFO - 2015-11-19 09:51:13,417 INFO : Initialising browser for v8_7 test... 09:51:13 INFO - 2015-11-19 09:51:13,423 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI7sNGs/profile http://localhost:51679/getInfo.html 09:51:17 INFO - 2015-11-19 09:51:17,744 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:51:17 INFO - 2015-11-19 09:51:17,744 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:51:17 INFO - 2015-11-19 09:51:17,744 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:51:17 INFO - 2015-11-19 09:51:17,744 DEBUG : BROWSER_OUTPUT: __metrics 09:51:17 INFO - 2015-11-19 09:51:17,901 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:51:19 INFO - 2015-11-19 09:51:19,344 INFO : Browser initialized. 09:51:19 INFO - 2015-11-19 09:51:19,344 INFO : Running cycle 1/1 for v8_7 test... 09:51:19 INFO - 2015-11-19 09:51:19,345 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI7sNGs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:51:31 INFO - 2015-11-19 09:51:31,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 142131200 09:51:31 INFO - 2015-11-19 09:51:31,120 DEBUG : BROWSER_OUTPUT: 09:51:52 INFO - 2015-11-19 09:51:52,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51679/tests/v8_7/run.html (next: http://localhost:51679/tests/v8_7/run.html) 09:51:52 INFO - 2015-11-19 09:51:52,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 616779776 09:51:52 INFO - 2015-11-19 09:51:52,786 DEBUG : BROWSER_OUTPUT: 09:51:52 INFO - 2015-11-19 09:51:52,786 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:51:52 INFO - 2015-11-19 09:51:52,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:51:52 INFO - 2015-11-19 09:51:52,787 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:51:52 INFO - 2015-11-19 09:51:52,787 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:51:52 INFO - 2015-11-19 09:51:52,787 DEBUG : BROWSER_OUTPUT: |0;Richards;162.813415825464 09:51:52 INFO - 2015-11-19 09:51:52,787 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.85580670303975 09:51:52 INFO - 2015-11-19 09:51:52,787 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.4950213371266 09:51:52 INFO - 2015-11-19 09:51:52,788 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 09:51:52 INFO - 2015-11-19 09:51:52,788 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1984.126984126984 09:51:52 INFO - 2015-11-19 09:51:52,788 DEBUG : BROWSER_OUTPUT: |5;Earley;791.1392405063291 09:51:52 INFO - 2015-11-19 09:51:52,788 DEBUG : BROWSER_OUTPUT: |6;Boyer;11764.70588235294 09:51:52 INFO - 2015-11-19 09:51:52,788 DEBUG : BROWSER_OUTPUT: |7;RegExp;26128.20512820513 09:51:52 INFO - 2015-11-19 09:51:52,788 DEBUG : BROWSER_OUTPUT: |8;Splay;640.6149903907751 09:51:52 INFO - 2015-11-19 09:51:52,789 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 09:51:52 INFO - 2015-11-19 09:51:52,789 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:51:52 INFO - 2015-11-19 09:51:52,789 DEBUG : BROWSER_OUTPUT: __startTimestamp1447955512783__endTimestamp 09:51:52 INFO - 2015-11-19 09:51:52,789 DEBUG : BROWSER_OUTPUT: 09:51:52 INFO - 2015-11-19 09:51:52,789 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:51:52 INFO - 2015-11-19 09:51:52,790 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:51:52 INFO - 2015-11-19 09:51:52,790 DEBUG : BROWSER_OUTPUT: 09:51:52 INFO - 2015-11-19 09:51:52,790 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.81 Median:162.81 stddev:0.00 (0.0%) 09:51:52 INFO - 2015-11-19 09:51:52,790 DEBUG : BROWSER_OUTPUT: Values: 162.8 09:51:52 INFO - 2015-11-19 09:51:52,790 DEBUG : BROWSER_OUTPUT: 09:51:52 INFO - 2015-11-19 09:51:52,790 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.86 Median:194.86 stddev:0.00 (0.0%) 09:51:52 INFO - 2015-11-19 09:51:52,791 DEBUG : BROWSER_OUTPUT: Values: 194.9 09:51:52 INFO - 2015-11-19 09:51:52,791 DEBUG : BROWSER_OUTPUT: 09:51:52 INFO - 2015-11-19 09:51:52,791 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.50 Median:284.50 stddev:0.00 (0.0%) 09:51:52 INFO - 2015-11-19 09:51:52,791 DEBUG : BROWSER_OUTPUT: Values: 284.5 09:51:52 INFO - 2015-11-19 09:51:52,791 DEBUG : BROWSER_OUTPUT: 09:51:52 INFO - 2015-11-19 09:51:52,791 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 09:51:52 INFO - 2015-11-19 09:51:52,792 DEBUG : BROWSER_OUTPUT: Values: 5030.2 09:51:52 INFO - 2015-11-19 09:51:52,792 DEBUG : BROWSER_OUTPUT: 09:51:52 INFO - 2015-11-19 09:51:52,792 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 09:51:52 INFO - 2015-11-19 09:51:52,792 DEBUG : BROWSER_OUTPUT: Values: 1984.1 09:51:52 INFO - 2015-11-19 09:51:52,792 DEBUG : BROWSER_OUTPUT: 09:51:52 INFO - 2015-11-19 09:51:52,792 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 09:51:52 INFO - 2015-11-19 09:51:52,793 DEBUG : BROWSER_OUTPUT: Values: 791.1 09:51:52 INFO - 2015-11-19 09:51:52,793 DEBUG : BROWSER_OUTPUT: 09:51:52 INFO - 2015-11-19 09:51:52,793 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11764.71 Median:11764.71 stddev:0.00 (0.0%) 09:51:52 INFO - 2015-11-19 09:51:52,793 DEBUG : BROWSER_OUTPUT: Values: 11764.7 09:51:52 INFO - 2015-11-19 09:51:52,793 DEBUG : BROWSER_OUTPUT: 09:51:52 INFO - 2015-11-19 09:51:52,793 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26128.21 Median:26128.21 stddev:0.00 (0.0%) 09:51:52 INFO - 2015-11-19 09:51:52,793 DEBUG : BROWSER_OUTPUT: Values: 26128.2 09:51:52 INFO - 2015-11-19 09:51:52,794 DEBUG : BROWSER_OUTPUT: 09:51:52 INFO - 2015-11-19 09:51:52,794 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:640.61 Median:640.61 stddev:0.00 (0.0%) 09:51:52 INFO - 2015-11-19 09:51:52,794 DEBUG : BROWSER_OUTPUT: Values: 640.6 09:51:52 INFO - 2015-11-19 09:51:52,794 DEBUG : BROWSER_OUTPUT: 09:51:52 INFO - 2015-11-19 09:51:52,794 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 09:51:52 INFO - 2015-11-19 09:51:52,794 DEBUG : BROWSER_OUTPUT: Values: 4845.4 09:51:52 INFO - 2015-11-19 09:51:52,794 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:51:52 INFO - 2015-11-19 09:51:52,794 DEBUG : BROWSER_OUTPUT: 09:51:53 INFO - 2015-11-19 09:51:53,661 INFO : Browser exited with error code: 0 09:51:53 INFO - 2015-11-19 09:51:53,676 INFO : Completed test v8_7 (00:00:40) 09:51:53 INFO - 2015-11-19 09:51:53,803 INFO : Completed test suite (00:20:16) 09:51:53 INFO - 2015-11-19 09:51:53,803 DEBUG : Working with test: dromaeo_css 09:51:53 INFO - 2015-11-19 09:51:53,803 DEBUG : Generating results file: dromaeo_css 09:51:53 INFO - 2015-11-19 09:51:53,804 DEBUG : Working with test: kraken 09:51:53 INFO - 2015-11-19 09:51:53,804 DEBUG : Generating results file: kraken 09:51:53 INFO - 2015-11-19 09:51:53,805 INFO : javascript benchmark 09:51:53 INFO - 2015-11-19 09:51:53,805 DEBUG : Working with test: v8_7 09:51:53 INFO - 2015-11-19 09:51:53,805 DEBUG : Generating results file: v8_7 09:51:53 INFO - 2015-11-19 09:51:53,805 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:53 INFO - 2015-11-19 09:51:53,871 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 09:51:53 INFO - 2015-11-19 09:51:53,871 DEBUG : process_Request line: dromaeo_css 6854.65 graph.html#tests=[[72,1,35]] 09:51:53 INFO - 2015-11-19 09:51:53,871 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:53 INFO - 2015-11-19 09:51:53,914 DEBUG : process_Request line: kraken 1489.40 graph.html#tests=[[232,1,35]] 09:51:53 INFO - 2015-11-19 09:51:53,914 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:53 INFO - 2015-11-19 09:51:53,951 DEBUG : process_Request line: v8_7 19774.91 graph.html#tests=[[230,1,35]] 09:51:53 INFO - 2015-11-19 09:51:53,953 INFO : javascript benchmark 09:51:54 INFO - 2015-11-19 09:51:53,956 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3146.323540438806, 3218.9195270118257, 3258.820764857932, 3273.2307907641716, 3284.8357582120902, 5099.413567439746, 5225.163973764198, 5351.785928562857, 5433.320834895638, 5486.094794358926, 5297.12597421425, 5340.0, 5340.172273297645, 5363.463653634634, 5486.890262194754, 4914.778834952427, 4929.309896614477, 4946.332245146913, 4976.178930476485, 4980.676256043345, 4729.668923175379, 4975.875603109933, 5001.649884508086, 5042.369703787027, 5072.72100034498, 4840.806367745286, 4909.091818013661, 4955.479674634147, 4958.033183529214, 4960.454350021495, 4962.131626965267, 4980.5019498049905, 4995.225740010304, 5005.89988200234, 5034.09386310464, 4709.152352576535, 4806.639502037361, 4954.653174277802, 4959.231319145538, 4994.725290109042, 5206.0, 5247.737613119367, 5254.4220135785035, 5276.815311464119, 5279.181726832308, 5768.3654797972185, 5770.538356931435, 5774.105013722879, 5782.45066718661, 5809.82570522885, 5571.916421253684, 5700.173474846166, 5751.884962300773, 5770.6249093808765, 5770.9422905770825, 5400.21696853954, 5410.323709536308, 5413.864653383657, 5414.485623865766, 5422.024035673578, 5864.296284445809, 5872.119182122716, 5878.676672783038, 5881.558883083786, 5885.764569417175, 5512.751926163332, 5595.496405323541, 5598.048331783525, 5623.465770751772, 5674.687892165971, 5782.479576838105, 5805.390434004453, 5816.214811000461, 5816.592838501264, 5820.534357251409, 5711.457411545896, 5766.884662306814, 5770.942290577124, 5777.19119323295, 5784.479396854304, 5569.443055694398, 5693.686847223443, 5769.942300577024, 5776.595638305278, 5786.074228123564, 4421.7346959181905, 4439.511653718088, 4441.0673758511075, 4442.711223770445, 4503.324501324828, 3991.7405368650943, 3996.760194388346, 4002.139539998914, 4036.1524079942956, 4042.2723909696538, 5230.450802665741, 5503.944960550423, 5518.641288316247, 5519.889602207933, 5522.66863988162, 5749.712514374264, 5772.595918285764, 5801.158831969341, 5893.0, 5927.2590926134235, 5501.504864562128, 5510.641808282448, 5517.917231241535, 5519.475649813261, 5519.751611177427, 4863.7324947128245, 5042.899142017139, 5074.720890350993, 5076.923846142311, 5122.436531981479, 5809.157672137517, 5899.115132730125, 5900.291964964146, 5926.733297001645, 5986.970065149646, 5733.455321744427, 5738.713064346849, 5755.482006619424, 5789.536837052941, 5810.767569297181, 5875.14810352488, 5912.320083190488, 5917.644941303535, 5923.614965027259, 5925.229720136354, 5497.285352904097, 5658.717064146694, 5672.546196304368, 5673.517750991212, 5693.886122277614, 5689.061304884648, 5751.769929202785, 5814.3604203538425, 5832.737526811388, 5909.438603332676, 5642.040853054908, 5645.209670646031, 5646.774129034792, 5648.322201335702, 5651.265335506522, 5333.759980800795, 5509.586780991362, 5646.463585959327, 5648.406917273627, 5652.180433837153, 5424.674519528841, 5483.862903427446, 5493.697846618475, 5532.087205611029, 5593.440655934537, 5690.658560486218, 5698.715064246854, 5738.053221218619, 5738.569607279387, 5772.711364431846, 5407.270018547603, 5437.564994800327, 5601.719914004365, 5604.85987850307, 5613.635113717595], "unit": "ms", "name": "dojo.html", "value": 5322.812882159381}, {"lowerIsBetter": false, "replicates": [577.9075347944329, 579.744912238615, 582.1616871704746, 586.0388962102151, 609.0407608017374, 31494.68505314949, 32547.186320341974, 40412.39381409278, 41419.0, 41431.0, 43368.566314336924, 44023.11953760923, 44027.559724402745, 44056.77971610145, 44080.89797755058, 7397.334239918407, 8633.223009929121, 8804.075572064938, 8816.515091669955, 8821.16198961101, 7563.848723025564, 7615.086189657249, 7661.157272699998, 7664.041994750656, 10476.1095306899, 10399.844002339933, 10406.739831504197, 10448.373097614129, 10505.789884202311, 10506.106980906632, 10466.895331046706, 10556.261061725681, 10562.102221311197, 10586.206034547362, 10588.841167382496, 7669.0797104347275, 7833.1775163608145, 7838.451308408414, 10487.632932847313, 10765.461726913623, 41128.58871411307, 41601.1679766406, 41670.79164604157, 41676.0, 41689.37465938013, 3280.6391296957318, 3281.2289112058647, 3518.309468639215, 3617.366960781879, 3952.2777653241446, 31030.844845775853, 31487.37025259482, 31815.0, 32098.518522222184, 32789.18027049319, 3599.190182208982, 3640.5449318835144, 3662.1943172502274, 3678.503402040717, 3797.2974999625158, 284648.0, 285578.0, 287117.9999999979, 287345.0, 287793.0, 54712.0, 55817.441825582035, 61540.69229653823, 61734.69132654308, 61881.38118618756, 68561.0, 69389.30610693828, 69541.30458695449, 69651.65174174096, 69674.0, 15510.30203640839, 15581.844181558266, 15613.14127722986, 15676.372945082068, 15724.528264152093, 11754.471048802825, 11756.706082347839, 11776.234544754563, 11777.587784427504, 11804.645860624196, 20168.890711010743, 20590.58818823615, 21037.78962210389, 21136.47158821011, 21206.78793212079, 8075.192480751995, 8455.534945578052, 8490.15098490146, 8505.787355316166, 8510.531920744295, 842.2377748137945, 1004.3421558878946, 1029.696239609317, 1055.4247934875511, 1127.3405058041137, 28468.71531284702, 28890.133296001153, 29037.709622903923, 29068.563971540443, 29247.0, 1022.1822541966545, 1023.3501726403787, 1119.5409881948362, 1122.1135303110614, 1134.9092072634335, 14849.92575037118, 14874.107553546823, 14949.476768313274, 15097.3206205721, 15124.924375378052, 322898.0, 325228.0, 328499.0, 328940.0, 329482.0, 53263.0, 53828.46171538234, 53946.7302663492, 54005.729971349894, 54090.45909540854, 1321.2799024531653, 1342.6039318401095, 1343.3014832287156, 1346.3672074125145, 1353.4045020191083, 27506.862465687544, 28132.57801132944, 28159.859200703864, 28420.431591367644, 28520.85739571372, 47543.04913901772, 47948.36284004413, 47957.5204247967, 47958.28062579134, 47960.76019620019, 303428.0, 303740.0, 304581.0, 305249.0, 307264.0, 29978.25054373658, 31797.36405271928, 32232.35535289234, 32392.83803580967, 32613.18467038343, 39781.2043759129, 40529.59470405258, 41006.0, 41163.38254926239, 50782.74608626933, 37913.4312985311, 38516.42225366566, 38553.61446385612, 38728.0, 39336.60663393444, 33013.66986330202, 33257.0, 38425.23149536938, 39364.2127157461, 39396.40905386479, 37386.252274954895, 37689.0, 37935.0, 38186.42720359141, 38196.236075278895, 30904.845475772476, 31923.0, 34344.82827585946, 34435.31129377449, 34976.82511587426, 26514.337141571614, 26538.734612653625, 26539.33651658724, 26570.335741606614, 26760.866195668896], "unit": "ms", "name": "ext.html", "value": 19089.429995116476}, {"lowerIsBetter": false, "replicates": [347.82434870390466, 349.4461278872987, 349.7953697087204, 350.2924093331471, 351.3885838640765, 14494.275286235672, 14897.851021489809, 16699.0, 17018.14909254537, 17755.73366399505, 16916.154192290367, 16934.915325423386, 17009.659806803855, 17365.826341736578, 17366.47900562985, 5204.635675502716, 5313.0967735485065, 5324.520793128618, 5330.253764472957, 5331.973340133313, 3958.782266975315, 4062.370332598437, 5313.574914006889, 5855.180274761537, 5996.460318571328, 5913.113033045056, 5933.940660593382, 5937.168796368512, 5953.70231488426, 5959.16571679963, 5536.667799931997, 5570.442955704418, 5588.497035266805, 5591.161325801122, 5596.188552659842, 5260.263563101169, 5305.124654432014, 5319.946800532022, 5327.413984461706, 5342.54588359986, 21387.0, 21705.0, 21845.453863653376, 21984.0, 21997.780022199735, 1959.0106995966946, 2097.3498215553227, 2113.0913707105938, 2203.636399993999, 2245.2702871566808, 13265.801012984813, 13540.729185416236, 13549.661258468519, 13667.111637743614, 13737.519186828513, 1812.3475548802421, 1830.569816093217, 1865.766779152606, 1878.605492846504, 1897.5351038995395, 59677.0, 61743.99999999955, 61759.691201543705, 62270.377296227365, 62615.0, 9628.0, 9834.459104749307, 10092.596296148073, 10093.646722364681, 10154.898451015542, 12928.418221180069, 12930.676733081747, 12975.286359250333, 12975.480980760853, 12984.675383115498, 7777.222277772291, 7803.375729941591, 7812.375009999187, 7901.486403383877, 7984.68061277554, 7718.228177182349, 7718.382529397635, 7725.8454830903065, 7777.805554861174, 7787.610619469004, 5892.764289428461, 6027.60820546663, 6030.879382412327, 6039.78860739872, 6042.274927008699, 1621.2542230573831, 1663.1019249605079, 1670.0564181237562, 1715.3567412220418, 1767.7083281258706, 383.9808009599509, 385.9656121594099, 400.79759721341117, 407.38484887819016, 992.9851052234222, 10436.0, 10539.683809485728, 10725.463726813628, 10800.837987430195, 10864.837027444595, 412.08928268526296, 415.8399016378716, 427.9144171165779, 432.91125319309464, 434.8695391382636, 5758.848230353862, 5836.708164591753, 5972.850678733066, 5979.491743201789, 5986.132010858489, 512721.0, 517830.0, 520400.5919881657, 523683.0, 542640.0, 73198.34008299564, 79564.0, 81016.18983810204, 81772.59113704393, 82232.29954652055, 575.5108158065694, 585.6193474241777, 588.3381196154412, 590.3181824992141, 591.6154499575224, 10697.0, 11236.0, 11416.714582135513, 11716.88283117192, 11923.523059077539, 37079.62920370762, 37084.44373334456, 37522.624773751915, 38781.41827872528, 39302.80348598239, 45477.31784023308, 46593.76703116598, 48069.0, 49478.50521494739, 49607.503924960285, 6870.20992585859, 6967.163940327193, 7026.086608740831, 7033.402160816388, 7041.823954401181, 12562.937185314015, 12743.171693839871, 12791.0, 12947.741045179233, 13159.078864479394, 11219.831702524305, 11310.886891131313, 11333.489992950503, 11437.656870293904, 11525.538978441104, 10643.627473038407, 11125.888741112485, 11127.443627818739, 11132.833007504732, 11256.549738010388, 11288.379139147097, 11324.547018119183, 11497.82753258685, 11585.710357241136, 11631.88368116342, 6895.207051188977, 6941.0629565010095, 6953.33943275388, 6970.372666460043, 6972.4073453757, 11049.0, 11228.775424491629, 11381.089512839118, 11387.715307117389, 11506.194566380607], "unit": "ms", "name": "jquery.html", "value": 7876.33858775296}, {"lowerIsBetter": false, "replicates": [1350.1021820489375, 1410.7037522120354, 1454.1565891782764, 1586.3416682076938, 1756.0956107604577, 6457.677116144192, 7100.254473280303, 7136.143662760476, 7148.714051437936, 7157.534760240581, 7467.551946883177, 7548.471606987499, 7557.2820582044615, 7575.0, 7578.280063393969, 1944.7763507196642, 1976.0317444452187, 1977.3968939473455, 2232.854864433815, 2264.4338915271182, 2248.763879792623, 2282.018731945263, 2284.4517315844246, 2285.3715228312262, 2285.9657105143438, 2219.1234462387347, 2221.6445368741006, 2270.6366981283, 2271.0, 2271.0234599122373, 1930.8841469511804, 1953.2870502266712, 2138.347803919804, 2193.407779899434, 2259.53679495703, 2237.686723858661, 2249.966250506244, 2260.9095636174534, 2260.9886950565306, 2261.412032871449, 7516.0, 7573.129090154647, 7574.3183113520045, 7575.696972121109, 7575.848483030309, 4538.863834084983, 4580.267157254823, 4591.311303304497, 4600.033992861503, 4619.076184763027, 3079.676633953425, 3148.3860647173583, 3187.932042765676, 3195.872165113393, 3238.5789847319934, 1053.7154968158554, 1072.81225785488, 1099.8075336816025, 1104.2491106047885, 1148.5004023249912, 10308.278420510567, 10434.478276086242, 10447.582096716122, 10464.895351046544, 10479.84280235797, 4190.979045104816, 4206.642435393026, 4295.140971805589, 4297.205017071852, 4308.375285583573, 8450.154984501623, 8585.098564650747, 8588.484690918565, 8598.914010859811, 8602.268807151337, 4644.907101857944, 4645.86062418128, 4647.395838540968, 4648.86053418398, 4652.139354219413, 4273.7008409411665, 4277.550857160016, 4312.956870431255, 4326.178026175016, 4327.6970612057485, 3318.070940136766, 3365.0746044837865, 3372.1738174147, 3381.0, 3404.965950340465, 1014.7564584499667, 1027.1012863744224, 1038.8909164537765, 1058.6718117383637, 1061.2518174686827, 1319.188698950158, 1330.8070329802124, 1343.0934119469514, 1347.3600039980931, 1359.8436179839446, 6646.601203927683, 6757.459403247728, 7107.82230444243, 7335.7432489862595, 7337.74317898871, 700.1772916822713, 707.2043950555625, 710.4813486155033, 713.2546488918988, 725.3725527418745, 5528.198411230349, 5546.057170281062, 5546.528545073714, 5563.916541251884, 5569.387367389584, 8933.508657023796, 9031.096890310917, 9134.040925702839, 9163.49600771964, 9251.629934802668, 9172.495512746864, 9226.86159707605, 9234.445933244027, 9282.72151835446, 9338.95330523343, 7045.8238544035785, 7197.712091516385, 7204.207537170907, 7228.9999999998945, 7237.167725711505, 6931.584104953719, 6933.3066693332285, 6933.445324374139, 6946.16646002483, 6969.477289203229, 8044.758657240292, 8180.0, 8203.138670439517, 8215.753527394188, 8321.625526851185, 8224.835503289782, 8388.245057944814, 8399.992000959925, 8499.74500764978, 8515.48907065578, 6447.3552644735155, 6502.187226596676, 6503.219613646393, 6518.348165183634, 6552.705128269335, 7428.517146385468, 7450.96274518624, 7466.216047314953, 7466.589337586485, 7474.663640136098, 6914.239433662193, 7008.369246767816, 7020.7542736004, 7115.288471152843, 7131.750388736369, 6835.077264569419, 6851.760188393382, 6936.306369363225, 6946.2011868635755, 6950.79147625572, 6003.669798161143, 6569.967150164219, 6966.9303306966285, 6987.056747339044, 7032.542884712478, 6435.517336199898, 6449.5485316027425, 6478.838029049123, 6479.157709497735, 6493.935060649333, 6479.157709497924, 6507.316731743288, 6514.771982980573, 6530.314316996647, 6548.0], "unit": "ms", "name": "mootools.html", "value": 4345.1285618700995}, {"lowerIsBetter": false, "replicates": [313.7568384502012, 316.5963396669246, 318.1886190214953, 323.4533638151524, 328.453125545966, 5887.23465949427, 5958.8808223835495, 5985.610935289209, 5999.880002399949, 6008.339082700911, 5784.3058832940005, 5911.113333000052, 5932.644041357522, 5937.168796368512, 5949.7025148742605, 4591.563801438858, 4593.862184134465, 4596.172688915994, 4599.425071866017, 4601.964557974463, 4344.304911214206, 4425.66807489438, 4484.573965473275, 4583.03756211196, 4590.449146102473, 4541.636669066484, 4569.109023740372, 4571.9314210286875, 4573.748443835604, 4583.0, 4563.338315944186, 4578.908421831561, 4579.793909274091, 4586.885327866797, 4592.563706447882, 4022.2357752027315, 4023.155137421145, 4024.577419370953, 4030.496187976503, 4030.8992275193064, 5559.9444005559835, 5649.689267090308, 5676.2620859288445, 5705.286839145107, 5713.942860571383, 5249.685018898878, 5262.605304602132, 5265.7893684252585, 5272.920906186372, 5274.55166310864, 6037.698115094272, 6334.334894836022, 6339.873202535923, 6340.682965851689, 6344.0, 4137.482814648169, 4286.978565107154, 4376.015396535754, 4377.474703035656, 4382.276924307485, 6531.836704082389, 6532.150820393318, 6582.144321238208, 6589.538732288742, 6617.404433600999, 4450.0, 4454.799534020977, 4454.955450445519, 4457.286834106528, 4457.68796184264, 4422.20400327944, 4505.391772110788, 4509.774511274423, 4513.50351461339, 4528.366028755977, 5232.058229518647, 5245.895082098336, 5246.580273578104, 5248.107821670325, 5252.868678282997, 6332.588381755171, 6377.426031657174, 6377.74489020434, 6379.521535884827, 6387.968060159669, 1574.5827355750735, 1600.6718622682322, 1603.4147536149221, 1603.5109291666154, 1604.3181647799638, 1001.6944831826218, 1023.5803320638652, 1033.3128469567653, 1045.0855501436242, 1046.49768111307, 6177.166082578884, 6187.659678717714, 6189.84525386869, 6190.442860142519, 6191.845203869849, 6534.771283005072, 6534.934650653433, 6544.70548825304, 6552.9344706553275, 6575.473962083021, 6046.0, 6183.628982261079, 6186.0, 6187.84530386744, 6190.102435146879, 3522.894313170609, 3544.858205671796, 3548.946765798515, 3552.982235088808, 3554.662307080823, 6796.35434633709, 6797.5581587196675, 6800.52396332252, 6804.319568043156, 6813.965930170417, 6565.048068030204, 6689.163854518185, 6693.423032132567, 6697.966510167418, 6701.798946031627, 6769.0, 6781.559198652072, 6785.1518560179975, 6795.082663840417, 6803.115594972721, 6346.714397852015, 6493.935060649333, 6496.9025464617125, 6497.350264973465, 6502.804915852532, 6337.936620633919, 6490.058941453557, 6498.740050397932, 6519.185101862267, 6522.15212022434, 6849.0, 6850.246472888078, 6859.759908403182, 6868.347506986828, 6876.037354770237, 4413.271810151289, 4508.774561271989, 4513.0, 4515.729056256635, 4519.141363140992, 6521.6087034776165, 6545.21457425112, 6580.7038683260325, 6589.868202636017, 6594.538382313192, 6406.903896441464, 6411.903821442776, 6415.711292991733, 6416.294207637063, 6427.55007149495, 6257.4681152102585, 6397.568923808923, 6408.551401401857, 6411.358864113551, 6419.679016049272, 6286.65423401699, 6287.622742635456, 6291.528135389955, 6295.276043255084, 6298.338674439301, 6441.227052753512, 6445.516586255956, 6445.903311450238, 6449.806505804833, 6450.870982580416, 6178.62928224308, 6267.717952692231, 6300.810975670737, 6301.275353334242, 6304.148939893055], "unit": "ms", "name": "prototype.html", "value": 4774.213732341228}, {"lowerIsBetter": false, "replicates": [759.5974133709134, 779.9025121859768, 857.1813917708589, 862.5687156421789, 863.4258218284841, 14235.43058277669, 14371.993960422775, 14399.64000899978, 14443.711125777478, 14448.638784030405, 13678.863211367883, 13782.0, 13797.0, 13808.930955345235, 13810.447582096704, 693.9791806245821, 702.3222590200455, 828.5898480252268, 833.8457385383723, 851.9574021298941, 820.7209548753423, 833.4374297349295, 833.5998720614109, 836.8786525953733, 837.7235512280932, 875.9737207883742, 877.1579283887476, 877.5831480046991, 878.1043335797483, 879.5470332778624, 724.8948902409147, 732.4140687450046, 873.6854732296337, 879.564615515324, 886.3175354976632, 648.8215740671305, 652.0154566604414, 652.4030512081487, 652.517137318381, 653.0074287083606, 12401.25592464455, 12826.358682065953, 12841.0, 12842.229466232056, 12866.742665146645, 10491.055804977588, 12385.62843114708, 12792.424340904681, 12871.163374380636, 13145.802812957718, 10064.245181611408, 10069.496525173785, 10266.281360304782, 10276.486175691185, 10343.79312413755, 3101.1936896407096, 3154.57413249213, 3169.4770362890094, 3240.481522956339, 3243.61076670801, 44518.777406113084, 44929.55070449286, 44938.32592511115, 45546.544534554894, 46346.53653463456, 10609.89390106089, 10624.618799556009, 10629.893701063045, 11063.22557420989, 11474.54101835934, 19958.50103747389, 19967.500812479804, 20028.399148025583, 20039.398818035483, 20064.69902951457, 7739.380849532136, 7931.365490760725, 7949.841003179904, 7975.1626079262005, 7983.321417679446, 4245.5542168072525, 4280.807363668642, 4342.261815491374, 4417.558244175557, 4489.663275254369, 3203.8077715337154, 3229.3218424130728, 3230.466972949484, 3231.74146068314, 3233.725133363643, 476.754471447205, 479.46060681733053, 482.2693619166965, 483.5164835164835, 490.7938665760389, 598.1954271504819, 629.5372900917822, 657.8223879552494, 661.8874791285493, 669.2332242878707, 8078.474899131537, 8124.512529248264, 8465.619047142893, 8666.306695464347, 8957.328200384996, 455.8040042781569, 522.950319719626, 540.8566729816602, 556.5686592890461, 564.1453198404421, 3821.2551699334253, 3869.342211823997, 3899.4735710678697, 3917.353636649978, 3965.1871366369824, 58138.418615814146, 59181.0, 59278.70360648255, 59563.40436595665, 59598.40401596015, 53392.0, 53549.46450535523, 54256.72871635616, 54366.18450723242, 54387.0, 47207.76396118066, 48348.27477587769, 48393.75803120962, 48796.75601621969, 48818.0, 7430.814229644302, 7670.693172273047, 7710.691572337044, 7957.681692732226, 8096.959515202387, 34457.13857153491, 34463.483047753805, 35960.28079438449, 36992.81503592465, 38015.0, 47696.284555731, 48088.0, 49914.50085499098, 50373.49626503688, 51015.89841015869, 10505.68482945513, 10626.787464250827, 10840.783184336111, 11025.889741102486, 11288.604898828502, 11511.654650360502, 11529.135314851252, 11749.060075194135, 12106.0, 12123.939380303042, 10662.8933710665, 10685.198610104118, 11041.834372484258, 11366.545338186379, 11503.94248028788, 10705.518251678537, 10810.67567972962, 11003.22977391575, 11039.061679757311, 11043.226974111734, 9653.924406252689, 10344.844827327746, 10369.222308327056, 10377.84433233487, 10380.532876020749, 9473.52632368365, 9605.231581473605, 9677.177439917687, 9811.656592019244, 10059.39643621385, 8603.78187117276, 8663.176998185163, 8740.21338079576, 9090.13643703847, 9160.816783664422], "unit": "ms", "name": "yui.html", "value": 6247.525321943829}], "name": "dromaeo_css", "value": 6854.647629399513}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 104.0, 109.0, 110.0, 111.0, 99.0, 109.0, 108.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [148.0, 123.0, 155.0, 162.0, 125.0, 146.0, 146.0, 125.0, 160.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 161.0, 160.0, 159.0, 159.0, 163.0, 168.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 86.0, 90.0, 72.0, 72.0, 79.0, 96.0, 90.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [89.0, 89.0, 137.0, 90.0, 90.0, 90.0, 138.0, 89.0, 89.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 104.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 144.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 101.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 58.0, 61.0, 59.0, 61.0, 58.0, 67.0, 56.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 67.0, 68.0, 69.0, 68.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 85.0, 86.0, 87.0, 85.0, 84.0, 85.0, 86.0, 92.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [118.0, 131.0, 115.0, 117.0, 122.0, 117.0, 121.0, 114.0, 114.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [141.0, 150.0, 149.0, 148.0, 150.0, 139.0, 149.0, 150.0, 151.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 64.0, 67.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.3}], "name": "kraken", "value": 1489.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.813415825464], "unit": "score", "name": "Richards", "value": 216.82488399999997}, {"lowerIsBetter": false, "replicates": [194.85580670303975], "unit": "score", "name": "DeltaBlue", "value": 339.3175759999999}, {"lowerIsBetter": false, "replicates": [284.4950213371266], "unit": "score", "name": "Encrypt", "value": 935.6262149999995}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [11764.70588235294], "unit": "score", "name": "Boyer", "value": 56.64935499999997}, {"lowerIsBetter": false, "replicates": [26128.20512820513], "unit": "score", "name": "RegExp", "value": 34.86596172718352}, {"lowerIsBetter": false, "replicates": [640.6149903907751], "unit": "score", "name": "Splay", "value": 127.207451}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19774.906769179535}]} 09:51:54 INFO - RETURN: dromaeo_css: 6854.65 09:51:54 INFO - RETURN: kraken: 1489.40 09:51:54 INFO - RETURN: v8_7: 19774.91 09:51:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19774.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1489.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6854.65"}}} 09:51:54 INFO - Return code: 0 09:51:54 INFO - # TBPL SUCCESS # 09:51:54 INFO - Running post-action listener: _resource_record_post_action 09:51:54 INFO - Running post-run listener: _resource_record_post_run 09:51:55 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508887040; Read time: 8; Write time: 827544 09:51:55 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 74436608; Read time: 0; Write time: 82544 09:51:55 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 384249856; Read time: 8; Write time: 527752 09:51:55 INFO - Running post-run listener: _upload_blobber_files 09:51:55 INFO - Blob upload gear active. 09:51:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:51:55 INFO - Copying logs to upload dir... 09:51:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.441181 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-19 09:51:54.964661) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:51:54.968499) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009974 build_url: 'https://queue.taskcluster.net/v1/task/UWhcG3fsRnS9LLoBlUZAnw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:51:55.019941) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:51:55.020288) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447954248.389123-1823317515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:51:55.069879) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 09:51:55.070205) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 09:51:55.070503) ========= ========= Total master_lag: 0.22 =========