builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1448330364.82 results: success (0) buildid: 20151123163001 builduid: f7a6c297645f47539aaaace126d55e64 revision: 19d89caa664dd9309c796929225ee409df5d1ee4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:24.823165) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:24.823579) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:24.823892) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006443 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:24.863669) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:24.863975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:24.898960) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:24.899323) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004702 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:24.949392) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:24.949701) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:24.950129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:24.950437) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 17:59:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-11-23 17:59:25 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112914 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:25.077576) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:25.077947) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019021 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:25.129342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 17:59:25.129796) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 19d89caa664dd9309c796929225ee409df5d1ee4 --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 19d89caa664dd9309c796929225ee409df5d1ee4 --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=ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 17:59:25,343 truncating revision to first 12 chars 2015-11-23 17:59:25,343 Setting DEBUG logging. 2015-11-23 17:59:25,343 attempt 1/10 2015-11-23 17:59:25,343 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/19d89caa664d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 17:59:26,472 unpacking tar archive at: mozilla-central-19d89caa664d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.433010 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 17:59:26.578339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:26.578689) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:26.587299) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:26.587608) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 17:59:26.588036) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-23 17:59:26.588372) ========= /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=ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:59:26 INFO - MultiFileLogger online at 20151123 17:59:26 in /builds/slave/test-pgo 17:59:26 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 17:59:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:59:26 INFO - {'append_to_log': False, 17:59:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:59:26 INFO - 'blob_upload_branch': 'Firefox', 17:59:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:59:26 INFO - 'branch': 'Firefox', 17:59:26 INFO - 'buildbot_json_path': 'buildprops.json', 17:59:26 INFO - 'config_files': ('talos/linux_config.py',), 17:59:26 INFO - 'default_actions': ('clobber', 17:59:26 INFO - 'read-buildbot-config', 17:59:26 INFO - 'download-and-extract', 17:59:26 INFO - 'populate-webroot', 17:59:26 INFO - 'create-virtualenv', 17:59:26 INFO - 'install', 17:59:26 INFO - 'run-tests'), 17:59:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:59:26 INFO - 'download_minidump_stackwalk': True, 17:59:26 INFO - 'download_symbols': 'ondemand', 17:59:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:59:26 INFO - 'tooltool.py': '/tools/tooltool.py', 17:59:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:59:26 INFO - '/tools/misc-python/virtualenv.py')}, 17:59:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:59:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:59:26 INFO - 'installer_path': 'installer.exe', 17:59:26 INFO - 'log_level': 'info', 17:59:26 INFO - 'log_name': 'talos', 17:59:26 INFO - 'log_to_console': True, 17:59:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:59:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:59:26 INFO - 'opt_config_files': (), 17:59:26 INFO - 'pip_index': False, 17:59:26 INFO - 'sps_profile': False, 17:59:26 INFO - 'sps_profile_interval': 0, 17:59:26 INFO - 'suite': 'dromaeojs', 17:59:26 INFO - 'system_bits': '64', 17:59:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:59:26 INFO - 'title': 'talos-linux64-ix-043', 17:59:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:59:26 INFO - 'use_talos_json': True, 17:59:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:59:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:59:26 INFO - 'work_dir': 'build'} 17:59:26 INFO - ##### 17:59:26 INFO - ##### Running clobber step. 17:59:26 INFO - ##### 17:59:26 INFO - Running pre-action listener: _resource_record_pre_action 17:59:26 INFO - Running main action method: clobber 17:59:26 INFO - rmtree: /builds/slave/test-pgo/build 17:59:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:59:27 INFO - Running post-action listener: _resource_record_post_action 17:59:27 INFO - ##### 17:59:27 INFO - ##### Running read-buildbot-config step. 17:59:27 INFO - ##### 17:59:27 INFO - Running pre-action listener: _resource_record_pre_action 17:59:27 INFO - Running main action method: read_buildbot_config 17:59:27 INFO - Using buildbot properties: 17:59:27 INFO - { 17:59:27 INFO - "properties": { 17:59:27 INFO - "buildnumber": 119, 17:59:27 INFO - "product": "firefox", 17:59:27 INFO - "script_repo_revision": "production", 17:59:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:59:27 INFO - "repository": "", 17:59:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 17:59:27 INFO - "buildid": "20151123163001", 17:59:27 INFO - "slavename": "talos-linux64-ix-043", 17:59:27 INFO - "pgo_build": "True", 17:59:27 INFO - "basedir": "/builds/slave/test-pgo", 17:59:27 INFO - "project": "", 17:59:27 INFO - "platform": "ubuntu64_hw", 17:59:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:59:27 INFO - "slavebuilddir": "test", 17:59:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 17:59:27 INFO - "branch": "mozilla-central", 17:59:27 INFO - "repo_path": "mozilla-central", 17:59:27 INFO - "stage_platform": "linux64-pgo", 17:59:27 INFO - "builduid": "f7a6c297645f47539aaaace126d55e64", 17:59:27 INFO - "revision": "19d89caa664dd9309c796929225ee409df5d1ee4" 17:59:27 INFO - }, 17:59:27 INFO - "sourcestamp": { 17:59:27 INFO - "repository": "", 17:59:27 INFO - "hasPatch": false, 17:59:27 INFO - "project": "", 17:59:27 INFO - "branch": "mozilla-central-linux64-pgo-talos", 17:59:27 INFO - "changes": [ 17:59:27 INFO - { 17:59:27 INFO - "category": null, 17:59:27 INFO - "files": [ 17:59:27 INFO - { 17:59:27 INFO - "url": null, 17:59:27 INFO - "name": "https://queue.taskcluster.net/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 17:59:27 INFO - } 17:59:27 INFO - ], 17:59:27 INFO - "repository": "", 17:59:27 INFO - "rev": "19d89caa664dd9309c796929225ee409df5d1ee4", 17:59:27 INFO - "who": "sendchange", 17:59:27 INFO - "when": 1448330271, 17:59:27 INFO - "number": 6698370, 17:59:27 INFO - "comments": "", 17:59:27 INFO - "project": "", 17:59:27 INFO - "at": "Mon 23 Nov 2015 17:57:51", 17:59:27 INFO - "branch": "mozilla-central-linux64-pgo-talos", 17:59:27 INFO - "revlink": "", 17:59:27 INFO - "properties": [ 17:59:27 INFO - [ 17:59:27 INFO - "buildid", 17:59:27 INFO - "20151123163001", 17:59:27 INFO - "Change" 17:59:27 INFO - ], 17:59:27 INFO - [ 17:59:27 INFO - "builduid", 17:59:27 INFO - "f7a6c297645f47539aaaace126d55e64", 17:59:27 INFO - "Change" 17:59:27 INFO - ], 17:59:27 INFO - [ 17:59:27 INFO - "pgo_build", 17:59:27 INFO - "True", 17:59:27 INFO - "Change" 17:59:27 INFO - ] 17:59:27 INFO - ], 17:59:27 INFO - "revision": "19d89caa664dd9309c796929225ee409df5d1ee4" 17:59:27 INFO - } 17:59:27 INFO - ], 17:59:27 INFO - "revision": "19d89caa664dd9309c796929225ee409df5d1ee4" 17:59:27 INFO - } 17:59:27 INFO - } 17:59:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 17:59:27 INFO - Running post-action listener: _resource_record_post_action 17:59:27 INFO - ##### 17:59:27 INFO - ##### Running download-and-extract step. 17:59:27 INFO - ##### 17:59:27 INFO - Running pre-action listener: _resource_record_pre_action 17:59:27 INFO - Running main action method: download_and_extract 17:59:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:27 INFO - https://queue.taskcluster.net/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/test_packages.json 17:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/test_packages.json 17:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:59:30 INFO - Downloaded 1302 bytes. 17:59:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:59:30 INFO - Using the following test package requirements: 17:59:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:59:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:59:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:59:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:59:30 INFO - u'jsshell-linux-x86_64.zip'], 17:59:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:59:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:59:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:59:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:59:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:59:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:59:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:59:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:59:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:59:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:59:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:59:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:59:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:30 INFO - https://queue.taskcluster.net/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:59:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:59:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:59:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/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 17:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/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 17:59:34 INFO - Downloaded 22525861 bytes. 17:59:34 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 17:59:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:59:34 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 17:59:35 INFO - Return code: 0 17:59:35 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 17:59:35 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')]} 17:59:35 INFO - https://queue.taskcluster.net/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/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 17:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/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 17:59:40 INFO - Downloaded 22525861 bytes. 17:59:40 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 17:59:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:59:40 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 17:59:41 INFO - Return code: 0 17:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:41 INFO - https://queue.taskcluster.net/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/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 17:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/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 17:59:42 INFO - Downloaded 11130997 bytes. 17:59:42 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 17:59:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:59:42 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 17:59:42 INFO - Return code: 0 17:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:42 INFO - https://queue.taskcluster.net/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/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 17:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/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 17:59:43 INFO - Downloaded 57548023 bytes. 17:59:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:59:43 INFO - mkdir: /builds/slave/test-pgo/properties 17:59:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:59:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:59:43 INFO - Contents: 17:59:43 INFO - build_url:https://queue.taskcluster.net/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:59:43 INFO - Running post-action listener: _resource_record_post_action 17:59:43 INFO - Running post-action listener: set_extra_try_arguments 17:59:43 INFO - ##### 17:59:43 INFO - ##### Running populate-webroot step. 17:59:43 INFO - ##### 17:59:43 INFO - Running pre-action listener: _resource_record_pre_action 17:59:43 INFO - Running main action method: populate_webroot 17:59:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:59:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:59:43 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:59:43 INFO - '../fennec_ids.txt'], 17:59:43 INFO - 'tests': ['tcheck2']}, 17:59:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:59:43 INFO - '--tppagecycles', 17:59:43 INFO - '7'], 17:59:43 INFO - 'tests': ['tsvgm']}}, 17:59:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:59:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:59:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:59:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:59:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:59:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:59:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:59:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:43 INFO - 'talos_options': ['--e10s'], 17:59:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:59:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:43 INFO - 'tests': ['damp', 'tps']}, 17:59:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:43 INFO - 'talos_options': ['--e10s'], 17:59:43 INFO - 'tests': ['damp', 'tps']}, 17:59:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:59:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:59:43 INFO - 'other': {'tests': ['a11yr', 17:59:43 INFO - 'ts_paint', 17:59:43 INFO - 'tpaint', 17:59:43 INFO - 'sessionrestore', 17:59:43 INFO - 'sessionrestore_no_auto_restore']}, 17:59:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:59:43 INFO - 'tests': ['a11yr', 17:59:43 INFO - 'ts_paint', 17:59:43 INFO - 'tpaint', 17:59:43 INFO - 'sessionrestore', 17:59:43 INFO - 'sessionrestore_no_auto_restore']}, 17:59:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:59:43 INFO - 'tests': ['a11yr', 17:59:43 INFO - 'ts_paint', 17:59:43 INFO - 'tpaint', 17:59:43 INFO - 'sessionrestore', 17:59:43 INFO - 'sessionrestore_no_auto_restore']}, 17:59:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:59:43 INFO - 'tests': ['a11yr', 17:59:43 INFO - 'ts_paint', 17:59:43 INFO - 'tpaint', 17:59:43 INFO - 'sessionrestore', 17:59:43 INFO - 'sessionrestore_no_auto_restore']}, 17:59:43 INFO - 'other_l64': {'tests': ['a11yr', 17:59:43 INFO - 'ts_paint', 17:59:43 INFO - 'tpaint', 17:59:43 INFO - 'sessionrestore', 17:59:43 INFO - 'sessionrestore_no_auto_restore']}, 17:59:43 INFO - 'other_nol64': {'tests': ['a11yr', 17:59:43 INFO - 'ts_paint', 17:59:43 INFO - 'tpaint', 17:59:43 INFO - 'sessionrestore', 17:59:43 INFO - 'sessionrestore_no_auto_restore']}, 17:59:43 INFO - 'svgr': {'tests': ['tsvgx', 17:59:43 INFO - 'tsvgr_opacity', 17:59:43 INFO - 'tart', 17:59:43 INFO - 'tscrollx', 17:59:43 INFO - 'cart']}, 17:59:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:59:43 INFO - 'tests': ['tsvgx', 17:59:43 INFO - 'tsvgr_opacity', 17:59:43 INFO - 'tart', 17:59:43 INFO - 'tscrollx', 17:59:43 INFO - 'cart']}, 17:59:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:43 INFO - 'tests': ['tp5o']}, 17:59:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:43 INFO - 'talos_options': ['--e10s'], 17:59:43 INFO - 'tests': ['tp5o']}, 17:59:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:43 INFO - 'talos_options': ['--xperf_path', 17:59:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:59:43 INFO - 'tests': ['tp5n']}, 17:59:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:43 INFO - 'talos_options': ['--e10s', 17:59:43 INFO - '--xperf_path', 17:59:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:59:43 INFO - 'tests': ['tp5n']}}, 17:59:43 INFO - 'talos.zip': {'path': '', 17:59:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:59:43 INFO - Running post-action listener: _resource_record_post_action 17:59:43 INFO - ##### 17:59:43 INFO - ##### Running create-virtualenv step. 17:59:43 INFO - ##### 17:59:43 INFO - Running pre-action listener: _resource_record_pre_action 17:59:43 INFO - Running main action method: create_virtualenv 17:59:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:59:43 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 17:59:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:59:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:59:44 INFO - Using real prefix '/usr' 17:59:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:59:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:59:46 INFO - Installing pip.................done. 17:59:46 INFO - Return code: 0 17:59:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:59:46 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')]} 17:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:46 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')]} 17:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:46 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 0x7fe472eddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a09a90>, '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 0x1a5bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c2e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', '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 17:59:46 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 17:59:46 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 17:59:46 INFO - Using env: {'DISPLAY': ':0', 17:59:46 INFO - 'HOME': '/home/cltbld', 17:59:46 INFO - 'LANG': 'en_US.UTF-8', 17:59:46 INFO - 'LANGUAGE': 'en_US:en', 17:59:46 INFO - 'LOGNAME': 'cltbld', 17:59:46 INFO - 'MAIL': '/var/mail/cltbld', 17:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:46 INFO - 'MOZ_NO_REMOTE': '1', 17:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:46 INFO - 'NO_EM_RESTART': '1', 17:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:59:46 INFO - 'PWD': '/builds/slave/test-pgo', 17:59:46 INFO - 'SHELL': '/bin/bash', 17:59:46 INFO - 'SHLVL': '1', 17:59:46 INFO - 'TERM': 'linux', 17:59:46 INFO - 'TMOUT': '86400', 17:59:46 INFO - 'USER': 'cltbld', 17:59:46 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', 17:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:46 INFO - '_': '/tools/buildbot/bin/python'} 17:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:46 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 17:59:46 INFO - Cleaning up... 17:59:46 INFO - Return code: 0 17:59:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:59:46 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')]} 17:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:46 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')]} 17:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:46 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 0x7fe472eddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a09a90>, '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 0x1a5bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c2e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', '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 17:59:46 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 17:59:46 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 17:59:46 INFO - Using env: {'DISPLAY': ':0', 17:59:46 INFO - 'HOME': '/home/cltbld', 17:59:46 INFO - 'LANG': 'en_US.UTF-8', 17:59:46 INFO - 'LANGUAGE': 'en_US:en', 17:59:46 INFO - 'LOGNAME': 'cltbld', 17:59:46 INFO - 'MAIL': '/var/mail/cltbld', 17:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:46 INFO - 'MOZ_NO_REMOTE': '1', 17:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:46 INFO - 'NO_EM_RESTART': '1', 17:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:59:46 INFO - 'PWD': '/builds/slave/test-pgo', 17:59:46 INFO - 'SHELL': '/bin/bash', 17:59:46 INFO - 'SHLVL': '1', 17:59:46 INFO - 'TERM': 'linux', 17:59:46 INFO - 'TMOUT': '86400', 17:59:46 INFO - 'USER': 'cltbld', 17:59:46 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', 17:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:46 INFO - '_': '/tools/buildbot/bin/python'} 17:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:47 INFO - Downloading/unpacking psutil>=0.7.1 17:59:47 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 17:59:47 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 17:59:47 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 17:59:47 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 17:59:47 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 17:59:47 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 17:59:48 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:59:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:59:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:59:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:59:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:59:48 INFO - Installing collected packages: psutil 17:59:48 INFO - Running setup.py install for psutil 17:59:48 INFO - building 'psutil._psutil_linux' extension 17:59:48 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 17:59:49 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 17:59:49 INFO - building 'psutil._psutil_posix' extension 17:59:49 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 17:59:49 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 17:59:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:59:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:59:49 INFO - Successfully installed psutil 17:59:49 INFO - Cleaning up... 17:59:49 INFO - Return code: 0 17:59:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:49 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 0x7fe472eddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a09a90>, '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 0x1a5bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c2e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', '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 17:59:49 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 17:59:49 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 17:59:49 INFO - Using env: {'DISPLAY': ':0', 17:59:49 INFO - 'HOME': '/home/cltbld', 17:59:49 INFO - 'LANG': 'en_US.UTF-8', 17:59:49 INFO - 'LANGUAGE': 'en_US:en', 17:59:49 INFO - 'LOGNAME': 'cltbld', 17:59:49 INFO - 'MAIL': '/var/mail/cltbld', 17:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:49 INFO - 'MOZ_NO_REMOTE': '1', 17:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:49 INFO - 'NO_EM_RESTART': '1', 17:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:59:49 INFO - 'PWD': '/builds/slave/test-pgo', 17:59:49 INFO - 'SHELL': '/bin/bash', 17:59:49 INFO - 'SHLVL': '1', 17:59:49 INFO - 'TERM': 'linux', 17:59:49 INFO - 'TMOUT': '86400', 17:59:49 INFO - 'USER': 'cltbld', 17:59:49 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', 17:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:49 INFO - '_': '/tools/buildbot/bin/python'} 17:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:59:49 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 17:59:49 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 17:59:49 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 17:59:49 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 17:59:49 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 17:59:49 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 17:59:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:59:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:59:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:59:51 INFO - Installing collected packages: mozsystemmonitor 17:59:51 INFO - Running setup.py install for mozsystemmonitor 17:59:51 INFO - Successfully installed mozsystemmonitor 17:59:51 INFO - Cleaning up... 17:59:51 INFO - Return code: 0 17:59:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:59: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')]} 17:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59: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')]} 17:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:51 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 0x7fe472eddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a09a90>, '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 0x1a5bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c2e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', '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 17:59:51 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 17:59:51 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 17:59:51 INFO - Using env: {'DISPLAY': ':0', 17:59:51 INFO - 'HOME': '/home/cltbld', 17:59:51 INFO - 'LANG': 'en_US.UTF-8', 17:59:51 INFO - 'LANGUAGE': 'en_US:en', 17:59:51 INFO - 'LOGNAME': 'cltbld', 17:59:51 INFO - 'MAIL': '/var/mail/cltbld', 17:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:51 INFO - 'MOZ_NO_REMOTE': '1', 17:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:51 INFO - 'NO_EM_RESTART': '1', 17:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:59:51 INFO - 'PWD': '/builds/slave/test-pgo', 17:59:51 INFO - 'SHELL': '/bin/bash', 17:59:51 INFO - 'SHLVL': '1', 17:59:51 INFO - 'TERM': 'linux', 17:59:51 INFO - 'TMOUT': '86400', 17:59:51 INFO - 'USER': 'cltbld', 17:59:51 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', 17:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:51 INFO - '_': '/tools/buildbot/bin/python'} 17:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:51 INFO - Downloading/unpacking blobuploader==1.2.4 17:59:51 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 17:59:51 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 17:59:51 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 17:59:51 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 17:59:51 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 17:59:51 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 17:59:53 INFO - Downloading blobuploader-1.2.4.tar.gz 17:59:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:59:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:59:53 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 17:59:53 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 17:59:53 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 17:59:53 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 17:59:53 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 17:59:53 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 17:59:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:59:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:59:53 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 17:59:53 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 17:59:53 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 17:59:53 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 17:59:53 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 17:59:53 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 17:59:54 INFO - Downloading docopt-0.6.1.tar.gz 17:59:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:59:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:59:54 INFO - Installing collected packages: blobuploader, requests, docopt 17:59:54 INFO - Running setup.py install for blobuploader 17:59:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:59:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:59:54 INFO - Running setup.py install for requests 17:59:54 INFO - Running setup.py install for docopt 17:59:54 INFO - Successfully installed blobuploader requests docopt 17:59:54 INFO - Cleaning up... 17:59:54 INFO - Return code: 0 17:59:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:59: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')]} 17:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59: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')]} 17:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:54 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 0x7fe472eddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a09a90>, '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 0x1a5bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c2e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', '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 17:59:54 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 17:59:54 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 17:59:54 INFO - Using env: {'DISPLAY': ':0', 17:59:54 INFO - 'HOME': '/home/cltbld', 17:59:54 INFO - 'LANG': 'en_US.UTF-8', 17:59:54 INFO - 'LANGUAGE': 'en_US:en', 17:59:54 INFO - 'LOGNAME': 'cltbld', 17:59:54 INFO - 'MAIL': '/var/mail/cltbld', 17:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:54 INFO - 'MOZ_NO_REMOTE': '1', 17:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:54 INFO - 'NO_EM_RESTART': '1', 17:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:59:54 INFO - 'PWD': '/builds/slave/test-pgo', 17:59:54 INFO - 'SHELL': '/bin/bash', 17:59:54 INFO - 'SHLVL': '1', 17:59:54 INFO - 'TERM': 'linux', 17:59:54 INFO - 'TMOUT': '86400', 17:59:54 INFO - 'USER': 'cltbld', 17:59:54 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', 17:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:54 INFO - '_': '/tools/buildbot/bin/python'} 17:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:59:54 INFO - Running setup.py (path:/tmp/pip-5_F0Sh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:59:55 INFO - Running setup.py (path:/tmp/pip-PBWvVd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:59:55 INFO - Running setup.py (path:/tmp/pip-_7jMwl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:59:55 INFO - Running setup.py (path:/tmp/pip-ET1jro-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:59:55 INFO - Running setup.py (path:/tmp/pip-s41CaS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:59:55 INFO - Running setup.py (path:/tmp/pip-c0z3XW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:59:55 INFO - Running setup.py (path:/tmp/pip-qelpmh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:59:55 INFO - Running setup.py (path:/tmp/pip-MhL6FF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:59:55 INFO - Running setup.py (path:/tmp/pip-iaTsdT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:59:55 INFO - Running setup.py (path:/tmp/pip-nBA3xv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:59:55 INFO - Running setup.py (path:/tmp/pip-nDLvwf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:59:55 INFO - Running setup.py (path:/tmp/pip-qfiYoO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:59:55 INFO - Running setup.py (path:/tmp/pip-O9N767-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:59:55 INFO - Running setup.py (path:/tmp/pip-7FCW7Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:59:55 INFO - Running setup.py (path:/tmp/pip-x1jqGL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:59:56 INFO - Running setup.py (path:/tmp/pip-Oxd09W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:59:56 INFO - Running setup.py (path:/tmp/pip-0JRiq3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:59:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:59:56 INFO - Running setup.py install for manifestparser 17:59:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:59:56 INFO - Running setup.py install for mozcrash 17:59:56 INFO - Running setup.py install for mozdebug 17:59:56 INFO - Running setup.py install for mozdevice 17:59:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:59:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:59:56 INFO - Running setup.py install for mozfile 17:59:56 INFO - Running setup.py install for mozhttpd 17:59:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:59:56 INFO - Running setup.py install for mozinfo 17:59:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:59:56 INFO - Running setup.py install for mozInstall 17:59:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:59:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:59:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:59:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:59:57 INFO - Running setup.py install for mozleak 17:59:57 INFO - Running setup.py install for mozlog 17:59:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:59:57 INFO - Running setup.py install for moznetwork 17:59:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:59:57 INFO - Running setup.py install for mozprocess 17:59:57 INFO - Running setup.py install for mozprofile 17:59:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:59:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:59:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:59:57 INFO - Running setup.py install for mozrunner 17:59:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:59:57 INFO - Running setup.py install for mozscreenshot 17:59:57 INFO - Running setup.py install for moztest 17:59:57 INFO - Running setup.py install for mozversion 17:59:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:59:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:59:57 INFO - Cleaning up... 17:59:57 INFO - Return code: 0 17:59:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:59:57 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')]} 17:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:57 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')]} 17:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:57 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 0x7fe472eddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a09a90>, '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 0x1a5bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c2e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', '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 17:59:57 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 17:59:57 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 17:59:57 INFO - Using env: {'DISPLAY': ':0', 17:59:57 INFO - 'HOME': '/home/cltbld', 17:59:57 INFO - 'LANG': 'en_US.UTF-8', 17:59:57 INFO - 'LANGUAGE': 'en_US:en', 17:59:57 INFO - 'LOGNAME': 'cltbld', 17:59:57 INFO - 'MAIL': '/var/mail/cltbld', 17:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:57 INFO - 'MOZ_NO_REMOTE': '1', 17:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:57 INFO - 'NO_EM_RESTART': '1', 17:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:59:57 INFO - 'PWD': '/builds/slave/test-pgo', 17:59:57 INFO - 'SHELL': '/bin/bash', 17:59:57 INFO - 'SHLVL': '1', 17:59:57 INFO - 'TERM': 'linux', 17:59:57 INFO - 'TMOUT': '86400', 17:59:57 INFO - 'USER': 'cltbld', 17:59:57 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', 17:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:57 INFO - '_': '/tools/buildbot/bin/python'} 17:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:59:58 INFO - Running setup.py (path:/tmp/pip-DQZg0M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:59:58 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)) 17:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:59:58 INFO - Running setup.py (path:/tmp/pip-JBbIZc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:59:58 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)) 17:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:59:58 INFO - Running setup.py (path:/tmp/pip-xrhVH2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:59:58 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)) 17:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:59:58 INFO - Running setup.py (path:/tmp/pip-VROoMp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:59:58 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)) 17:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:59:58 INFO - Running setup.py (path:/tmp/pip-L3q104-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:59:58 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)) 17:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:59:58 INFO - Running setup.py (path:/tmp/pip-Jv8Bfu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:59:58 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)) 17:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:59:58 INFO - Running setup.py (path:/tmp/pip-Rz1T3h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:59:58 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)) 17:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:59:58 INFO - Running setup.py (path:/tmp/pip-RZZsJd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:59:58 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)) 17:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:59:58 INFO - Running setup.py (path:/tmp/pip-043cAQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:59:58 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)) 17:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:59:58 INFO - Running setup.py (path:/tmp/pip-I10gpd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:59:58 INFO - Running setup.py (path:/tmp/pip-1lhCkQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:59:58 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)) 17:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:59:58 INFO - Running setup.py (path:/tmp/pip-0HGSJY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:59:59 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)) 17:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:59:59 INFO - Running setup.py (path:/tmp/pip-fPx026-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:59:59 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)) 17:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:59:59 INFO - Running setup.py (path:/tmp/pip-IQ8meA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:59:59 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)) 17:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:59:59 INFO - Running setup.py (path:/tmp/pip-tZdT1s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:59:59 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)) 17:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:59:59 INFO - Running setup.py (path:/tmp/pip-tOi30j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:59:59 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)) 17:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:59:59 INFO - Running setup.py (path:/tmp/pip-gpa1mc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:59:59 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)) 17:59:59 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)) 17:59:59 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)) 17:59:59 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)) 17:59:59 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)) 17:59:59 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)) 17:59:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:59:59 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 17:59:59 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 17:59:59 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 17:59:59 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 17:59:59 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 17:59:59 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 18:00:01 INFO - Downloading blessings-1.5.1.tar.gz 18:00:01 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 18:00:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:00:01 INFO - Installing collected packages: blessings 18:00:01 INFO - Running setup.py install for blessings 18:00:01 INFO - Successfully installed blessings 18:00:01 INFO - Cleaning up... 18:00:01 INFO - Return code: 0 18:00:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:00:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:00:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:00:01 INFO - Reading from file tmpfile_stdout 18:00:01 INFO - Current package versions: 18:00:01 INFO - argparse == 1.2.1 18:00:01 INFO - blessings == 1.5.1 18:00:01 INFO - blobuploader == 1.2.4 18:00:01 INFO - docopt == 0.6.1 18:00:01 INFO - manifestparser == 1.1 18:00:01 INFO - mozInstall == 1.12 18:00:01 INFO - mozcrash == 0.16 18:00:01 INFO - mozdebug == 0.1 18:00:01 INFO - mozdevice == 0.47 18:00:01 INFO - mozfile == 1.2 18:00:01 INFO - mozhttpd == 0.7 18:00:01 INFO - mozinfo == 0.9 18:00:01 INFO - mozleak == 0.1 18:00:01 INFO - mozlog == 3.1 18:00:01 INFO - moznetwork == 0.27 18:00:01 INFO - mozprocess == 0.22 18:00:01 INFO - mozprofile == 0.27 18:00:01 INFO - mozrunner == 6.11 18:00:01 INFO - mozscreenshot == 0.1 18:00:01 INFO - mozsystemmonitor == 0.0 18:00:01 INFO - moztest == 0.7 18:00:01 INFO - mozversion == 1.4 18:00:01 INFO - psutil == 3.1.1 18:00:01 INFO - requests == 1.2.3 18:00:01 INFO - wsgiref == 0.1.2 18:00:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:00: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')]} 18:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00: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')]} 18:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:01 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 0x7fe472eddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a09a90>, '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 0x1a5bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c2e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', '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 18:00:01 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 18:00:01 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 18:00:01 INFO - Using env: {'DISPLAY': ':0', 18:00:01 INFO - 'HOME': '/home/cltbld', 18:00:01 INFO - 'LANG': 'en_US.UTF-8', 18:00:01 INFO - 'LANGUAGE': 'en_US:en', 18:00:01 INFO - 'LOGNAME': 'cltbld', 18:00:01 INFO - 'MAIL': '/var/mail/cltbld', 18:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:01 INFO - 'MOZ_NO_REMOTE': '1', 18:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:01 INFO - 'NO_EM_RESTART': '1', 18:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:00:01 INFO - 'PWD': '/builds/slave/test-pgo', 18:00:01 INFO - 'SHELL': '/bin/bash', 18:00:01 INFO - 'SHLVL': '1', 18:00:01 INFO - 'TERM': 'linux', 18:00:01 INFO - 'TMOUT': '86400', 18:00:01 INFO - 'USER': 'cltbld', 18:00:01 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', 18:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:01 INFO - '_': '/tools/buildbot/bin/python'} 18:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 INFO - Cleaning up... 18:00:01 INFO - Return code: 0 18:00:01 INFO - Running post-action listener: _resource_record_post_action 18:00:01 INFO - Running post-action listener: _start_resource_monitoring 18:00:01 INFO - Starting resource monitoring. 18:00:01 INFO - ##### 18:00:01 INFO - ##### Running install step. 18:00:01 INFO - ##### 18:00:01 INFO - Running pre-action listener: _resource_record_pre_action 18:00:01 INFO - Running main action method: install 18:00:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:00:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:00:02 INFO - Reading from file tmpfile_stdout 18:00:02 INFO - Detecting whether we're running mozinstall >=1.0... 18:00:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:00:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:00:02 INFO - Reading from file tmpfile_stdout 18:00:02 INFO - Output received: 18:00:02 INFO - Usage: mozinstall [options] installer 18:00:02 INFO - Options: 18:00:02 INFO - -h, --help show this help message and exit 18:00:02 INFO - -d DEST, --destination=DEST 18:00:02 INFO - Directory to install application into. [default: 18:00:02 INFO - "/builds/slave/test-pgo"] 18:00:02 INFO - --app=APP Application being installed. [default: firefox] 18:00:02 INFO - mkdir: /builds/slave/test-pgo/build/application 18:00:02 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'] 18:00:02 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 18:00:16 INFO - Reading from file tmpfile_stdout 18:00:16 INFO - Output received: 18:00:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:00:16 INFO - Running post-action listener: _resource_record_post_action 18:00:16 INFO - ##### 18:00:16 INFO - ##### Running run-tests step. 18:00:16 INFO - ##### 18:00:16 INFO - Running pre-action listener: _resource_record_pre_action 18:00:16 INFO - Running main action method: run_tests 18:00:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:00:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:00:16 INFO - Python 2.7.3 18:00:16 INFO - Return code: 0 18:00:16 INFO - grabbing minidump binary from tooltool 18:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:16 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 0x1a09a90>, '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 0x1a5bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:00:16 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 18:00:16 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 18:00:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:00:16 INFO - Return code: 0 18:00:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:00:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:00:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:00:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:00:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:00:16 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/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:00:16 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/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost 18:00:16 INFO - Using env: {'DISPLAY': ':0', 18:00:16 INFO - 'HOME': '/home/cltbld', 18:00:16 INFO - 'LANG': 'en_US.UTF-8', 18:00:16 INFO - 'LANGUAGE': 'en_US:en', 18:00:16 INFO - 'LOGNAME': 'cltbld', 18:00:16 INFO - 'MAIL': '/var/mail/cltbld', 18:00:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:00:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:16 INFO - 'MOZ_NO_REMOTE': '1', 18:00:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:16 INFO - 'NO_EM_RESTART': '1', 18:00:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:00:16 INFO - 'PWD': '/builds/slave/test-pgo', 18:00:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:00:16 INFO - 'SHELL': '/bin/bash', 18:00:16 INFO - 'SHLVL': '1', 18:00:16 INFO - 'TERM': 'linux', 18:00:16 INFO - 'TMOUT': '86400', 18:00:16 INFO - 'USER': 'cltbld', 18:00:16 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073', 18:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:16 INFO - '_': '/tools/buildbot/bin/python'} 18:00:16 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/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost'] with output_timeout 3600 18:00:16 INFO - mozversion INFO | application_buildid: 20151123163001 18:00:16 INFO - mozversion INFO | application_changeset: 19d89caa664dd9309c796929225ee409df5d1ee4 18:00:16 INFO - mozversion INFO | application_display_name: Nightly 18:00:16 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:00:16 INFO - mozversion INFO | application_name: Firefox 18:00:16 INFO - mozversion INFO | application_remotingname: firefox 18:00:16 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 18:00:16 INFO - mozversion INFO | application_vendor: Mozilla 18:00:16 INFO - mozversion INFO | application_version: 45.0a1 18:00:16 INFO - mozversion INFO | platform_buildid: 20151123163001 18:00:16 INFO - mozversion INFO | platform_changeset: 19d89caa664dd9309c796929225ee409df5d1ee4 18:00:16 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 18:00:16 INFO - mozversion INFO | platform_version: 45.0a1 18:00:16 INFO - 2015-11-23 18:00:16,815 DEBUG : using testdate: 1448330416 18:00:16 INFO - 2015-11-23 18:00:16,815 DEBUG : actual date: 1448330416 18:00:16 INFO - 2015-11-23 18:00:16,822 INFO : starting webserver on 'localhost:60244' 18:00:16 INFO - 2015-11-23 18:00:16,823 INFO : Starting test suite talos-linux64-ix-043 18:00:16 INFO - 2015-11-23 18:00:16,823 INFO : Starting test dromaeo_css 18:00:16 INFO - 2015-11-23 18:00:16,823 DEBUG : operating with platform_type : linux_ 18:00:16 INFO - 2015-11-23 18:00:16,823 INFO : Initialising browser for dromaeo_css test... 18:00:16 INFO - 2015-11-23 18:00:16,830 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxiY3s2/profile http://localhost:60244/getInfo.html 18:00:22 INFO - 2015-11-23 18:00:22,232 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:00:22 INFO - 2015-11-23 18:00:22,232 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:00:22 INFO - 2015-11-23 18:00:22,232 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:00:22 INFO - 2015-11-23 18:00:22,233 DEBUG : BROWSER_OUTPUT: __metrics 18:00:22 INFO - 2015-11-23 18:00:22,335 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:00:23 INFO - 2015-11-23 18:00:23,500 INFO : Browser initialized. 18:00:23 INFO - 2015-11-23 18:00:23,501 INFO : Running cycle 1/1 for dromaeo_css test... 18:00:23 INFO - 2015-11-23 18:00:23,501 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxiY3s2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:00:35 INFO - 2015-11-23 18:00:35,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 140734464 18:00:35 INFO - 2015-11-23 18:00:35,296 DEBUG : BROWSER_OUTPUT: 18:01:26 INFO - 2015-11-23 18:01:26,965 DEBUG : BROWSER_OUTPUT: 1448330486963 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] 18:03:35 INFO - 2015-11-23 18:03:35,814 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60244/tests/dromaeo/cssquery-ext.html) 18:03:36 INFO - 2015-11-23 18:03:36,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 260476928 18:03:36 INFO - 2015-11-23 18:03:36,939 DEBUG : BROWSER_OUTPUT: 18:06:39 INFO - 2015-11-23 18:06:39,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/dromaeo/cssquery-ext.html (next: http://localhost:60244/tests/dromaeo/cssquery-jquery.html) 18:06:39 INFO - 2015-11-23 18:06:39,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 225497088 18:06:39 INFO - 2015-11-23 18:06:39,887 DEBUG : BROWSER_OUTPUT: 18:09:41 INFO - 2015-11-23 18:09:41,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60244/tests/dromaeo/cssquery-mootools.html) 18:09:42 INFO - 2015-11-23 18:09:42,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 222871552 18:09:42 INFO - 2015-11-23 18:09:42,450 DEBUG : BROWSER_OUTPUT: 18:12:44 INFO - 2015-11-23 18:12:44,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60244/tests/dromaeo/cssquery-prototype.html) 18:12:44 INFO - 2015-11-23 18:12:44,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 204701696 18:12:44 INFO - 2015-11-23 18:12:44,851 DEBUG : BROWSER_OUTPUT: 18:15:47 INFO - 2015-11-23 18:15:47,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60244/tests/dromaeo/cssquery-yui.html) 18:15:47 INFO - 2015-11-23 18:15:47,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 206970880 18:15:47 INFO - 2015-11-23 18:15:47,850 DEBUG : BROWSER_OUTPUT: 18:18:50 INFO - 2015-11-23 18:18:50,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/dromaeo/cssquery-yui.html (next: http://localhost:60244/tests/dromaeo/cssquery-dojo.html) 18:18:50 INFO - 2015-11-23 18:18:50,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 294137856 18:18:50 INFO - 2015-11-23 18:18:50,641 DEBUG : BROWSER_OUTPUT: 18:18:50 INFO - 2015-11-23 18:18:50,641 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:18:50 INFO - 2015-11-23 18:18:50,641 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:18:50 INFO - 2015-11-23 18:18:50,641 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:18:50 INFO - 2015-11-23 18:18:50,641 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:18:50 INFO - 2015-11-23 18:18:50,641 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3164.098232003879;3244.3511297740456;3284.704376606105;3291.4404551226276;3307.884224052158;5289.68261904286;5418.647787893784;5449.891002179959;5491.148871924853;5492;5437.9939711153365;5466.9179962300595;5543.861403464915;5545.694986775726;5569.637973531718;5015.322931404259;5015.999999999982;5043.167877300241;5063.518965698271;5090.872728181788;4895.608351331903;5077.898442031157;5088.5929125670045;5125.308083408748;5159.716215608159;4927.77824997876;4927.876803079916;4998.175301075318;5014.2979982802435;5048.848534543969;4950.2822090796635;4972.502749725035;4978.178600530944;4993.825216117455;5027.396712394499;4802.735849528274;4935.111679897617;4944.53026962438;4954.0587288415445;5032.6477146599755;5185.662931909414;5286;5338.039152952467;5350.3312085989255;5364.1149210380245;5907.409259074101;5918.644881307136;5921.052631578927;5921.319048309413;5930.229070220844;5853.912191317134;5931.110333449974;5947.791827286024;5948.910766338508;5963.701814909281;5411.864703382407;5512.39363669996;5534.667919924817;5542.251796007568;5544.805931792368;6057.666828324484;6061.363556826558;6091.269939592756;6099.497746808767;6104.755809767559;5847.795327163529;5858.736356863951;5915.438033386821;5915.940840591625;5950.256217972754;5750.079987202028;5807.738651760681;5863.208466857005;5928.0515117581845;5990.041593345044;5915.7633694652595;5925.703714814242;5939.792107276225;5940.762369505258;5950.702464876739;5912.76348946046;5915.3788852170765;5916.230889984275;5916.290045194604;5918.733656985446;4409.1181763646755;4459.977700111479;4508.278675411918;4516.029053753458;4546.045330480636;3994.1612261424843;3994.360902255625;4028.3957406389277;4037.2732908076828;4047.1905618876344;5498.257735205696;5503.449655034545;5505.504504594525;5507.284053073155;5523.944760552424;5836.182934389189;5862.794802181903;5929.703514824328;5964.880702385928;5979;5632.5212356950115;5666;5677.489025987598;5679.261695979496;5679.488846003879;5058.620603454756;5067.695938243717;5074.847754567369;5076.238564215323;5126.615503837227;5995.730192141364;5997.310309314485;6093.055576385667;6096.664683442454;6116.908246376397;5962.105684147413;5968.76124954997;5985.461308482258;5988.8802223956145;5999.070144127667;6169.105479705508;6185.134081228542;6185.165002724574;6186.10301506288;6190.380961903774;5721;5833.445822646841;5851.473367396955;5860.619059761272;5916.083007133901;5837.211976383134;5975.133605627247;5975.731092100953;5979.431953964367;6030.7286172121485;5842.853928651818;5847.8245652630485;5850.034744267318;5850.12248162779;5857.179994800646;5509.146082357241;5631.915521267266;5689.089745640677;5824.097264923944;5840.153177789111;5718.399568045295;5723.284589426322;5728.427157284238;5729.885402291848;5745.8563535911935;5713.428657134419;5814.156947242711;5822.0684690449325;5833.095870140135;5837.0368889132815;5600.60795744294;5601.971990140023;5718.542516598579;5740.569457290803;5745.195672605755 18:18:50 INFO - 2015-11-23 18:18:50,641 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.9002979463697;556.9779454700624;559.9524040456562;579.6029719642048;597.8923793717132;32560.511592326104;33656.15859603508;41164.58835411649;41939.79030104845;42021.36967945483;44381.556184438145;44745;44846;44846.103077938424;44946;7673.309402153805;8836.381453298272;8950.194482496607;8988;9005.054469280729;7805.336546393563;7918.4457088003865;10637.414942178177;10979.066779323766;10995.615153469631;10585.947070264638;10603.522841472113;10711.357318560873;10726.03465688088;10733.355998640107;7898.368130549542;8078.071021832506;10606.363618182895;10707.839382409193;10715.571377144945;10706.839397409045;11004.449777511092;11010.39442830644;11011.83482247767;11016.559337626486;40696;40949.385759213634;41165;41278.79360603208;41343.1731365374;3290.52287418323;3302.9009129725905;3427.605825330094;4082.265192265391;4113.773742444165;30706.692933070608;30999;31155.065348039596;31568.526472102938;32107.51838722421;3928.5678575356687;3939.2909276330247;3978.2242462719782;4043.4945631796027;4121.752694838319;268647;270971;270978.64510677516;271316;272224;56165;57662.7116864413;60048.69975650094;60484.69757651183;60734;56030.719846400505;56294.43705562892;56395.15407268894;56398.71800641053;56585.43414565884;15614.453494127878;15788.131652758979;15794.763078553831;15804;15836.208189590474;11796.46915888787;11852.11109166816;11874.525018999144;11929.403529823474;12038.374819399443;20133.295334663217;20189.394318170478;20324.390268291976;20335.18659253643;20375.59248815045;7883.211678832071;8046.597670116471;8083.03003639567;8128.674853005932;8133.4306598538715;921.5069937583361;1004.9346792458467;1041.2138835179392;1063.7606538528769;1115.1914861725347;29165.270868228465;29327.853360733487;29415.26461838471;29837.40325193484;30381.240468988453;1028.6612481222433;1042.2443728297076;1044.8693913260843;1066.4294602387686;1071.3090056913247;14816.94412917741;14881.255937203097;14995.32521036556;15031.173285469404;15038.32327545263;311794;315326;319118;319505;319980;52906.735466322425;53186.46813531892;53196.46803531992;53196.73401632967;53247.46752532425;1323.8345206849144;1346.5758286139835;1359.9728005439836;1369.5069774881035;1372.1149858341514;27686.307842304104;28464.85767571149;28557.42885142244;28709.138725838257;28831.42337153287;47562.76218618885;47587.52412475831;47709.76145119252;47709.76145119252;47840.76079619719;296047;296743;297272;297633;298378;31040.844795775876;31626.683733162376;31855.522167167048;31958.28354589886;32064.51903221407;43490.34764478472;43804.916082727126;44020.33969490524;44227.33658995053;44740.32889506725;36019.459708103874;36829.26341473102;37200.25599488049;37577.872663820126;37784;35927;36395.27209455849;36820.26359472742;36857.26285474222;37292.627073728916;36133;36473;36533.634663654084;36635.26729465449;37020.629793701715;31953.520697189095;33142.33715325632;33180;33740.83129584337;33849.661503384654;25456.23631291064;25519.234422966598;25661;25876.482470350864;26109.477810444063 18:18:50 INFO - 2015-11-23 18:18:50,641 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.06888195227043;353.8690684446755;359.699650791589;362.3025675574518;362.6899001353842;13191.07662463628;16701.582460438494;17232.224549895236;17811.64376712465;17818.55453613657;16632.25154868031;16979.91510042448;17433.389831355904;17564.912175439105;17612.559686007855;4046.271671099201;4218.409422680827;4219.493660760698;5322.148456247001;5504.036793561131;5784.334801497818;5966.194563733884;6000.249968753906;6003.549733769963;6005.849853753647;5835.44563266489;5878.294604647448;5907.350191478956;5932.021216499273;5940.34656187819;5942.494887934531;6061.060535616986;6065.696715164224;6073.058675905242;6129.417705317987;5307.911878065026;5326.9467305327225;5330.546903513206;5334.866628334284;5344.545713614348;20493.89753051225;20494.282700105574;20553.8972305139;20705;20759.169633214653;2197.967030494544;2201.966970495444;2223.399682085828;2235.955280894373;2347.7534858839745;12438.875611243862;12516.874831251662;12668.303243321614;12868.806967895489;13555.051146419755;1800;1804.3323970131005;1822.4441545328668;1843.603625220584;1911.6176764647125;58532.41467585312;61643.383566164215;61683.38316616866;61890.38109618936;62007.379926200614;10264.332818366782;10312.226583006304;10337.328073675188;10341;10348.120409765104;13383;13417.865821341857;13429.664258393423;13486.730265394637;13488.460461581426;7000.754973576002;7107.6446177690905;7121.608311542811;7145.356917877416;7185.89221161683;6667.366600172976;6671.232808227116;6714.429273511806;6726.865462690719;6740.561863478858;4094.3244364679495;4202.2646036943415;4261.360795880642;4364.345348197796;4396.406485124531;1780.5103596510803;1827.7806663200502;1846.510674671213;1866.915988780508;1881.2569035231281;887.60057973912;890.247740659142;898.1108702384723;990.4008075114596;1040.9011143941314;16134.435294764628;16532.504024879272;16656.500914917717;16816.57958551046;16945.49163525096;884.9380543361902;903.4579252448478;908.0374802709149;927.188709878856;952.0717300631967;9450.57472413743;9563.139317461462;9912.950435247778;9923.40459572428;9965.950170249247;321812;430779;533525;542787;550649;72561.2743872565;72978.27021729821;74439.25560744431;79293.60353198196;83850;1084.0406240477234;1105.1214284643727;1106.7233191702076;1108.0304733358312;1118.3904771899333;12365.876341236832;14435.639109022359;14748.63128421798;14912.776308355167;15271.176963936296;35915.64084359227;35948.64051359453;36123.09692257715;36285;36634.8168259157;44527.55472445234;46120.538794611624;46132.53867461282;46445;46724.76637616926;9090.909090909006;9188.448693078437;9219.124183202584;9293.860592090989;9311.022342653923;13145.868541314465;16394;17479.300827966737;17481.125943703017;17532.82467175312;14120.929395352958;14212.786808197678;14383.137011779327;14628.780568291697;14633;13928.233947133005;14125;14242.359093841009;14303.427862885368;14574;14545.200013998909;14620.85379146195;14657.120572765669;14809;14939.253037347871;9190.21883139914;9196;9213.12475314844;9479.620815167316;9671.806563868542;13087.934560327138;13655.863441365856;13808.240546769623;13893.861061389662;14274.500392486214 18:18:50 INFO - 2015-11-23 18:18:50,641 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1317.756215100207;1684.9326026958922;1720.346268418001;1721.535185499915;1744.5725797179693;6620.668966551677;7385;7530.209328020561;7531.661075251606;7537.057867766529;7357.889631655529;7603.429742769286;7615.657295421705;7626.08486981563;7629.656665450054;1959.0596513673445;2030.604032213719;2033.7356143701297;2257.5146343536094;2284.1434462076722;2041.6325061488926;2283.178055899875;2312.5259321839067;2314.976850231493;2332.603457412244;2193.1665966932624;2217.833662475313;2227.465408302004;2295.7933785959262;2296.689946857178;1979;2015.9193632254692;2231.263682984619;2263.4454558633156;2263.8868056597103;1905.066517406461;1908.5037890148521;1908.570571621374;2249.325202439262;2310.8151347892294;7534.698612055511;7617.885731714029;7626;7629.351505122071;7636.618169091579;4647.372604698357;4726.0784147091335;4727.456342520585;4731.2430011198385;4739.4075740532435;3122.31309111995;3165.5568220449154;3214.5499630051813;3276.8197749123788;3277.901662950115;961.5336561767607;986.6546708651986;994.2394068537575;997.9072915157891;1018.7809620931462;10557.63048293306;10568.788624227473;10583.259171857973;10607;10641.521131549176;4179.2477354076555;4312.5903039211225;4332.155229730172;4337.609615134653;4353.804078816461;9024.413413128257;9042.773930651787;9053.68312109073;9064.274858011344;9067.68263110788;4798.5441383068555;4828.155072862305;4833.685810422382;4833.975830120898;4835.274708793709;4381.255186618282;4384.495782984934;4401.405810215644;4412.4705035395955;4413.095315460387;3556.413191823372;3614.6023937366867;3636.781793092423;3647.94528082079;3667.9633203668154;1220.6033039262097;1224.64485299264;1227.2575092069349;1229.0843321725372;1229.9815502767465;1314.8224989626278;1320.8348956380453;1336.7059246965653;1356.010112617775;1357.9932100339436;7100.893486597705;7168.247334029956;7187.065681461377;7197.964010179916;7201.207867134611;460.5854730742359;467.9321498382715;468.7281376801447;473.1011078949954;481.22042291488015;5310.893782124336;5454.972725136349;5548.72256387179;5608.355039170466;5624.0439125348785;8953.820923581623;9127.589258483384;9145.268378529701;9162.404443711137;9219.354645174773;8931;8990.685326013558;9029.23251523628;9432.056794320513;9448.338616296931;7176.354128128493;7190.96404517974;7274.672639731225;7302.634868256566;7321.450891183183;6938.930610693828;7004.0544526488275;7012.4390048796995;7023.719051237893;7045;7948.443608947318;8244.752657420288;8285.58572071382;8354.665813367397;8368.665253389796;8315.168483151636;8401.747947561584;8435.789105272417;8507.149285071444;8692.739217823475;6801.2858649841055;6862;6867.759628412981;6871.14110736158;6872.587644741331;7228.710851565878;7260.056192694916;7291.890621640786;7300.634968251672;7325.230850760807;6911.5853048817235;6992.650367481708;6999.1950925644205;7090.751823686146;7112.502124851418;6852.657367131524;6857.108575885103;6890.724371025303;6971.79084627462;6993.440524757905;6993.685284162123;7028.543144695578;7074.893876591752;7086.574805511686;7091.716331346688;6308.936910631019;6345.841353966003;6377.7130029147875;6395.072714456471;6407.199100112486;6385.7126429309865;6450.48396128318;6453.774117905851;6455.0317452382515;6457.967710161419 18:18:50 INFO - 2015-11-23 18:18:50,643 DEBUG : BROWSER_OUTPUT: |4;prototype.html;331.39189587107654;331.9618243901952;332.77870216306155;335.87236849997004;337.93410284994434;5950.226470558827;5961.433663801938;5966.105084237367;5966.343702192756;6019.307779605347;5729.140628905666;5755.712214389285;5853.678047707374;5921.230240068785;5928.288605367351;4540.046590216059;4562.452505699304;4585.472670642869;4600.7929643166135;4616.676832621718;4573.062522182944;4586.656000799937;4591.357209990587;4593.127305811901;4598.931016034762;4324.459442569679;4405.867823965286;4433.578810013044;4555.498895121551;4556.521565235652;4529.8641040768825;4540.614047805941;4546.386237857913;4547.045120524694;4553.134904368159;3989.082511022452;3994.4807175067344;3994.560598334181;3996.900077498057;4002.699797515198;5640.2667653205235;5655.462731040545;5658.943410565924;5664.745086471119;5679.488846003879;5055.317532133152;5225.242339860737;5231;5236.581073514109;5237.109691352479;6235.7505699771955;6236.282827474854;6239.095331176999;6243.1883855099;6251.593646412968;4313.654907607384;4314.439122914033;4315.395844581761;4319.870403887889;4321.2653848845775;6337.746490140389;6467.32093130224;6543.149390579194;6544.149260596139;6545.247296560909;4305;4423.314386270134;4427.40230068943;4432.867013989586;4434.778261086997;4478.440194975628;4479.552044795494;4480.215962206601;4482.731036137777;4483.641308695296;5189.273501709764;5194.97402512985;5204;5207.036698210767;5214.32213812202;6166.7224974876235;6292.024736165901;6320.273168585672;6338.429541341301;6342.904856427157;1556.5719427157621;1561.3832536148159;1571.4735563586328;1578.565894379032;1578.6053486628343;1017.531935309751;1031.3502493429241;1040.443362800913;1041.5937784264142;1048.5072016152396;6084.117802918552;6094.908576371358;6095.481884039907;6101.755929762849;6103.572749907464;6477.4170324671;6483.902741458882;6488.28628850826;6499.642519661369;6507.8698426031215;5910.143029260733;6035.185249991283;6065.332813390523;6072.878542429126;6162.753489860445;3527.329807336649;3529.541159649229;3546.4680297955515;3549.7515173937577;3551.8224088795455;6765.458763298924;6772.932270677329;6773.830654233683;6776.2546119926765;6781.287964763629;6569.507286953402;6719.563228390139;6726.596404215763;6732.158480189976;6733.293004234485;6768.492363072789;6773.559718618274;6779.559328643622;6781.287964763629;6796.558223715344;6562.146920900253;6567.868642627025;6570.77002304917;6576.901346479711;6577.704003319958;6313.526485513697;6495.935040649722;6508.902366464412;6509.251436084911;6517.4460170886005;6766.289539598271;6769.763058292936;6769.916813310044;6772.93227067723;6777.085093512313;4428.756418397019;4430.534793846599;4442.800073996613;4444.888877778081;4445.399871017501;6427.871442571216;6518.348165183444;6536.215654121535;6548.574342667712;6553.115329430466;6343.143675603919;6357.93642063592;6367.586106903222;6371.872562548816;6379.840503987438;6338.809835704937;6354.523410744305;6364.681765911779;6367.363263673596;6381.29805721361;6097.359777223505;6244.46922011616;6247.312795592572;6261.968690156702;6265.780697675559;6364.109024736448;6397.936020639921;6401.327860574759;6407.423331900151;6407.71165297572;6235.095911092775;6242.032484964838;6244.531660125418;6251.78118765841;6265.8120256392385 18:18:50 INFO - 2015-11-23 18:18:50,644 DEBUG : BROWSER_OUTPUT: |5;yui.html;744.9962750186248;746.3394895517469;782.8316911863951;798.0662624729065;857.2713193785281;14026.579202623925;14308.856911430883;14339;14352;14431.711365772679;13368.532101376453;13375;14000.509982150626;14627.268636568155;14634.926825365885;798.138010948176;810.4731924249227;810.7932477218301;812.2040400407604;812.8780682897553;669.4945316286197;675.0717763075771;808.2362167751477;817.3257062923083;818.472085504852;840.0297656207091;845.3152946113637;845.5772113943028;846.7332790171076;847.4152834544145;706.2972342519226;711.5588335232189;852.995735021324;853.7524118005801;857.3269983063328;523.7433657507831;627.6328347916474;628.1269036039909;628.8930881750114;629.4932579273683;14324;14373.425062997467;14414.13515189092;14415.063020903608;14415.063020903712;12042.759144817055;12874.485020599164;13049.739005219843;13236.272005039718;13356.933215333958;10514.106300964428;10527.84208236877;10544.947275263574;10756.354618722902;10935.890641093567;3621.2073679021228;3686.4838922550866;3696.815159242054;3730.8321125549146;3809.5999920008276;49769.25346119811;50058.24912626314;50336.74831625855;50351.496485035044;50376.49623503755;10592.364458132382;10820.35077895313;10848.62029828968;10865.239433239598;10868;19549.218031278873;19561.510962226057;19588.804111958983;19661.803381965998;19665.705014424795;7810.062792464827;7852.960735196288;7877.487963282369;8015.879761803578;8025.879611805827;4227.811678325184;4321;4385.210662080793;4427.070315233837;4519.163954668331;3168.081256435654;3181.0774875285906;3194.3611277744544;3207.4707673233656;3215.437298472758;545.8062387852256;561.9072852979212;570.2785975740692;570.9628874123168;582.8775957049068;512.7692538357754;653.167211804943;677.9966100169567;680.9216940051858;721.0986267166043;8314.792130196673;8512.70205542803;8837.160469755363;8935.151160639729;9008.684696035738;618.6473709985355;626.5394934722975;648.9805305840832;649.7238673563717;720.1538192623647;4186.476690413699;4195.223883581547;4301.09676967834;4409.4488188976375;4556.225441674923;56073.43926560764;56193.7190314054;56393.154102688495;56756;60603.69698151569;52115.47884521182;52570.47429525732;53004.20493692598;53031.20453193205;53071.73464132655;47591.5240847594;47878.760606197444;48030.519694802606;48105.27842082441;48623.27065094026;9043.593038313424;9226.9538652309;9233.769155771159;9298.163165315154;9347.112024357675;36849;37444.25111497809;37689;37859.24281514299;38092;43281;43794.56205437905;46829.76585117052;46979.53020469888;47042.52957470382;10775.6228532001;10846.891531084588;11367.958669229174;11492.885071149181;11859.822102668639;12494.312812795384;12507.812382814083;12513.124081314585;13337.266450345323;13348.399322030726;11574.537018519164;11756.118291128028;11764.000059994996;11793.52825886955;12205.450754716237;11257.831132532854;11400.828987565359;12090.214136081127;12339.876601233873;12344.074194435274;7439.404847612286;10365.63720269787;11131.387773672526;11401.372924489233;11582.305061696325;9709.223262139154;9903.158231550111;9948.502574871372;10026.147777438999;10161.339512931636;9699.272554558294;9762.414255144715;9809.85285220708;9835.950820245853;9877.604895804086 18:18:50 INFO - 2015-11-23 18:18:50,644 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:18:50 INFO - 2015-11-23 18:18:50,644 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:18:50 INFO - 2015-11-23 18:18:50,644 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,931 18:18:50 INFO - 2015-11-23 18:18:50,644 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:18:50 INFO - 2015-11-23 18:18:50,644 DEBUG : BROWSER_OUTPUT: __startTimestamp1448331530634__endTimestamp 18:18:50 INFO - 2015-11-23 18:18:50,644 DEBUG : BROWSER_OUTPUT: 18:18:50 INFO - 2015-11-23 18:18:50,646 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:18:50 INFO - 2015-11-23 18:18:50,646 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:18:50 INFO - 2015-11-23 18:18:50,646 DEBUG : BROWSER_OUTPUT: 18:18:50 INFO - 2015-11-23 18:18:50,646 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5486.04 Median:5718.54 stddev:629.86 (11.0%) stddev-sans-first:604.88 18:18:50 INFO - 2015-11-23 18:18:50,646 DEBUG : BROWSER_OUTPUT: Values: 3164.1 3244.4 3284.7 3291.4 3307.9 5289.7 5418.6 5449.9 5491.1 5492.0 5438.0 5466.9 5543.9 5545.7 5569.6 5015.3 5016.0 5043.2 5063.5 5090.9 4895.6 5077.9 5088.6 5125.3 5159.7 4927.8 4927.9 4998.2 5014.3 5048.8 4950.3 4972.5 4978.2 4993.8 5027.4 4802.7 4935.1 4944.5 4954.1 5032.6 5185.7 5286.0 5338.0 5350.3 5364.1 5907.4 5918.6 5921.1 5921.3 5930.2 5853.9 5931.1 5947.8 5948.9 5963.7 5411.9 5512.4 5534.7 5542.3 5544.8 6057.7 6061.4 6091.3 6099.5 6104.8 5847.8 5858.7 5915.4 5915.9 5950.3 5750.1 5807.7 5863.2 5928.1 5990.0 5915.8 5925.7 5939.8 5940.8 5950.7 5912.8 5915.4 5916.2 5916.3 5918.7 4409.1 4460.0 4508.3 4516.0 4546.0 3994.2 3994.4 4028.4 4037.3 4047.2 5498.3 5503.4 5505.5 5507.3 5523.9 5836.2 5862.8 5929.7 5964.9 5979.0 5632.5 5666.0 5677.5 5679.3 5679.5 5058.6 5067.7 5074.8 5076.2 5126.6 5995.7 5997.3 6093.1 6096.7 6116.9 5962.1 5968.8 5985.5 5988.9 5999.1 6169.1 6185.1 6185.2 6186.1 6190.4 5721.0 5833.4 5851.5 5860.6 5916.1 5837.2 5975.1 5975.7 5979.4 6030.7 5842.9 5847.8 5850.0 5850.1 5857.2 5509.1 5631.9 5689.1 5824.1 5840.2 5718.4 5723.3 5728.4 5729.9 5745.9 5713.4 5814.2 5822.1 5833.1 5837.0 5600.6 5602.0 5718.5 5740.6 5745.2 18:18:50 INFO - 2015-11-23 18:18:50,646 DEBUG : BROWSER_OUTPUT: 18:18:50 INFO - 2015-11-23 18:18:50,646 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47000.13 Median:32334.01 stddev:77087.45 (238.4%) stddev-sans-first:77224.82 18:18:50 INFO - 2015-11-23 18:18:50,646 DEBUG : BROWSER_OUTPUT: Values: 553.9 557.0 560.0 579.6 597.9 32560.5 33656.2 41164.6 41939.8 42021.4 44381.6 44745.0 44846.0 44846.1 44946.0 7673.3 8836.4 8950.2 8988.0 9005.1 7805.3 7918.4 10637.4 10979.1 10995.6 10585.9 10603.5 10711.4 10726.0 10733.4 7898.4 8078.1 10606.4 10707.8 10715.6 10706.8 11004.4 11010.4 11011.8 11016.6 40696.0 40949.4 41165.0 41278.8 41343.2 3290.5 3302.9 3427.6 4082.3 4113.8 30706.7 30999.0 31155.1 31568.5 32107.5 3928.6 3939.3 3978.2 4043.5 4121.8 268647.0 270971.0 270978.6 271316.0 272224.0 56165.0 57662.7 60048.7 60484.7 60734.0 56030.7 56294.4 56395.2 56398.7 56585.4 15614.5 15788.1 15794.8 15804.0 15836.2 11796.5 11852.1 11874.5 11929.4 12038.4 20133.3 20189.4 20324.4 20335.2 20375.6 7883.2 8046.6 8083.0 8128.7 8133.4 921.5 1004.9 1041.2 1063.8 1115.2 29165.3 29327.9 29415.3 29837.4 30381.2 1028.7 1042.2 1044.9 1066.4 1071.3 14816.9 14881.3 14995.3 15031.2 15038.3 311794.0 315326.0 319118.0 319505.0 319980.0 52906.7 53186.5 53196.5 53196.7 53247.5 1323.8 1346.6 1360.0 1369.5 1372.1 27686.3 28464.9 28557.4 28709.1 28831.4 47562.8 47587.5 47709.8 47709.8 47840.8 296047.0 296743.0 297272.0 297633.0 298378.0 31040.8 31626.7 31855.5 31958.3 32064.5 43490.3 43804.9 44020.3 44227.3 44740.3 36019.5 36829.3 37200.3 37577.9 37784.0 35927.0 36395.3 36820.3 36857.3 37292.6 36133.0 36473.0 36533.6 36635.3 37020.6 31953.5 33142.3 33180.0 33740.8 33849.7 25456.2 25519.2 25661.0 25876.5 26109.5 18:18:50 INFO - 2015-11-23 18:18:50,646 DEBUG : BROWSER_OUTPUT: 18:18:50 INFO - 2015-11-23 18:18:50,646 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27078.63 Median:35932.14 stddev:79199.34 (220.4%) stddev-sans-first:79396.07 18:18:50 INFO - 2015-11-23 18:18:50,646 DEBUG : BROWSER_OUTPUT: Values: 341.1 353.9 359.7 362.3 362.7 13191.1 16701.6 17232.2 17811.6 17818.6 16632.3 16979.9 17433.4 17564.9 17612.6 4046.3 4218.4 4219.5 5322.1 5504.0 5784.3 5966.2 6000.2 6003.5 6005.8 5835.4 5878.3 5907.4 5932.0 5940.3 5942.5 6061.1 6065.7 6073.1 6129.4 5307.9 5326.9 5330.5 5334.9 5344.5 20493.9 20494.3 20553.9 20705.0 20759.2 2198.0 2202.0 2223.4 2236.0 2347.8 12438.9 12516.9 12668.3 12868.8 13555.1 1800.0 1804.3 1822.4 1843.6 1911.6 58532.4 61643.4 61683.4 61890.4 62007.4 10264.3 10312.2 10337.3 10341.0 10348.1 13383.0 13417.9 13429.7 13486.7 13488.5 7000.8 7107.6 7121.6 7145.4 7185.9 6667.4 6671.2 6714.4 6726.9 6740.6 4094.3 4202.3 4261.4 4364.3 4396.4 1780.5 1827.8 1846.5 1866.9 1881.3 887.6 890.2 898.1 990.4 1040.9 16134.4 16532.5 16656.5 16816.6 16945.5 884.9 903.5 908.0 927.2 952.1 9450.6 9563.1 9913.0 9923.4 9966.0 321812.0 430779.0 533525.0 542787.0 550649.0 72561.3 72978.3 74439.3 79293.6 83850.0 1084.0 1105.1 1106.7 1108.0 1118.4 12365.9 14435.6 14748.6 14912.8 15271.2 35915.6 35948.6 36123.1 36285.0 36634.8 44527.6 46120.5 46132.5 46445.0 46724.8 9090.9 9188.4 9219.1 9293.9 9311.0 13145.9 16394.0 17479.3 17481.1 17532.8 14120.9 14212.8 14383.1 14628.8 14633.0 13928.2 14125.0 14242.4 14303.4 14574.0 14545.2 14620.9 14657.1 14809.0 14939.3 9190.2 9196.0 9213.1 9479.6 9671.8 13087.9 13655.9 13808.2 13893.9 14274.5 18:18:50 INFO - 2015-11-23 18:18:50,646 DEBUG : BROWSER_OUTPUT: 18:18:50 INFO - 2015-11-23 18:18:50,647 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5377.06 Median:6401.14 stddev:2791.96 (43.6%) stddev-sans-first:2783.12 18:18:50 INFO - 2015-11-23 18:18:50,648 DEBUG : BROWSER_OUTPUT: Values: 1317.8 1684.9 1720.3 1721.5 1744.6 6620.7 7385.0 7530.2 7531.7 7537.1 7357.9 7603.4 7615.7 7626.1 7629.7 1959.1 2030.6 2033.7 2257.5 2284.1 2041.6 2283.2 2312.5 2315.0 2332.6 2193.2 2217.8 2227.5 2295.8 2296.7 1979.0 2015.9 2231.3 2263.4 2263.9 1905.1 1908.5 1908.6 2249.3 2310.8 7534.7 7617.9 7626.0 7629.4 7636.6 4647.4 4726.1 4727.5 4731.2 4739.4 3122.3 3165.6 3214.5 3276.8 3277.9 961.5 986.7 994.2 997.9 1018.8 10557.6 10568.8 10583.3 10607.0 10641.5 4179.2 4312.6 4332.2 4337.6 4353.8 9024.4 9042.8 9053.7 9064.3 9067.7 4798.5 4828.2 4833.7 4834.0 4835.3 4381.3 4384.5 4401.4 4412.5 4413.1 3556.4 3614.6 3636.8 3647.9 3668.0 1220.6 1224.6 1227.3 1229.1 1230.0 1314.8 1320.8 1336.7 1356.0 1358.0 7100.9 7168.2 7187.1 7198.0 7201.2 460.6 467.9 468.7 473.1 481.2 5310.9 5455.0 5548.7 5608.4 5624.0 8953.8 9127.6 9145.3 9162.4 9219.4 8931.0 8990.7 9029.2 9432.1 9448.3 7176.4 7191.0 7274.7 7302.6 7321.5 6938.9 7004.1 7012.4 7023.7 7045.0 7948.4 8244.8 8285.6 8354.7 8368.7 8315.2 8401.7 8435.8 8507.1 8692.7 6801.3 6862.0 6867.8 6871.1 6872.6 7228.7 7260.1 7291.9 7300.6 7325.2 6911.6 6992.7 6999.2 7090.8 7112.5 6852.7 6857.1 6890.7 6971.8 6993.4 6993.7 7028.5 7074.9 7086.6 7091.7 6308.9 6345.8 6377.7 6395.1 6407.2 6385.7 6450.5 6453.8 6455.0 6458.0 18:18:50 INFO - 2015-11-23 18:18:50,648 DEBUG : BROWSER_OUTPUT: 18:18:50 INFO - 2015-11-23 18:18:50,648 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5277.28 Median:6027.25 stddev:1603.28 (26.6%) stddev-sans-first:1564.21 18:18:50 INFO - 2015-11-23 18:18:50,648 DEBUG : BROWSER_OUTPUT: Values: 331.4 332.0 332.8 335.9 337.9 5950.2 5961.4 5966.1 5966.3 6019.3 5729.1 5755.7 5853.7 5921.2 5928.3 4540.0 4562.5 4585.5 4600.8 4616.7 4573.1 4586.7 4591.4 4593.1 4598.9 4324.5 4405.9 4433.6 4555.5 4556.5 4529.9 4540.6 4546.4 4547.0 4553.1 3989.1 3994.5 3994.6 3996.9 4002.7 5640.3 5655.5 5658.9 5664.7 5679.5 5055.3 5225.2 5231.0 5236.6 5237.1 6235.8 6236.3 6239.1 6243.2 6251.6 4313.7 4314.4 4315.4 4319.9 4321.3 6337.7 6467.3 6543.1 6544.1 6545.2 4305.0 4423.3 4427.4 4432.9 4434.8 4478.4 4479.6 4480.2 4482.7 4483.6 5189.3 5195.0 5204.0 5207.0 5214.3 6166.7 6292.0 6320.3 6338.4 6342.9 1556.6 1561.4 1571.5 1578.6 1578.6 1017.5 1031.4 1040.4 1041.6 1048.5 6084.1 6094.9 6095.5 6101.8 6103.6 6477.4 6483.9 6488.3 6499.6 6507.9 5910.1 6035.2 6065.3 6072.9 6162.8 3527.3 3529.5 3546.5 3549.8 3551.8 6765.5 6772.9 6773.8 6776.3 6781.3 6569.5 6719.6 6726.6 6732.2 6733.3 6768.5 6773.6 6779.6 6781.3 6796.6 6562.1 6567.9 6570.8 6576.9 6577.7 6313.5 6495.9 6508.9 6509.3 6517.4 6766.3 6769.8 6769.9 6772.9 6777.1 4428.8 4430.5 4442.8 4444.9 4445.4 6427.9 6518.3 6536.2 6548.6 6553.1 6343.1 6357.9 6367.6 6371.9 6379.8 6338.8 6354.5 6364.7 6367.4 6381.3 6097.4 6244.5 6247.3 6262.0 6265.8 6364.1 6397.9 6401.3 6407.4 6407.7 6235.1 6242.0 6244.5 6251.8 6265.8 18:18:50 INFO - 2015-11-23 18:18:50,648 DEBUG : BROWSER_OUTPUT: 18:18:50 INFO - 2015-11-23 18:18:50,648 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14275.09 Median:47317.03 stddev:16376.76 (34.6%) stddev-sans-first:16391.18 18:18:50 INFO - 2015-11-23 18:18:50,648 DEBUG : BROWSER_OUTPUT: Values: 745.0 746.3 782.8 798.1 857.3 14026.6 14308.9 14339.0 14352.0 14431.7 13368.5 13375.0 14000.5 14627.3 14634.9 798.1 810.5 810.8 812.2 812.9 669.5 675.1 808.2 817.3 818.5 840.0 845.3 845.6 846.7 847.4 706.3 711.6 853.0 853.8 857.3 523.7 627.6 628.1 628.9 629.5 14324.0 14373.4 14414.1 14415.1 14415.1 12042.8 12874.5 13049.7 13236.3 13356.9 10514.1 10527.8 10544.9 10756.4 10935.9 3621.2 3686.5 3696.8 3730.8 3809.6 49769.3 50058.2 50336.7 50351.5 50376.5 10592.4 10820.4 10848.6 10865.2 10868.0 19549.2 19561.5 19588.8 19661.8 19665.7 7810.1 7853.0 7877.5 8015.9 8025.9 4227.8 4321.0 4385.2 4427.1 4519.2 3168.1 3181.1 3194.4 3207.5 3215.4 545.8 561.9 570.3 571.0 582.9 512.8 653.2 678.0 680.9 721.1 8314.8 8512.7 8837.2 8935.2 9008.7 618.6 626.5 649.0 649.7 720.2 4186.5 4195.2 4301.1 4409.4 4556.2 56073.4 56193.7 56393.2 56756.0 60603.7 52115.5 52570.5 53004.2 53031.2 53071.7 47591.5 47878.8 48030.5 48105.3 48623.3 9043.6 9227.0 9233.8 9298.2 9347.1 36849.0 37444.3 37689.0 37859.2 38092.0 43281.0 43794.6 46829.8 46979.5 47042.5 10775.6 10846.9 11368.0 11492.9 11859.8 12494.3 12507.8 12513.1 13337.3 13348.4 11574.5 11756.1 11764.0 11793.5 12205.5 11257.8 11400.8 12090.2 12339.9 12344.1 7439.4 10365.6 11131.4 11401.4 11582.3 9709.2 9903.2 9948.5 10026.1 10161.3 9699.3 9762.4 9809.9 9836.0 9877.6 18:18:50 INFO - 2015-11-23 18:18:50,648 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:18:50 INFO - 2015-11-23 18:18:50,648 DEBUG : BROWSER_OUTPUT: 18:18:51 INFO - 2015-11-23 18:18:51,376 INFO : Browser exited with error code: 0 18:18:51 INFO - 2015-11-23 18:18:51,392 INFO : Completed test dromaeo_css (00:18:34) 18:18:51 INFO - 2015-11-23 18:18:51,392 INFO : Starting test kraken 18:18:51 INFO - 2015-11-23 18:18:51,392 DEBUG : operating with platform_type : linux_ 18:18:51 INFO - 2015-11-23 18:18:51,392 INFO : Initialising browser for kraken test... 18:18:51 INFO - 2015-11-23 18:18:51,399 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4F8rwv/profile http://localhost:60244/getInfo.html 18:18:55 INFO - 2015-11-23 18:18:55,175 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:18:55 INFO - 2015-11-23 18:18:55,176 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:18:55 INFO - 2015-11-23 18:18:55,176 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:18:55 INFO - 2015-11-23 18:18:55,176 DEBUG : BROWSER_OUTPUT: __metrics 18:18:55 INFO - 2015-11-23 18:18:55,317 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:18:56 INFO - 2015-11-23 18:18:56,518 INFO : Browser initialized. 18:18:56 INFO - 2015-11-23 18:18:56,518 INFO : Running cycle 1/1 for kraken test... 18:18:56 INFO - 2015-11-23 18:18:56,518 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4F8rwv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:19:08 INFO - 2015-11-23 18:19:08,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 140263424 18:19:08 INFO - 2015-11-23 18:19:08,360 DEBUG : BROWSER_OUTPUT: 18:19:10 INFO - 2015-11-23 18:19:10,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60244/tests/kraken/driver.html?testName=audio-beat-detection) 18:19:11 INFO - 2015-11-23 18:19:11,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 178843648 18:19:11 INFO - 2015-11-23 18:19:11,397 DEBUG : BROWSER_OUTPUT: 18:19:13 INFO - 2015-11-23 18:19:13,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60244/tests/kraken/driver.html?testName=audio-dft) 18:19:14 INFO - 2015-11-23 18:19:14,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 170020864 18:19:14 INFO - 2015-11-23 18:19:14,549 DEBUG : BROWSER_OUTPUT: 18:19:17 INFO - 2015-11-23 18:19:17,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60244/tests/kraken/driver.html?testName=audio-fft) 18:19:17 INFO - 2015-11-23 18:19:17,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 152580096 18:19:17 INFO - 2015-11-23 18:19:17,941 DEBUG : BROWSER_OUTPUT: 18:19:19 INFO - 2015-11-23 18:19:19,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60244/tests/kraken/driver.html?testName=audio-oscillator) 18:19:20 INFO - 2015-11-23 18:19:20,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 153747456 18:19:20 INFO - 2015-11-23 18:19:20,480 DEBUG : BROWSER_OUTPUT: 18:19:22 INFO - 2015-11-23 18:19:22,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:19:23 INFO - 2015-11-23 18:19:23,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 155566080 18:19:23 INFO - 2015-11-23 18:19:23,201 DEBUG : BROWSER_OUTPUT: 18:19:26 INFO - 2015-11-23 18:19:26,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60244/tests/kraken/driver.html?testName=imaging-darkroom) 18:19:26 INFO - 2015-11-23 18:19:26,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 154963968 18:19:26 INFO - 2015-11-23 18:19:26,638 DEBUG : BROWSER_OUTPUT: 18:19:29 INFO - 2015-11-23 18:19:29,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60244/tests/kraken/driver.html?testName=imaging-desaturate) 18:19:30 INFO - 2015-11-23 18:19:30,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 156012544 18:19:30 INFO - 2015-11-23 18:19:30,553 DEBUG : BROWSER_OUTPUT: 18:19:33 INFO - 2015-11-23 18:19:33,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60244/tests/kraken/driver.html?testName=json-parse-financial) 18:19:33 INFO - 2015-11-23 18:19:33,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 157876224 18:19:33 INFO - 2015-11-23 18:19:33,878 DEBUG : BROWSER_OUTPUT: 18:19:35 INFO - 2015-11-23 18:19:35,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:19:35 INFO - 2015-11-23 18:19:35,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 170737664 18:19:35 INFO - 2015-11-23 18:19:35,989 DEBUG : BROWSER_OUTPUT: 18:19:37 INFO - 2015-11-23 18:19:37,771 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60244/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:19:38 INFO - 2015-11-23 18:19:38,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 168448000 18:19:38 INFO - 2015-11-23 18:19:38,365 DEBUG : BROWSER_OUTPUT: 18:19:40 INFO - 2015-11-23 18:19:40,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:19:40 INFO - 2015-11-23 18:19:40,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 177618944 18:19:40 INFO - 2015-11-23 18:19:40,984 DEBUG : BROWSER_OUTPUT: 18:19:43 INFO - 2015-11-23 18:19:43,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:19:43 INFO - 2015-11-23 18:19:43,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 183369728 18:19:43 INFO - 2015-11-23 18:19:43,963 DEBUG : BROWSER_OUTPUT: 18:19:46 INFO - 2015-11-23 18:19:46,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:19:47 INFO - 2015-11-23 18:19:47,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 181673984 18:19:47 INFO - 2015-11-23 18:19:47,063 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60244/tests/kraken/driver.html?testName=ai-astar) 18:19:48 INFO - 2015-11-23 18:19:48,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 240390144 18:19:48 INFO - 2015-11-23 18:19:48,971 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,971 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:19:48 INFO - 2015-11-23 18:19:48,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:19:48 INFO - 2015-11-23 18:19:48,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:19:48 INFO - 2015-11-23 18:19:48,971 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:19:48 INFO - 2015-11-23 18:19:48,971 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;104;109;109;109;99;111;110;101 18:19:48 INFO - 2015-11-23 18:19:48,971 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;132;148;165;126;151;157;124;170;125 18:19:48 INFO - 2015-11-23 18:19:48,972 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;163;160;159;158;160;164;159;160 18:19:48 INFO - 2015-11-23 18:19:48,972 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;88;94;71;71;71;107;89;71 18:19:48 INFO - 2015-11-23 18:19:48,972 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;136;92;93;92;137;92;93;136 18:19:48 INFO - 2015-11-23 18:19:48,972 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;111;111;110;109;109;109;109 18:19:48 INFO - 2015-11-23 18:19:48,972 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;145;145;145;145;146;146;144;145 18:19:48 INFO - 2015-11-23 18:19:48,972 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;95;96;96;97;96;95 18:19:48 INFO - 2015-11-23 18:19:48,972 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;58;58;60;60;58;60;58;57 18:19:48 INFO - 2015-11-23 18:19:48,972 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;69;68;69;69;69 18:19:48 INFO - 2015-11-23 18:19:48,972 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;84;85;84;93;84;84;84;85 18:19:48 INFO - 2015-11-23 18:19:48,972 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;130;120;113;136;118;122;125;115;122 18:19:48 INFO - 2015-11-23 18:19:48,972 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;150;157;146;149;138;148;148;148;139 18:19:48 INFO - 2015-11-23 18:19:48,972 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;65;68;66;70;66;65;64;65 18:19:48 INFO - 2015-11-23 18:19:48,973 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:19:48 INFO - 2015-11-23 18:19:48,973 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:19:48 INFO - 2015-11-23 18:19:48,973 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,897 18:19:48 INFO - 2015-11-23 18:19:48,973 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:19:48 INFO - 2015-11-23 18:19:48,973 DEBUG : BROWSER_OUTPUT: __startTimestamp1448331588965__endTimestamp 18:19:48 INFO - 2015-11-23 18:19:48,973 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,973 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:19:48 INFO - 2015-11-23 18:19:48,973 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:19:48 INFO - 2015-11-23 18:19:48,973 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,973 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.90 Median:109.00 stddev:4.09 (3.8%) stddev-sans-first:4.32 18:19:48 INFO - 2015-11-23 18:19:48,973 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 104.0 109.0 109.0 109.0 99.0 111.0 110.0 101.0 18:19:48 INFO - 2015-11-23 18:19:48,973 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,974 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.10 Median:152.00 stddev:17.16 (11.3%) stddev-sans-first:17.96 18:19:48 INFO - 2015-11-23 18:19:48,974 DEBUG : BROWSER_OUTPUT: Values: 153.0 132.0 148.0 165.0 126.0 151.0 157.0 124.0 170.0 125.0 18:19:48 INFO - 2015-11-23 18:19:48,974 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,974 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.83 (1.1%) stddev-sans-first:1.94 18:19:48 INFO - 2015-11-23 18:19:48,975 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 163.0 160.0 159.0 158.0 160.0 164.0 159.0 160.0 18:19:48 INFO - 2015-11-23 18:19:48,975 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,975 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.50 Median:71.50 stddev:13.07 (18.3%) stddev-sans-first:13.40 18:19:48 INFO - 2015-11-23 18:19:48,975 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 88.0 94.0 71.0 71.0 71.0 107.0 89.0 71.0 18:19:48 INFO - 2015-11-23 18:19:48,975 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,975 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:92.00 stddev:21.21 (23.1%) stddev-sans-first:21.92 18:19:48 INFO - 2015-11-23 18:19:48,975 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 136.0 92.0 93.0 92.0 137.0 92.0 93.0 136.0 18:19:48 INFO - 2015-11-23 18:19:48,975 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,976 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:109.50 stddev:0.84 (0.8%) stddev-sans-first:0.88 18:19:48 INFO - 2015-11-23 18:19:48,976 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 111.0 111.0 110.0 109.0 109.0 109.0 109.0 18:19:48 INFO - 2015-11-23 18:19:48,976 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,976 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 18:19:48 INFO - 2015-11-23 18:19:48,976 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 145.0 145.0 145.0 145.0 146.0 146.0 144.0 145.0 18:19:48 INFO - 2015-11-23 18:19:48,976 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,976 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 18:19:48 INFO - 2015-11-23 18:19:48,976 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 97.0 96.0 95.0 18:19:48 INFO - 2015-11-23 18:19:48,976 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,976 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.00 stddev:1.08 (1.9%) stddev-sans-first:1.13 18:19:48 INFO - 2015-11-23 18:19:48,976 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 58.0 58.0 60.0 60.0 58.0 60.0 58.0 57.0 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 69.0 68.0 69.0 69.0 69.0 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.00 stddev:2.81 (3.3%) stddev-sans-first:2.95 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 84.0 85.0 84.0 93.0 84.0 84.0 84.0 85.0 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:122.00 stddev:6.85 (5.6%) stddev-sans-first:7.23 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: Values: 120.0 130.0 120.0 113.0 136.0 118.0 122.0 125.0 115.0 122.0 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:148.00 stddev:5.72 (3.9%) stddev-sans-first:5.72 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: Values: 141.0 150.0 157.0 146.0 149.0 138.0 148.0 148.0 148.0 139.0 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.73 (2.6%) stddev-sans-first:1.83 18:19:48 INFO - 2015-11-23 18:19:48,977 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 65.0 68.0 66.0 70.0 66.0 65.0 64.0 65.0 18:19:48 INFO - 2015-11-23 18:19:48,978 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:19:48 INFO - 2015-11-23 18:19:48,978 DEBUG : BROWSER_OUTPUT: 18:19:49 INFO - 2015-11-23 18:19:49,876 INFO : Browser exited with error code: 0 18:19:49 INFO - 2015-11-23 18:19:49,927 INFO : Completed test kraken (00:00:58) 18:19:49 INFO - 2015-11-23 18:19:49,927 INFO : Starting test v8_7 18:19:49 INFO - 2015-11-23 18:19:49,927 DEBUG : operating with platform_type : linux_ 18:19:49 INFO - 2015-11-23 18:19:49,927 INFO : Initialising browser for v8_7 test... 18:19:49 INFO - 2015-11-23 18:19:49,933 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxEbIQd/profile http://localhost:60244/getInfo.html 18:19:53 INFO - 2015-11-23 18:19:53,989 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:19:53 INFO - 2015-11-23 18:19:53,990 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:19:53 INFO - 2015-11-23 18:19:53,990 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:19:53 INFO - 2015-11-23 18:19:53,990 DEBUG : BROWSER_OUTPUT: __metrics 18:19:54 INFO - 2015-11-23 18:19:54,086 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:19:55 INFO - 2015-11-23 18:19:55,503 INFO : Browser initialized. 18:19:55 INFO - 2015-11-23 18:19:55,504 INFO : Running cycle 1/1 for v8_7 test... 18:19:55 INFO - 2015-11-23 18:19:55,504 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxEbIQd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:20:07 INFO - 2015-11-23 18:20:07,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 139927552 18:20:07 INFO - 2015-11-23 18:20:07,335 DEBUG : BROWSER_OUTPUT: 18:20:28 INFO - 2015-11-23 18:20:28,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60244/tests/v8_7/run.html (next: http://localhost:60244/tests/v8_7/run.html) 18:20:29 INFO - 2015-11-23 18:20:29,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 620277760 18:20:29 INFO - 2015-11-23 18:20:29,021 DEBUG : BROWSER_OUTPUT: 18:20:29 INFO - 2015-11-23 18:20:29,021 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:20:29 INFO - 2015-11-23 18:20:29,021 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:20:29 INFO - 2015-11-23 18:20:29,021 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:20:29 INFO - 2015-11-23 18:20:29,021 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:20:29 INFO - 2015-11-23 18:20:29,021 DEBUG : BROWSER_OUTPUT: |0;Richards;189.60940462646948 18:20:29 INFO - 2015-11-23 18:20:29,021 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.43904335990666 18:20:29 INFO - 2015-11-23 18:20:29,022 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.4950213371266 18:20:29 INFO - 2015-11-23 18:20:29,022 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 18:20:29 INFO - 2015-11-23 18:20:29,022 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1953.125 18:20:29 INFO - 2015-11-23 18:20:29,022 DEBUG : BROWSER_OUTPUT: |5;Earley;780.64012490242 18:20:29 INFO - 2015-11-23 18:20:29,022 DEBUG : BROWSER_OUTPUT: |6;Boyer;12072.289156626506 18:20:29 INFO - 2015-11-23 18:20:29,022 DEBUG : BROWSER_OUTPUT: |7;RegExp;25350 18:20:29 INFO - 2015-11-23 18:20:29,023 DEBUG : BROWSER_OUTPUT: |8;Splay;648.0881399870383 18:20:29 INFO - 2015-11-23 18:20:29,023 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 18:20:29 INFO - 2015-11-23 18:20:29,023 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:20:29 INFO - 2015-11-23 18:20:29,023 DEBUG : BROWSER_OUTPUT: __startTimestamp1448331629020__endTimestamp 18:20:29 INFO - 2015-11-23 18:20:29,023 DEBUG : BROWSER_OUTPUT: 18:20:29 INFO - 2015-11-23 18:20:29,024 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:20:29 INFO - 2015-11-23 18:20:29,024 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:20:29 INFO - 2015-11-23 18:20:29,024 DEBUG : BROWSER_OUTPUT: 18:20:29 INFO - 2015-11-23 18:20:29,024 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.61 Median:189.61 stddev:0.00 (0.0%) 18:20:29 INFO - 2015-11-23 18:20:29,024 DEBUG : BROWSER_OUTPUT: Values: 189.6 18:20:29 INFO - 2015-11-23 18:20:29,025 DEBUG : BROWSER_OUTPUT: 18:20:29 INFO - 2015-11-23 18:20:29,025 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.44 Median:194.44 stddev:0.00 (0.0%) 18:20:29 INFO - 2015-11-23 18:20:29,025 DEBUG : BROWSER_OUTPUT: Values: 194.4 18:20:29 INFO - 2015-11-23 18:20:29,025 DEBUG : BROWSER_OUTPUT: 18:20:29 INFO - 2015-11-23 18:20:29,025 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.50 Median:284.50 stddev:0.00 (0.0%) 18:20:29 INFO - 2015-11-23 18:20:29,025 DEBUG : BROWSER_OUTPUT: Values: 284.5 18:20:29 INFO - 2015-11-23 18:20:29,026 DEBUG : BROWSER_OUTPUT: 18:20:29 INFO - 2015-11-23 18:20:29,026 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 18:20:29 INFO - 2015-11-23 18:20:29,026 DEBUG : BROWSER_OUTPUT: Values: 5000.0 18:20:29 INFO - 2015-11-23 18:20:29,026 DEBUG : BROWSER_OUTPUT: 18:20:29 INFO - 2015-11-23 18:20:29,026 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1953.13 Median:1953.13 stddev:0.00 (0.0%) 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: Values: 1953.1 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:780.64 Median:780.64 stddev:0.00 (0.0%) 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: Values: 780.6 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12072.29 Median:12072.29 stddev:0.00 (0.0%) 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: Values: 12072.3 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25350.00 Median:25350.00 stddev:0.00 (0.0%) 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: Values: 25350.0 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:648.09 Median:648.09 stddev:0.00 (0.0%) 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: Values: 648.1 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 18:20:29 INFO - 2015-11-23 18:20:29,028 DEBUG : BROWSER_OUTPUT: Values: 4850.2 18:20:29 INFO - 2015-11-23 18:20:29,029 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:20:29 INFO - 2015-11-23 18:20:29,029 DEBUG : BROWSER_OUTPUT: 18:20:29 INFO - 2015-11-23 18:20:29,828 INFO : Browser exited with error code: 0 18:20:29 INFO - 2015-11-23 18:20:29,847 INFO : Completed test v8_7 (00:00:39) 18:20:30 INFO - 2015-11-23 18:20:30,020 INFO : Completed test suite (00:20:13) 18:20:30 INFO - 2015-11-23 18:20:30,021 DEBUG : Working with test: dromaeo_css 18:20:30 INFO - 2015-11-23 18:20:30,021 DEBUG : Generating results file: dromaeo_css 18:20:30 INFO - 2015-11-23 18:20:30,022 DEBUG : Working with test: kraken 18:20:30 INFO - 2015-11-23 18:20:30,022 DEBUG : Generating results file: kraken 18:20:30 INFO - 2015-11-23 18:20:30,022 INFO : javascript benchmark 18:20:30 INFO - 2015-11-23 18:20:30,022 DEBUG : Working with test: v8_7 18:20:30 INFO - 2015-11-23 18:20:30,022 DEBUG : Generating results file: v8_7 18:20:30 INFO - 2015-11-23 18:20:30,023 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:20:30 INFO - 2015-11-23 18:20:30,150 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 18:20:30 INFO - 2015-11-23 18:20:30,150 DEBUG : process_Request line: dromaeo_css 7056.01 graph.html#tests=[[72,1,35]] 18:20:30 INFO - 2015-11-23 18:20:30,150 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:20:30 INFO - 2015-11-23 18:20:30,252 DEBUG : process_Request line: kraken 1495.90 graph.html#tests=[[232,1,35]] 18:20:30 INFO - 2015-11-23 18:20:30,252 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:20:30 INFO - 2015-11-23 18:20:30,357 DEBUG : process_Request line: v8_7 19532.00 graph.html#tests=[[230,1,35]] 18:20:30 INFO - 2015-11-23 18:20:30,359 INFO : javascript benchmark 18:20:30 INFO - 2015-11-23 18:20:30,362 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3164.098232003879, 3244.3511297740456, 3284.704376606105, 3291.4404551226276, 3307.884224052158, 5289.68261904286, 5418.647787893784, 5449.891002179959, 5491.148871924853, 5492.0, 5437.9939711153365, 5466.9179962300595, 5543.861403464915, 5545.694986775726, 5569.637973531718, 5015.322931404259, 5015.999999999982, 5043.167877300241, 5063.518965698271, 5090.872728181788, 4895.608351331903, 5077.898442031157, 5088.5929125670045, 5125.308083408748, 5159.716215608159, 4927.77824997876, 4927.876803079916, 4998.175301075318, 5014.2979982802435, 5048.848534543969, 4950.2822090796635, 4972.502749725035, 4978.178600530944, 4993.825216117455, 5027.396712394499, 4802.735849528274, 4935.111679897617, 4944.53026962438, 4954.0587288415445, 5032.6477146599755, 5185.662931909414, 5286.0, 5338.039152952467, 5350.3312085989255, 5364.1149210380245, 5907.409259074101, 5918.644881307136, 5921.052631578927, 5921.319048309413, 5930.229070220844, 5853.912191317134, 5931.110333449974, 5947.791827286024, 5948.910766338508, 5963.701814909281, 5411.864703382407, 5512.39363669996, 5534.667919924817, 5542.251796007568, 5544.805931792368, 6057.666828324484, 6061.363556826558, 6091.269939592756, 6099.497746808767, 6104.755809767559, 5847.795327163529, 5858.736356863951, 5915.438033386821, 5915.940840591625, 5950.256217972754, 5750.079987202028, 5807.738651760681, 5863.208466857005, 5928.0515117581845, 5990.041593345044, 5915.7633694652595, 5925.703714814242, 5939.792107276225, 5940.762369505258, 5950.702464876739, 5912.76348946046, 5915.3788852170765, 5916.230889984275, 5916.290045194604, 5918.733656985446, 4409.1181763646755, 4459.977700111479, 4508.278675411918, 4516.029053753458, 4546.045330480636, 3994.1612261424843, 3994.360902255625, 4028.3957406389277, 4037.2732908076828, 4047.1905618876344, 5498.257735205696, 5503.449655034545, 5505.504504594525, 5507.284053073155, 5523.944760552424, 5836.182934389189, 5862.794802181903, 5929.703514824328, 5964.880702385928, 5979.0, 5632.5212356950115, 5666.0, 5677.489025987598, 5679.261695979496, 5679.488846003879, 5058.620603454756, 5067.695938243717, 5074.847754567369, 5076.238564215323, 5126.615503837227, 5995.730192141364, 5997.310309314485, 6093.055576385667, 6096.664683442454, 6116.908246376397, 5962.105684147413, 5968.76124954997, 5985.461308482258, 5988.8802223956145, 5999.070144127667, 6169.105479705508, 6185.134081228542, 6185.165002724574, 6186.10301506288, 6190.380961903774, 5721.0, 5833.445822646841, 5851.473367396955, 5860.619059761272, 5916.083007133901, 5837.211976383134, 5975.133605627247, 5975.731092100953, 5979.431953964367, 6030.7286172121485, 5842.853928651818, 5847.8245652630485, 5850.034744267318, 5850.12248162779, 5857.179994800646, 5509.146082357241, 5631.915521267266, 5689.089745640677, 5824.097264923944, 5840.153177789111, 5718.399568045295, 5723.284589426322, 5728.427157284238, 5729.885402291848, 5745.8563535911935, 5713.428657134419, 5814.156947242711, 5822.0684690449325, 5833.095870140135, 5837.0368889132815, 5600.60795744294, 5601.971990140023, 5718.542516598579, 5740.569457290803, 5745.195672605755], "unit": "ms", "name": "dojo.html", "value": 5443.690475355623}, {"lowerIsBetter": false, "replicates": [553.9002979463697, 556.9779454700624, 559.9524040456562, 579.6029719642048, 597.8923793717132, 32560.511592326104, 33656.15859603508, 41164.58835411649, 41939.79030104845, 42021.36967945483, 44381.556184438145, 44745.0, 44846.0, 44846.103077938424, 44946.0, 7673.309402153805, 8836.381453298272, 8950.194482496607, 8988.0, 9005.054469280729, 7805.336546393563, 7918.4457088003865, 10637.414942178177, 10979.066779323766, 10995.615153469631, 10585.947070264638, 10603.522841472113, 10711.357318560873, 10726.03465688088, 10733.355998640107, 7898.368130549542, 8078.071021832506, 10606.363618182895, 10707.839382409193, 10715.571377144945, 10706.839397409045, 11004.449777511092, 11010.39442830644, 11011.83482247767, 11016.559337626486, 40696.0, 40949.385759213634, 41165.0, 41278.79360603208, 41343.1731365374, 3290.52287418323, 3302.9009129725905, 3427.605825330094, 4082.265192265391, 4113.773742444165, 30706.692933070608, 30999.0, 31155.065348039596, 31568.526472102938, 32107.51838722421, 3928.5678575356687, 3939.2909276330247, 3978.2242462719782, 4043.4945631796027, 4121.752694838319, 268647.0, 270971.0, 270978.64510677516, 271316.0, 272224.0, 56165.0, 57662.7116864413, 60048.69975650094, 60484.69757651183, 60734.0, 56030.719846400505, 56294.43705562892, 56395.15407268894, 56398.71800641053, 56585.43414565884, 15614.453494127878, 15788.131652758979, 15794.763078553831, 15804.0, 15836.208189590474, 11796.46915888787, 11852.11109166816, 11874.525018999144, 11929.403529823474, 12038.374819399443, 20133.295334663217, 20189.394318170478, 20324.390268291976, 20335.18659253643, 20375.59248815045, 7883.211678832071, 8046.597670116471, 8083.03003639567, 8128.674853005932, 8133.4306598538715, 921.5069937583361, 1004.9346792458467, 1041.2138835179392, 1063.7606538528769, 1115.1914861725347, 29165.270868228465, 29327.853360733487, 29415.26461838471, 29837.40325193484, 30381.240468988453, 1028.6612481222433, 1042.2443728297076, 1044.8693913260843, 1066.4294602387686, 1071.3090056913247, 14816.94412917741, 14881.255937203097, 14995.32521036556, 15031.173285469404, 15038.32327545263, 311794.0, 315326.0, 319118.0, 319505.0, 319980.0, 52906.735466322425, 53186.46813531892, 53196.46803531992, 53196.73401632967, 53247.46752532425, 1323.8345206849144, 1346.5758286139835, 1359.9728005439836, 1369.5069774881035, 1372.1149858341514, 27686.307842304104, 28464.85767571149, 28557.42885142244, 28709.138725838257, 28831.42337153287, 47562.76218618885, 47587.52412475831, 47709.76145119252, 47709.76145119252, 47840.76079619719, 296047.0, 296743.0, 297272.0, 297633.0, 298378.0, 31040.844795775876, 31626.683733162376, 31855.522167167048, 31958.28354589886, 32064.51903221407, 43490.34764478472, 43804.916082727126, 44020.33969490524, 44227.33658995053, 44740.32889506725, 36019.459708103874, 36829.26341473102, 37200.25599488049, 37577.872663820126, 37784.0, 35927.0, 36395.27209455849, 36820.26359472742, 36857.26285474222, 37292.627073728916, 36133.0, 36473.0, 36533.634663654084, 36635.26729465449, 37020.629793701715, 31953.520697189095, 33142.33715325632, 33180.0, 33740.83129584337, 33849.661503384654, 25456.23631291064, 25519.234422966598, 25661.0, 25876.482470350864, 26109.477810444063], "unit": "ms", "name": "ext.html", "value": 19074.685153373066}, {"lowerIsBetter": false, "replicates": [341.06888195227043, 353.8690684446755, 359.699650791589, 362.3025675574518, 362.6899001353842, 13191.07662463628, 16701.582460438494, 17232.224549895236, 17811.64376712465, 17818.55453613657, 16632.25154868031, 16979.91510042448, 17433.389831355904, 17564.912175439105, 17612.559686007855, 4046.271671099201, 4218.409422680827, 4219.493660760698, 5322.148456247001, 5504.036793561131, 5784.334801497818, 5966.194563733884, 6000.249968753906, 6003.549733769963, 6005.849853753647, 5835.44563266489, 5878.294604647448, 5907.350191478956, 5932.021216499273, 5940.34656187819, 5942.494887934531, 6061.060535616986, 6065.696715164224, 6073.058675905242, 6129.417705317987, 5307.911878065026, 5326.9467305327225, 5330.546903513206, 5334.866628334284, 5344.545713614348, 20493.89753051225, 20494.282700105574, 20553.8972305139, 20705.0, 20759.169633214653, 2197.967030494544, 2201.966970495444, 2223.399682085828, 2235.955280894373, 2347.7534858839745, 12438.875611243862, 12516.874831251662, 12668.303243321614, 12868.806967895489, 13555.051146419755, 1800.0, 1804.3323970131005, 1822.4441545328668, 1843.603625220584, 1911.6176764647125, 58532.41467585312, 61643.383566164215, 61683.38316616866, 61890.38109618936, 62007.379926200614, 10264.332818366782, 10312.226583006304, 10337.328073675188, 10341.0, 10348.120409765104, 13383.0, 13417.865821341857, 13429.664258393423, 13486.730265394637, 13488.460461581426, 7000.754973576002, 7107.6446177690905, 7121.608311542811, 7145.356917877416, 7185.89221161683, 6667.366600172976, 6671.232808227116, 6714.429273511806, 6726.865462690719, 6740.561863478858, 4094.3244364679495, 4202.2646036943415, 4261.360795880642, 4364.345348197796, 4396.406485124531, 1780.5103596510803, 1827.7806663200502, 1846.510674671213, 1866.915988780508, 1881.2569035231281, 887.60057973912, 890.247740659142, 898.1108702384723, 990.4008075114596, 1040.9011143941314, 16134.435294764628, 16532.504024879272, 16656.500914917717, 16816.57958551046, 16945.49163525096, 884.9380543361902, 903.4579252448478, 908.0374802709149, 927.188709878856, 952.0717300631967, 9450.57472413743, 9563.139317461462, 9912.950435247778, 9923.40459572428, 9965.950170249247, 321812.0, 430779.0, 533525.0, 542787.0, 550649.0, 72561.2743872565, 72978.27021729821, 74439.25560744431, 79293.60353198196, 83850.0, 1084.0406240477234, 1105.1214284643727, 1106.7233191702076, 1108.0304733358312, 1118.3904771899333, 12365.876341236832, 14435.639109022359, 14748.63128421798, 14912.776308355167, 15271.176963936296, 35915.64084359227, 35948.64051359453, 36123.09692257715, 36285.0, 36634.8168259157, 44527.55472445234, 46120.538794611624, 46132.53867461282, 46445.0, 46724.76637616926, 9090.909090909006, 9188.448693078437, 9219.124183202584, 9293.860592090989, 9311.022342653923, 13145.868541314465, 16394.0, 17479.300827966737, 17481.125943703017, 17532.82467175312, 14120.929395352958, 14212.786808197678, 14383.137011779327, 14628.780568291697, 14633.0, 13928.233947133005, 14125.0, 14242.359093841009, 14303.427862885368, 14574.0, 14545.200013998909, 14620.85379146195, 14657.120572765669, 14809.0, 14939.253037347871, 9190.21883139914, 9196.0, 9213.12475314844, 9479.620815167316, 9671.806563868542, 13087.934560327138, 13655.863441365856, 13808.240546769623, 13893.861061389662, 14274.500392486214], "unit": "ms", "name": "jquery.html", "value": 8893.238917679771}, {"lowerIsBetter": false, "replicates": [1317.756215100207, 1684.9326026958922, 1720.346268418001, 1721.535185499915, 1744.5725797179693, 6620.668966551677, 7385.0, 7530.209328020561, 7531.661075251606, 7537.057867766529, 7357.889631655529, 7603.429742769286, 7615.657295421705, 7626.08486981563, 7629.656665450054, 1959.0596513673445, 2030.604032213719, 2033.7356143701297, 2257.5146343536094, 2284.1434462076722, 2041.6325061488926, 2283.178055899875, 2312.5259321839067, 2314.976850231493, 2332.603457412244, 2193.1665966932624, 2217.833662475313, 2227.465408302004, 2295.7933785959262, 2296.689946857178, 1979.0, 2015.9193632254692, 2231.263682984619, 2263.4454558633156, 2263.8868056597103, 1905.066517406461, 1908.5037890148521, 1908.570571621374, 2249.325202439262, 2310.8151347892294, 7534.698612055511, 7617.885731714029, 7626.0, 7629.351505122071, 7636.618169091579, 4647.372604698357, 4726.0784147091335, 4727.456342520585, 4731.2430011198385, 4739.4075740532435, 3122.31309111995, 3165.5568220449154, 3214.5499630051813, 3276.8197749123788, 3277.901662950115, 961.5336561767607, 986.6546708651986, 994.2394068537575, 997.9072915157891, 1018.7809620931462, 10557.63048293306, 10568.788624227473, 10583.259171857973, 10607.0, 10641.521131549176, 4179.2477354076555, 4312.5903039211225, 4332.155229730172, 4337.609615134653, 4353.804078816461, 9024.413413128257, 9042.773930651787, 9053.68312109073, 9064.274858011344, 9067.68263110788, 4798.5441383068555, 4828.155072862305, 4833.685810422382, 4833.975830120898, 4835.274708793709, 4381.255186618282, 4384.495782984934, 4401.405810215644, 4412.4705035395955, 4413.095315460387, 3556.413191823372, 3614.6023937366867, 3636.781793092423, 3647.94528082079, 3667.9633203668154, 1220.6033039262097, 1224.64485299264, 1227.2575092069349, 1229.0843321725372, 1229.9815502767465, 1314.8224989626278, 1320.8348956380453, 1336.7059246965653, 1356.010112617775, 1357.9932100339436, 7100.893486597705, 7168.247334029956, 7187.065681461377, 7197.964010179916, 7201.207867134611, 460.5854730742359, 467.9321498382715, 468.7281376801447, 473.1011078949954, 481.22042291488015, 5310.893782124336, 5454.972725136349, 5548.72256387179, 5608.355039170466, 5624.0439125348785, 8953.820923581623, 9127.589258483384, 9145.268378529701, 9162.404443711137, 9219.354645174773, 8931.0, 8990.685326013558, 9029.23251523628, 9432.056794320513, 9448.338616296931, 7176.354128128493, 7190.96404517974, 7274.672639731225, 7302.634868256566, 7321.450891183183, 6938.930610693828, 7004.0544526488275, 7012.4390048796995, 7023.719051237893, 7045.0, 7948.443608947318, 8244.752657420288, 8285.58572071382, 8354.665813367397, 8368.665253389796, 8315.168483151636, 8401.747947561584, 8435.789105272417, 8507.149285071444, 8692.739217823475, 6801.2858649841055, 6862.0, 6867.759628412981, 6871.14110736158, 6872.587644741331, 7228.710851565878, 7260.056192694916, 7291.890621640786, 7300.634968251672, 7325.230850760807, 6911.5853048817235, 6992.650367481708, 6999.1950925644205, 7090.751823686146, 7112.502124851418, 6852.657367131524, 6857.108575885103, 6890.724371025303, 6971.79084627462, 6993.440524757905, 6993.685284162123, 7028.543144695578, 7074.893876591752, 7086.574805511686, 7091.716331346688, 6308.936910631019, 6345.841353966003, 6377.7130029147875, 6395.072714456471, 6407.199100112486, 6385.7126429309865, 6450.48396128318, 6453.774117905851, 6455.0317452382515, 6457.967710161419], "unit": "ms", "name": "mootools.html", "value": 4352.865701234083}, {"lowerIsBetter": false, "replicates": [331.39189587107654, 331.9618243901952, 332.77870216306155, 335.87236849997004, 337.93410284994434, 5950.226470558827, 5961.433663801938, 5966.105084237367, 5966.343702192756, 6019.307779605347, 5729.140628905666, 5755.712214389285, 5853.678047707374, 5921.230240068785, 5928.288605367351, 4540.046590216059, 4562.452505699304, 4585.472670642869, 4600.7929643166135, 4616.676832621718, 4573.062522182944, 4586.656000799937, 4591.357209990587, 4593.127305811901, 4598.931016034762, 4324.459442569679, 4405.867823965286, 4433.578810013044, 4555.498895121551, 4556.521565235652, 4529.8641040768825, 4540.614047805941, 4546.386237857913, 4547.045120524694, 4553.134904368159, 3989.082511022452, 3994.4807175067344, 3994.560598334181, 3996.900077498057, 4002.699797515198, 5640.2667653205235, 5655.462731040545, 5658.943410565924, 5664.745086471119, 5679.488846003879, 5055.317532133152, 5225.242339860737, 5231.0, 5236.581073514109, 5237.109691352479, 6235.7505699771955, 6236.282827474854, 6239.095331176999, 6243.1883855099, 6251.593646412968, 4313.654907607384, 4314.439122914033, 4315.395844581761, 4319.870403887889, 4321.2653848845775, 6337.746490140389, 6467.32093130224, 6543.149390579194, 6544.149260596139, 6545.247296560909, 4305.0, 4423.314386270134, 4427.40230068943, 4432.867013989586, 4434.778261086997, 4478.440194975628, 4479.552044795494, 4480.215962206601, 4482.731036137777, 4483.641308695296, 5189.273501709764, 5194.97402512985, 5204.0, 5207.036698210767, 5214.32213812202, 6166.7224974876235, 6292.024736165901, 6320.273168585672, 6338.429541341301, 6342.904856427157, 1556.5719427157621, 1561.3832536148159, 1571.4735563586328, 1578.565894379032, 1578.6053486628343, 1017.531935309751, 1031.3502493429241, 1040.443362800913, 1041.5937784264142, 1048.5072016152396, 6084.117802918552, 6094.908576371358, 6095.481884039907, 6101.755929762849, 6103.572749907464, 6477.4170324671, 6483.902741458882, 6488.28628850826, 6499.642519661369, 6507.8698426031215, 5910.143029260733, 6035.185249991283, 6065.332813390523, 6072.878542429126, 6162.753489860445, 3527.329807336649, 3529.541159649229, 3546.4680297955515, 3549.7515173937577, 3551.8224088795455, 6765.458763298924, 6772.932270677329, 6773.830654233683, 6776.2546119926765, 6781.287964763629, 6569.507286953402, 6719.563228390139, 6726.596404215763, 6732.158480189976, 6733.293004234485, 6768.492363072789, 6773.559718618274, 6779.559328643622, 6781.287964763629, 6796.558223715344, 6562.146920900253, 6567.868642627025, 6570.77002304917, 6576.901346479711, 6577.704003319958, 6313.526485513697, 6495.935040649722, 6508.902366464412, 6509.251436084911, 6517.4460170886005, 6766.289539598271, 6769.763058292936, 6769.916813310044, 6772.93227067723, 6777.085093512313, 4428.756418397019, 4430.534793846599, 4442.800073996613, 4444.888877778081, 4445.399871017501, 6427.871442571216, 6518.348165183444, 6536.215654121535, 6548.574342667712, 6553.115329430466, 6343.143675603919, 6357.93642063592, 6367.586106903222, 6371.872562548816, 6379.840503987438, 6338.809835704937, 6354.523410744305, 6364.681765911779, 6367.363263673596, 6381.29805721361, 6097.359777223505, 6244.46922011616, 6247.312795592572, 6261.968690156702, 6265.780697675559, 6364.109024736448, 6397.936020639921, 6401.327860574759, 6407.423331900151, 6407.71165297572, 6235.095911092775, 6242.032484964838, 6244.531660125418, 6251.78118765841, 6265.8120256392385], "unit": "ms", "name": "prototype.html", "value": 4752.655940762932}, {"lowerIsBetter": false, "replicates": [744.9962750186248, 746.3394895517469, 782.8316911863951, 798.0662624729065, 857.2713193785281, 14026.579202623925, 14308.856911430883, 14339.0, 14352.0, 14431.711365772679, 13368.532101376453, 13375.0, 14000.509982150626, 14627.268636568155, 14634.926825365885, 798.138010948176, 810.4731924249227, 810.7932477218301, 812.2040400407604, 812.8780682897553, 669.4945316286197, 675.0717763075771, 808.2362167751477, 817.3257062923083, 818.472085504852, 840.0297656207091, 845.3152946113637, 845.5772113943028, 846.7332790171076, 847.4152834544145, 706.2972342519226, 711.5588335232189, 852.995735021324, 853.7524118005801, 857.3269983063328, 523.7433657507831, 627.6328347916474, 628.1269036039909, 628.8930881750114, 629.4932579273683, 14324.0, 14373.425062997467, 14414.13515189092, 14415.063020903608, 14415.063020903712, 12042.759144817055, 12874.485020599164, 13049.739005219843, 13236.272005039718, 13356.933215333958, 10514.106300964428, 10527.84208236877, 10544.947275263574, 10756.354618722902, 10935.890641093567, 3621.2073679021228, 3686.4838922550866, 3696.815159242054, 3730.8321125549146, 3809.5999920008276, 49769.25346119811, 50058.24912626314, 50336.74831625855, 50351.496485035044, 50376.49623503755, 10592.364458132382, 10820.35077895313, 10848.62029828968, 10865.239433239598, 10868.0, 19549.218031278873, 19561.510962226057, 19588.804111958983, 19661.803381965998, 19665.705014424795, 7810.062792464827, 7852.960735196288, 7877.487963282369, 8015.879761803578, 8025.879611805827, 4227.811678325184, 4321.0, 4385.210662080793, 4427.070315233837, 4519.163954668331, 3168.081256435654, 3181.0774875285906, 3194.3611277744544, 3207.4707673233656, 3215.437298472758, 545.8062387852256, 561.9072852979212, 570.2785975740692, 570.9628874123168, 582.8775957049068, 512.7692538357754, 653.167211804943, 677.9966100169567, 680.9216940051858, 721.0986267166043, 8314.792130196673, 8512.70205542803, 8837.160469755363, 8935.151160639729, 9008.684696035738, 618.6473709985355, 626.5394934722975, 648.9805305840832, 649.7238673563717, 720.1538192623647, 4186.476690413699, 4195.223883581547, 4301.09676967834, 4409.4488188976375, 4556.225441674923, 56073.43926560764, 56193.7190314054, 56393.154102688495, 56756.0, 60603.69698151569, 52115.47884521182, 52570.47429525732, 53004.20493692598, 53031.20453193205, 53071.73464132655, 47591.5240847594, 47878.760606197444, 48030.519694802606, 48105.27842082441, 48623.27065094026, 9043.593038313424, 9226.9538652309, 9233.769155771159, 9298.163165315154, 9347.112024357675, 36849.0, 37444.25111497809, 37689.0, 37859.24281514299, 38092.0, 43281.0, 43794.56205437905, 46829.76585117052, 46979.53020469888, 47042.52957470382, 10775.6228532001, 10846.891531084588, 11367.958669229174, 11492.885071149181, 11859.822102668639, 12494.312812795384, 12507.812382814083, 12513.124081314585, 13337.266450345323, 13348.399322030726, 11574.537018519164, 11756.118291128028, 11764.000059994996, 11793.52825886955, 12205.450754716237, 11257.831132532854, 11400.828987565359, 12090.214136081127, 12339.876601233873, 12344.074194435274, 7439.404847612286, 10365.63720269787, 11131.387773672526, 11401.372924489233, 11582.305061696325, 9709.223262139154, 9903.158231550111, 9948.502574871372, 10026.147777438999, 10161.339512931636, 9699.272554558294, 9762.414255144715, 9809.85285220708, 9835.950820245853, 9877.604895804086], "unit": "ms", "name": "yui.html", "value": 6459.410261501957}], "name": "dromaeo_css", "value": 7056.011646257074}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 104.0, 109.0, 109.0, 109.0, 99.0, 111.0, 110.0, 101.0], "unit": "ms", "name": "ai-astar", "value": 106.9}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 148.0, 165.0, 126.0, 151.0, 157.0, 124.0, 170.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 163.0, 160.0, 159.0, 158.0, 160.0, 164.0, 159.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 88.0, 94.0, 71.0, 71.0, 71.0, 107.0, 89.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 136.0, 92.0, 93.0, 92.0, 137.0, 92.0, 93.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 111.0, 111.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 144.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 58.0, 58.0, 60.0, 60.0, 58.0, 60.0, 58.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 93.0, 84.0, 84.0, 84.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [120.0, 130.0, 120.0, 113.0, 136.0, 118.0, 122.0, 125.0, 115.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.1}, {"lowerIsBetter": true, "replicates": [141.0, 150.0, 157.0, 146.0, 149.0, 138.0, 148.0, 148.0, 148.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 68.0, 66.0, 70.0, 66.0, 65.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1495.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [189.60940462646948], "unit": "score", "name": "Richards", "value": 186.18274799999998}, {"lowerIsBetter": false, "replicates": [194.43904335990666], "unit": "score", "name": "DeltaBlue", "value": 340.0448739999999}, {"lowerIsBetter": false, "replicates": [284.4950213371266], "unit": "score", "name": "Encrypt", "value": 935.6262149999995}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [1953.125], "unit": "score", "name": "RayTrace", "value": 378.87436799999995}, {"lowerIsBetter": false, "replicates": [780.64012490242], "unit": "score", "name": "Earley", "value": 853.7391030000001}, {"lowerIsBetter": false, "replicates": [12072.289156626506], "unit": "score", "name": "Boyer", "value": 55.20601696606782}, {"lowerIsBetter": false, "replicates": [25350.0], "unit": "score", "name": "RegExp", "value": 35.936291913214966}, {"lowerIsBetter": false, "replicates": [648.0881399870383], "unit": "score", "name": "Splay", "value": 125.74061300000001}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19532.002589362033}]} 18:20:30 INFO - RETURN: dromaeo_css: 7056.01 18:20:30 INFO - RETURN: kraken: 1495.90 18:20:30 INFO - RETURN: v8_7: 19532.00 18:20:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19532.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1495.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "7056.01"}}} 18:20:30 INFO - Return code: 0 18:20:30 INFO - # TBPL SUCCESS # 18:20:30 INFO - Running post-action listener: _resource_record_post_action 18:20:30 INFO - Running post-run listener: _resource_record_post_run 18:20:31 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 147456; Write bytes: 507678720; Read time: 272; Write time: 497600 18:20:31 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 103407616; Read time: 0; Write time: 82796 18:20:31 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 147456; Write bytes: 332918784; Read time: 272; Write time: 316716 18:20:31 INFO - Running post-run listener: _upload_blobber_files 18:20:31 INFO - Blob upload gear active. 18:20:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:20:31 INFO - Copying logs to upload dir... 18:20:31 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.776316 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-23 18:20:31.379316) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:31.382574) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009860 build_url: 'https://queue.taskcluster.net/v1/task/QBD6jyF5RKSJ21ueQjF2GQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:31.439755) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:31.440745) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1448329184.135992-1975702073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004794 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:31.492234) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 18:20:31.492588) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 18:20:31.492905) ========= ========= Total master_lag: 0.25 =========