builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1448106395.16 results: success (0) buildid: 20151121013100 builduid: b66ea78946404830994c6e308b0aef25 revision: c3aa84cd334c17606ff33284a058064eafd67d28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.160934) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.161905) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.162223) ========= 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=6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006636 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.187633) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.187976) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.262524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.262795) ========= 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=6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004629 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.342394) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.342687) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.343065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.343368) ========= 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=6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-21 03:46:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-11-21 03:46:36 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186072 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.555968) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.556353) ========= 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=6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014758 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.611804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:35.612156) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c3aa84cd334c17606ff33284a058064eafd67d28 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c3aa84cd334c17606ff33284a058064eafd67d28 --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=6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-21 03:46:36,147 truncating revision to first 12 chars 2015-11-21 03:46:36,147 Setting DEBUG logging. 2015-11-21 03:46:36,147 attempt 1/10 2015-11-21 03:46:36,147 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c3aa84cd334c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-21 03:46:36,416 unpacking tar archive at: mozilla-inbound-c3aa84cd334c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.930568 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:36.554930) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:36.555216) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:36.564851) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:36.568656) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 03:46:36.569127) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-21 03:46:36.569407) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:46:37 INFO - MultiFileLogger online at 20151121 03:46:37 in /builds/slave/test-pgo 03:46:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:46:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:46:37 INFO - {'append_to_log': False, 03:46:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:46:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:46:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:46:37 INFO - 'branch': 'Mozilla-Inbound', 03:46:37 INFO - 'buildbot_json_path': 'buildprops.json', 03:46:37 INFO - 'config_files': ('talos/linux_config.py',), 03:46:37 INFO - 'default_actions': ('clobber', 03:46:37 INFO - 'read-buildbot-config', 03:46:37 INFO - 'download-and-extract', 03:46:37 INFO - 'populate-webroot', 03:46:37 INFO - 'create-virtualenv', 03:46:37 INFO - 'install', 03:46:37 INFO - 'run-tests'), 03:46:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:46:37 INFO - 'download_minidump_stackwalk': True, 03:46:37 INFO - 'download_symbols': 'ondemand', 03:46:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:46:37 INFO - 'tooltool.py': '/tools/tooltool.py', 03:46:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:46:37 INFO - '/tools/misc-python/virtualenv.py')}, 03:46:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:46:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:46:37 INFO - 'installer_path': 'installer.exe', 03:46:37 INFO - 'log_level': 'info', 03:46:37 INFO - 'log_name': 'talos', 03:46:37 INFO - 'log_to_console': True, 03:46:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:46:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:46:37 INFO - 'opt_config_files': (), 03:46:37 INFO - 'pip_index': False, 03:46:37 INFO - 'sps_profile': False, 03:46:37 INFO - 'sps_profile_interval': 0, 03:46:37 INFO - 'suite': 'dromaeojs', 03:46:37 INFO - 'system_bits': '64', 03:46:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:46:37 INFO - 'title': 'talos-linux64-ix-017', 03:46:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:46:37 INFO - 'use_talos_json': True, 03:46:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:46:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:46:37 INFO - 'work_dir': 'build'} 03:46:37 INFO - ##### 03:46:37 INFO - ##### Running clobber step. 03:46:37 INFO - ##### 03:46:37 INFO - Running pre-action listener: _resource_record_pre_action 03:46:37 INFO - Running main action method: clobber 03:46:37 INFO - rmtree: /builds/slave/test-pgo/build 03:46:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:46:37 INFO - Running post-action listener: _resource_record_post_action 03:46:37 INFO - ##### 03:46:37 INFO - ##### Running read-buildbot-config step. 03:46:37 INFO - ##### 03:46:37 INFO - Running pre-action listener: _resource_record_pre_action 03:46:37 INFO - Running main action method: read_buildbot_config 03:46:37 INFO - Using buildbot properties: 03:46:37 INFO - { 03:46:37 INFO - "properties": { 03:46:37 INFO - "buildnumber": 1291, 03:46:37 INFO - "product": "firefox", 03:46:37 INFO - "script_repo_revision": "production", 03:46:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:46:37 INFO - "repository": "", 03:46:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:46:37 INFO - "buildid": "20151121013100", 03:46:37 INFO - "slavename": "talos-linux64-ix-017", 03:46:37 INFO - "pgo_build": "True", 03:46:37 INFO - "basedir": "/builds/slave/test-pgo", 03:46:37 INFO - "project": "", 03:46:37 INFO - "platform": "ubuntu64_hw", 03:46:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:46:37 INFO - "slavebuilddir": "test", 03:46:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:46:37 INFO - "branch": "mozilla-inbound", 03:46:37 INFO - "repo_path": "integration/mozilla-inbound", 03:46:37 INFO - "stage_platform": "linux64-pgo", 03:46:37 INFO - "builduid": "b66ea78946404830994c6e308b0aef25", 03:46:37 INFO - "revision": "c3aa84cd334c17606ff33284a058064eafd67d28" 03:46:37 INFO - }, 03:46:37 INFO - "sourcestamp": { 03:46:37 INFO - "repository": "", 03:46:37 INFO - "hasPatch": false, 03:46:37 INFO - "project": "", 03:46:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 03:46:37 INFO - "changes": [ 03:46:37 INFO - { 03:46:37 INFO - "category": null, 03:46:37 INFO - "files": [ 03:46:37 INFO - { 03:46:37 INFO - "url": null, 03:46:37 INFO - "name": "https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:46:37 INFO - } 03:46:37 INFO - ], 03:46:37 INFO - "repository": "", 03:46:37 INFO - "rev": "c3aa84cd334c17606ff33284a058064eafd67d28", 03:46:37 INFO - "who": "sendchange", 03:46:37 INFO - "when": 1448106347, 03:46:37 INFO - "number": 6692238, 03:46:37 INFO - "comments": "", 03:46:37 INFO - "project": "", 03:46:37 INFO - "at": "Sat 21 Nov 2015 03:45:47", 03:46:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 03:46:37 INFO - "revlink": "", 03:46:37 INFO - "properties": [ 03:46:37 INFO - [ 03:46:37 INFO - "buildid", 03:46:37 INFO - "20151121013100", 03:46:37 INFO - "Change" 03:46:37 INFO - ], 03:46:37 INFO - [ 03:46:37 INFO - "builduid", 03:46:37 INFO - "b66ea78946404830994c6e308b0aef25", 03:46:37 INFO - "Change" 03:46:37 INFO - ], 03:46:37 INFO - [ 03:46:37 INFO - "pgo_build", 03:46:37 INFO - "True", 03:46:37 INFO - "Change" 03:46:37 INFO - ] 03:46:37 INFO - ], 03:46:37 INFO - "revision": "c3aa84cd334c17606ff33284a058064eafd67d28" 03:46:37 INFO - } 03:46:37 INFO - ], 03:46:37 INFO - "revision": "c3aa84cd334c17606ff33284a058064eafd67d28" 03:46:37 INFO - } 03:46:37 INFO - } 03:46:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:46:37 INFO - Running post-action listener: _resource_record_post_action 03:46:37 INFO - ##### 03:46:37 INFO - ##### Running download-and-extract step. 03:46:37 INFO - ##### 03:46:37 INFO - Running pre-action listener: _resource_record_pre_action 03:46:37 INFO - Running main action method: download_and_extract 03:46:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:37 INFO - https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:46:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/test_packages.json 03:46:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/test_packages.json 03:46:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:46:46 INFO - Downloaded 1302 bytes. 03:46:46 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:46:46 INFO - Using the following test package requirements: 03:46:46 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:46:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:46:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:46 INFO - u'jsshell-linux-x86_64.zip'], 03:46:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:46:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:46:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:46:46 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:46:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:46:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:46:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:46:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:46: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')]} 03:46:46 INFO - https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/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 03:46:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/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 03:46:48 INFO - Downloaded 22524115 bytes. 03:46:48 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 03:46:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:48 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 03:46:49 INFO - Return code: 0 03:46:49 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 03:46: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')]} 03:46:49 INFO - https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/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 03:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/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 03:47:00 INFO - Downloaded 22524115 bytes. 03:47:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:47:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:47:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:47:01 INFO - Return code: 0 03:47: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')]} 03:47:01 INFO - https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:47:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/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 03:47:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/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 03:47:02 INFO - Downloaded 11130997 bytes. 03:47:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:47:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:47:02 INFO - Return code: 0 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:02 INFO - https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:47:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:47:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:47:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/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 03:47:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0ffqsuCvTfi3qFVyPEVWKA/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 03:47:04 INFO - Downloaded 57433500 bytes. 03:47:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:47:04 INFO - mkdir: /builds/slave/test-pgo/properties 03:47:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:47:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:47:04 INFO - Contents: 03:47:04 INFO - build_url:https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:47:04 INFO - Running post-action listener: _resource_record_post_action 03:47:04 INFO - Running post-action listener: set_extra_try_arguments 03:47:04 INFO - ##### 03:47:04 INFO - ##### Running populate-webroot step. 03:47:04 INFO - ##### 03:47:04 INFO - Running pre-action listener: _resource_record_pre_action 03:47:04 INFO - Running main action method: populate_webroot 03:47:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:47:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:47:04 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:47:04 INFO - '../fennec_ids.txt'], 03:47:04 INFO - 'tests': ['tcheck2']}, 03:47:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:47:04 INFO - '--tppagecycles', 03:47:04 INFO - '7'], 03:47:04 INFO - 'tests': ['tsvgm']}}, 03:47:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:47:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:47:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:47:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:47:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:47:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:47:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:04 INFO - 'talos_options': ['--e10s'], 03:47:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:04 INFO - 'tests': ['damp', 'tps']}, 03:47:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:04 INFO - 'talos_options': ['--e10s'], 03:47:04 INFO - 'tests': ['damp', 'tps']}, 03:47:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:47:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:47:04 INFO - 'other': {'tests': ['a11yr', 03:47:04 INFO - 'ts_paint', 03:47:04 INFO - 'tpaint', 03:47:04 INFO - 'sessionrestore', 03:47:04 INFO - 'sessionrestore_no_auto_restore']}, 03:47:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:47:04 INFO - 'tests': ['a11yr', 03:47:04 INFO - 'ts_paint', 03:47:04 INFO - 'tpaint', 03:47:04 INFO - 'sessionrestore', 03:47:04 INFO - 'sessionrestore_no_auto_restore']}, 03:47:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:47:04 INFO - 'tests': ['a11yr', 03:47:04 INFO - 'ts_paint', 03:47:04 INFO - 'tpaint', 03:47:04 INFO - 'sessionrestore', 03:47:04 INFO - 'sessionrestore_no_auto_restore']}, 03:47:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:47:04 INFO - 'tests': ['a11yr', 03:47:04 INFO - 'ts_paint', 03:47:04 INFO - 'tpaint', 03:47:04 INFO - 'sessionrestore', 03:47:04 INFO - 'sessionrestore_no_auto_restore']}, 03:47:04 INFO - 'other_l64': {'tests': ['a11yr', 03:47:04 INFO - 'ts_paint', 03:47:04 INFO - 'tpaint', 03:47:04 INFO - 'sessionrestore', 03:47:04 INFO - 'sessionrestore_no_auto_restore']}, 03:47:04 INFO - 'other_nol64': {'tests': ['a11yr', 03:47:04 INFO - 'ts_paint', 03:47:04 INFO - 'tpaint', 03:47:04 INFO - 'sessionrestore', 03:47:04 INFO - 'sessionrestore_no_auto_restore']}, 03:47:04 INFO - 'svgr': {'tests': ['tsvgx', 03:47:04 INFO - 'tsvgr_opacity', 03:47:04 INFO - 'tart', 03:47:04 INFO - 'tscrollx', 03:47:04 INFO - 'cart']}, 03:47:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:47:04 INFO - 'tests': ['tsvgx', 03:47:04 INFO - 'tsvgr_opacity', 03:47:04 INFO - 'tart', 03:47:04 INFO - 'tscrollx', 03:47:04 INFO - 'cart']}, 03:47:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:04 INFO - 'tests': ['tp5o']}, 03:47:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:04 INFO - 'talos_options': ['--e10s'], 03:47:04 INFO - 'tests': ['tp5o']}, 03:47:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:04 INFO - 'talos_options': ['--xperf_path', 03:47:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:04 INFO - 'tests': ['tp5n']}, 03:47:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:04 INFO - 'talos_options': ['--e10s', 03:47:04 INFO - '--xperf_path', 03:47:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:04 INFO - 'tests': ['tp5n']}}, 03:47:04 INFO - 'talos.zip': {'path': '', 03:47:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:47:04 INFO - Running post-action listener: _resource_record_post_action 03:47:04 INFO - ##### 03:47:04 INFO - ##### Running create-virtualenv step. 03:47:04 INFO - ##### 03:47:04 INFO - Running pre-action listener: _resource_record_pre_action 03:47:04 INFO - Running main action method: create_virtualenv 03:47:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:47:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:47:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:47:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:47:04 INFO - Using real prefix '/usr' 03:47:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:47:05 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:06 INFO - Installing pip.................done. 03:47:06 INFO - Return code: 0 03:47:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4f799bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1803d70>, '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 0x1804b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1804fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', '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 03:47:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:47:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:47:06 INFO - Using env: {'DISPLAY': ':0', 03:47:06 INFO - 'HOME': '/home/cltbld', 03:47:06 INFO - 'LANG': 'en_US.UTF-8', 03:47:06 INFO - 'LANGUAGE': 'en_US:en', 03:47:06 INFO - 'LOGNAME': 'cltbld', 03:47:06 INFO - 'MAIL': '/var/mail/cltbld', 03:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:06 INFO - 'MOZ_NO_REMOTE': '1', 03:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:06 INFO - 'NO_EM_RESTART': '1', 03:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:06 INFO - 'SHELL': '/bin/bash', 03:47:06 INFO - 'SHLVL': '1', 03:47:06 INFO - 'TERM': 'linux', 03:47:06 INFO - 'TMOUT': '86400', 03:47:06 INFO - 'USER': 'cltbld', 03:47:06 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', 03:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:06 INFO - '_': '/tools/buildbot/bin/python'} 03:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:07 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 03:47:07 INFO - Cleaning up... 03:47:07 INFO - Return code: 0 03:47:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:07 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 0x7ff4f799bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1803d70>, '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 0x1804b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1804fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', '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 03:47:07 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 03:47:07 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 03:47:07 INFO - Using env: {'DISPLAY': ':0', 03:47:07 INFO - 'HOME': '/home/cltbld', 03:47:07 INFO - 'LANG': 'en_US.UTF-8', 03:47:07 INFO - 'LANGUAGE': 'en_US:en', 03:47:07 INFO - 'LOGNAME': 'cltbld', 03:47:07 INFO - 'MAIL': '/var/mail/cltbld', 03:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:07 INFO - 'MOZ_NO_REMOTE': '1', 03:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:07 INFO - 'NO_EM_RESTART': '1', 03:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:07 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:07 INFO - 'SHELL': '/bin/bash', 03:47:07 INFO - 'SHLVL': '1', 03:47:07 INFO - 'TERM': 'linux', 03:47:07 INFO - 'TMOUT': '86400', 03:47:07 INFO - 'USER': 'cltbld', 03:47:07 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', 03:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:07 INFO - '_': '/tools/buildbot/bin/python'} 03:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:07 INFO - Downloading/unpacking psutil>=0.7.1 03:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:47:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:47:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:47:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:09 INFO - Installing collected packages: psutil 03:47:09 INFO - Running setup.py install for psutil 03:47:09 INFO - building 'psutil._psutil_linux' extension 03:47:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:47:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:47:09 INFO - building 'psutil._psutil_posix' extension 03:47:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:47:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:47:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:09 INFO - Successfully installed psutil 03:47:09 INFO - Cleaning up... 03:47:09 INFO - Return code: 0 03:47:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4f799bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1803d70>, '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 0x1804b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1804fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', '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 03:47:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:47:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:47:09 INFO - Using env: {'DISPLAY': ':0', 03:47:09 INFO - 'HOME': '/home/cltbld', 03:47:09 INFO - 'LANG': 'en_US.UTF-8', 03:47:09 INFO - 'LANGUAGE': 'en_US:en', 03:47:09 INFO - 'LOGNAME': 'cltbld', 03:47:09 INFO - 'MAIL': '/var/mail/cltbld', 03:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:09 INFO - 'MOZ_NO_REMOTE': '1', 03:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:09 INFO - 'NO_EM_RESTART': '1', 03:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:09 INFO - 'SHELL': '/bin/bash', 03:47:09 INFO - 'SHLVL': '1', 03:47:09 INFO - 'TERM': 'linux', 03:47:09 INFO - 'TMOUT': '86400', 03:47:09 INFO - 'USER': 'cltbld', 03:47:09 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', 03:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:09 INFO - '_': '/tools/buildbot/bin/python'} 03:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:47:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:47:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:47:11 INFO - Installing collected packages: mozsystemmonitor 03:47:11 INFO - Running setup.py install for mozsystemmonitor 03:47:11 INFO - Successfully installed mozsystemmonitor 03:47:11 INFO - Cleaning up... 03:47:11 INFO - Return code: 0 03:47:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4f799bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1803d70>, '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 0x1804b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1804fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', '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 03:47:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:47:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:47:11 INFO - Using env: {'DISPLAY': ':0', 03:47:11 INFO - 'HOME': '/home/cltbld', 03:47:11 INFO - 'LANG': 'en_US.UTF-8', 03:47:11 INFO - 'LANGUAGE': 'en_US:en', 03:47:11 INFO - 'LOGNAME': 'cltbld', 03:47:11 INFO - 'MAIL': '/var/mail/cltbld', 03:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:11 INFO - 'MOZ_NO_REMOTE': '1', 03:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:11 INFO - 'NO_EM_RESTART': '1', 03:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:11 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:11 INFO - 'SHELL': '/bin/bash', 03:47:11 INFO - 'SHLVL': '1', 03:47:11 INFO - 'TERM': 'linux', 03:47:11 INFO - 'TMOUT': '86400', 03:47:11 INFO - 'USER': 'cltbld', 03:47:11 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', 03:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:11 INFO - '_': '/tools/buildbot/bin/python'} 03:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:12 INFO - Downloading/unpacking blobuploader==1.2.4 03:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:13 INFO - Downloading blobuploader-1.2.4.tar.gz 03:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:47:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:47:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:47:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:47:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:47:14 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 03:47:14 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 03:47:14 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 03:47:14 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 03:47:14 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 03:47:14 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 03:47:14 INFO - Downloading docopt-0.6.1.tar.gz 03:47:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:47:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:47:14 INFO - Installing collected packages: blobuploader, requests, docopt 03:47:14 INFO - Running setup.py install for blobuploader 03:47:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:47:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:47:14 INFO - Running setup.py install for requests 03:47:14 INFO - Running setup.py install for docopt 03:47:14 INFO - Successfully installed blobuploader requests docopt 03:47:14 INFO - Cleaning up... 03:47:14 INFO - Return code: 0 03:47:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4f799bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1803d70>, '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 0x1804b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1804fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', '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 03:47:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:47:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:47:14 INFO - Using env: {'DISPLAY': ':0', 03:47:14 INFO - 'HOME': '/home/cltbld', 03:47:14 INFO - 'LANG': 'en_US.UTF-8', 03:47:14 INFO - 'LANGUAGE': 'en_US:en', 03:47:14 INFO - 'LOGNAME': 'cltbld', 03:47:14 INFO - 'MAIL': '/var/mail/cltbld', 03:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:14 INFO - 'MOZ_NO_REMOTE': '1', 03:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:14 INFO - 'NO_EM_RESTART': '1', 03:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:14 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:14 INFO - 'SHELL': '/bin/bash', 03:47:14 INFO - 'SHLVL': '1', 03:47:14 INFO - 'TERM': 'linux', 03:47:14 INFO - 'TMOUT': '86400', 03:47:14 INFO - 'USER': 'cltbld', 03:47:14 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', 03:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:14 INFO - '_': '/tools/buildbot/bin/python'} 03:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:15 INFO - Running setup.py (path:/tmp/pip-bd7spT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:15 INFO - Running setup.py (path:/tmp/pip-Wo6Oxt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:15 INFO - Running setup.py (path:/tmp/pip-erzytm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:15 INFO - Running setup.py (path:/tmp/pip-bpSOhk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:15 INFO - Running setup.py (path:/tmp/pip-jd3Qm1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:15 INFO - Running setup.py (path:/tmp/pip-sGsUa3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:15 INFO - Running setup.py (path:/tmp/pip-mdGCj2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:15 INFO - Running setup.py (path:/tmp/pip-uy0so9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:15 INFO - Running setup.py (path:/tmp/pip-CYXdqZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:15 INFO - Running setup.py (path:/tmp/pip-YF5Z7a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:15 INFO - Running setup.py (path:/tmp/pip-0MEZ1b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:15 INFO - Running setup.py (path:/tmp/pip-7D4JsV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:16 INFO - Running setup.py (path:/tmp/pip-jVLFeC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:16 INFO - Running setup.py (path:/tmp/pip-4VrYW9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:16 INFO - Running setup.py (path:/tmp/pip-8yenQy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:16 INFO - Running setup.py (path:/tmp/pip-kCFqCC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:16 INFO - Running setup.py (path:/tmp/pip-IJWGPS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:47:16 INFO - Running setup.py install for manifestparser 03:47:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:47:16 INFO - Running setup.py install for mozcrash 03:47:16 INFO - Running setup.py install for mozdebug 03:47:16 INFO - Running setup.py install for mozdevice 03:47:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:47:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:47:16 INFO - Running setup.py install for mozfile 03:47:16 INFO - Running setup.py install for mozhttpd 03:47:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:47:17 INFO - Running setup.py install for mozinfo 03:47:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:47:17 INFO - Running setup.py install for mozInstall 03:47:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:47:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:47:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:47:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:47:17 INFO - Running setup.py install for mozleak 03:47:17 INFO - Running setup.py install for mozlog 03:47:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:47:17 INFO - Running setup.py install for moznetwork 03:47:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:47:17 INFO - Running setup.py install for mozprocess 03:47:17 INFO - Running setup.py install for mozprofile 03:47:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:47:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:47:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:47:17 INFO - Running setup.py install for mozrunner 03:47:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:47:17 INFO - Running setup.py install for mozscreenshot 03:47:17 INFO - Running setup.py install for moztest 03:47:18 INFO - Running setup.py install for mozversion 03:47:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:47:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:47:18 INFO - Cleaning up... 03:47:18 INFO - Return code: 0 03:47:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7ff4f799bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1803d70>, '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 0x1804b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1804fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', '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 03:47:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 03:47:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 03:47:18 INFO - Using env: {'DISPLAY': ':0', 03:47:18 INFO - 'HOME': '/home/cltbld', 03:47:18 INFO - 'LANG': 'en_US.UTF-8', 03:47:18 INFO - 'LANGUAGE': 'en_US:en', 03:47:18 INFO - 'LOGNAME': 'cltbld', 03:47:18 INFO - 'MAIL': '/var/mail/cltbld', 03:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:18 INFO - 'MOZ_NO_REMOTE': '1', 03:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:18 INFO - 'NO_EM_RESTART': '1', 03:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:18 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:18 INFO - 'SHELL': '/bin/bash', 03:47:18 INFO - 'SHLVL': '1', 03:47:18 INFO - 'TERM': 'linux', 03:47:18 INFO - 'TMOUT': '86400', 03:47:18 INFO - 'USER': 'cltbld', 03:47:18 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', 03:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:18 INFO - '_': '/tools/buildbot/bin/python'} 03:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:18 INFO - Running setup.py (path:/tmp/pip-DhFx_J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:47:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:18 INFO - Running setup.py (path:/tmp/pip-3RoZsB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:18 INFO - Running setup.py (path:/tmp/pip-ial2yw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:47:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:18 INFO - Running setup.py (path:/tmp/pip-UwWHxC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:18 INFO - Running setup.py (path:/tmp/pip-U9fHLc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:47:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:18 INFO - Running setup.py (path:/tmp/pip-sZEHTE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:47:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:18 INFO - Running setup.py (path:/tmp/pip-XDeviE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:47:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:18 INFO - Running setup.py (path:/tmp/pip-TQgaO8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:47:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:18 INFO - Running setup.py (path:/tmp/pip-b4shJn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:19 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)) 03:47:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:19 INFO - Running setup.py (path:/tmp/pip-MyoqHa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:19 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)) 03:47:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:19 INFO - Running setup.py (path:/tmp/pip-yDBvbd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:19 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)) 03:47:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:19 INFO - Running setup.py (path:/tmp/pip-uOFjVC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:47:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:19 INFO - Running setup.py (path:/tmp/pip-9QD5jJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:47:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:19 INFO - Running setup.py (path:/tmp/pip-40mwAr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:47:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:19 INFO - Running setup.py (path:/tmp/pip-4uKKk8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:47:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:19 INFO - Running setup.py (path:/tmp/pip-M01Fxr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:47:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:19 INFO - Running setup.py (path:/tmp/pip-zhj1Bp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:21 INFO - Downloading blessings-1.5.1.tar.gz 03:47:21 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:47:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:47:21 INFO - Installing collected packages: blessings 03:47:21 INFO - Running setup.py install for blessings 03:47:21 INFO - Successfully installed blessings 03:47:21 INFO - Cleaning up... 03:47:21 INFO - Return code: 0 03:47:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:47:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:47:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:47:21 INFO - Reading from file tmpfile_stdout 03:47:21 INFO - Current package versions: 03:47:21 INFO - argparse == 1.2.1 03:47:21 INFO - blessings == 1.5.1 03:47:21 INFO - blobuploader == 1.2.4 03:47:21 INFO - docopt == 0.6.1 03:47:21 INFO - manifestparser == 1.1 03:47:21 INFO - mozInstall == 1.12 03:47:21 INFO - mozcrash == 0.16 03:47:21 INFO - mozdebug == 0.1 03:47:21 INFO - mozdevice == 0.47 03:47:21 INFO - mozfile == 1.2 03:47:21 INFO - mozhttpd == 0.7 03:47:21 INFO - mozinfo == 0.9 03:47:21 INFO - mozleak == 0.1 03:47:21 INFO - mozlog == 3.1 03:47:21 INFO - moznetwork == 0.27 03:47:21 INFO - mozprocess == 0.22 03:47:21 INFO - mozprofile == 0.27 03:47:21 INFO - mozrunner == 6.11 03:47:21 INFO - mozscreenshot == 0.1 03:47:21 INFO - mozsystemmonitor == 0.0 03:47:21 INFO - moztest == 0.7 03:47:21 INFO - mozversion == 1.4 03:47:21 INFO - psutil == 3.1.1 03:47:21 INFO - requests == 1.2.3 03:47:21 INFO - wsgiref == 0.1.2 03:47:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4f799bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1803d70>, '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 0x1804b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1804fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', '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 03:47:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 03:47:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:47:21 INFO - Using env: {'DISPLAY': ':0', 03:47:21 INFO - 'HOME': '/home/cltbld', 03:47:21 INFO - 'LANG': 'en_US.UTF-8', 03:47:21 INFO - 'LANGUAGE': 'en_US:en', 03:47:21 INFO - 'LOGNAME': 'cltbld', 03:47:21 INFO - 'MAIL': '/var/mail/cltbld', 03:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:21 INFO - 'MOZ_NO_REMOTE': '1', 03:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:21 INFO - 'NO_EM_RESTART': '1', 03:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:21 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:21 INFO - 'SHELL': '/bin/bash', 03:47:21 INFO - 'SHLVL': '1', 03:47:21 INFO - 'TERM': 'linux', 03:47:21 INFO - 'TMOUT': '86400', 03:47:21 INFO - 'USER': 'cltbld', 03:47:21 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', 03:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:21 INFO - '_': '/tools/buildbot/bin/python'} 03:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:47:21 INFO - Cleaning up... 03:47:21 INFO - Return code: 0 03:47:21 INFO - Running post-action listener: _resource_record_post_action 03:47:21 INFO - Running post-action listener: _start_resource_monitoring 03:47:21 INFO - Starting resource monitoring. 03:47:21 INFO - ##### 03:47:21 INFO - ##### Running install step. 03:47:21 INFO - ##### 03:47:21 INFO - Running pre-action listener: _resource_record_pre_action 03:47:21 INFO - Running main action method: install 03:47:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:47:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:47:22 INFO - Reading from file tmpfile_stdout 03:47:22 INFO - Detecting whether we're running mozinstall >=1.0... 03:47:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:47:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:47:22 INFO - Reading from file tmpfile_stdout 03:47:22 INFO - Output received: 03:47:22 INFO - Usage: mozinstall [options] installer 03:47:22 INFO - Options: 03:47:22 INFO - -h, --help show this help message and exit 03:47:22 INFO - -d DEST, --destination=DEST 03:47:22 INFO - Directory to install application into. [default: 03:47:22 INFO - "/builds/slave/test-pgo"] 03:47:22 INFO - --app=APP Application being installed. [default: firefox] 03:47:22 INFO - mkdir: /builds/slave/test-pgo/build/application 03:47:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:47:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:47:36 INFO - Reading from file tmpfile_stdout 03:47:36 INFO - Output received: 03:47:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:47:36 INFO - Running post-action listener: _resource_record_post_action 03:47:36 INFO - ##### 03:47:36 INFO - ##### Running run-tests step. 03:47:36 INFO - ##### 03:47:36 INFO - Running pre-action listener: _resource_record_pre_action 03:47:36 INFO - Running main action method: run_tests 03:47:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:47:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:47:36 INFO - Python 2.7.3 03:47:36 INFO - Return code: 0 03:47:36 INFO - grabbing minidump binary from tooltool 03:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:36 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1803d70>, '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 0x1804b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1804fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:47:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:47:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:47:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:47:36 INFO - Return code: 0 03:47:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:47:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:47:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:47:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:47:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:47:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:47:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 03:47:36 INFO - Using env: {'DISPLAY': ':0', 03:47:36 INFO - 'HOME': '/home/cltbld', 03:47:36 INFO - 'LANG': 'en_US.UTF-8', 03:47:36 INFO - 'LANGUAGE': 'en_US:en', 03:47:36 INFO - 'LOGNAME': 'cltbld', 03:47:36 INFO - 'MAIL': '/var/mail/cltbld', 03:47:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:47:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:36 INFO - 'MOZ_NO_REMOTE': '1', 03:47:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:47:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:36 INFO - 'NO_EM_RESTART': '1', 03:47:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:36 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:47:36 INFO - 'SHELL': '/bin/bash', 03:47:36 INFO - 'SHLVL': '1', 03:47:36 INFO - 'TERM': 'linux', 03:47:36 INFO - 'TMOUT': '86400', 03:47:36 INFO - 'USER': 'cltbld', 03:47:36 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739', 03:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:36 INFO - '_': '/tools/buildbot/bin/python'} 03:47:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 03:47:36 INFO - mozversion INFO | application_buildid: 20151121013100 03:47:36 INFO - mozversion INFO | application_changeset: c3aa84cd334c17606ff33284a058064eafd67d28 03:47:36 INFO - mozversion INFO | application_display_name: Nightly 03:47:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:47:36 INFO - mozversion INFO | application_name: Firefox 03:47:36 INFO - mozversion INFO | application_remotingname: firefox 03:47:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:47:36 INFO - mozversion INFO | application_vendor: Mozilla 03:47:36 INFO - mozversion INFO | application_version: 45.0a1 03:47:36 INFO - mozversion INFO | platform_buildid: 20151121013100 03:47:36 INFO - mozversion INFO | platform_changeset: c3aa84cd334c17606ff33284a058064eafd67d28 03:47:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:47:36 INFO - mozversion INFO | platform_version: 45.0a1 03:47:36 INFO - 2015-11-21 03:47:36,929 DEBUG : using testdate: 1448106456 03:47:36 INFO - 2015-11-21 03:47:36,929 DEBUG : actual date: 1448106456 03:47:36 INFO - 2015-11-21 03:47:36,942 INFO : starting webserver on 'localhost:49375' 03:47:36 INFO - 2015-11-21 03:47:36,943 INFO : Starting test suite talos-linux64-ix-017 03:47:36 INFO - 2015-11-21 03:47:36,943 INFO : Starting test dromaeo_css 03:47:36 INFO - 2015-11-21 03:47:36,943 DEBUG : operating with platform_type : linux_ 03:47:36 INFO - 2015-11-21 03:47:36,944 INFO : Initialising browser for dromaeo_css test... 03:47:36 INFO - 2015-11-21 03:47:36,959 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7FOYgS/profile http://localhost:49375/getInfo.html 03:47:41 INFO - 2015-11-21 03:47:41,051 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:47:41 INFO - 2015-11-21 03:47:41,051 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:47:41 INFO - 2015-11-21 03:47:41,051 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:47:41 INFO - 2015-11-21 03:47:41,051 DEBUG : BROWSER_OUTPUT: __metrics 03:47:41 INFO - 2015-11-21 03:47:41,127 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:47:42 INFO - 2015-11-21 03:47:42,328 INFO : Browser initialized. 03:47:42 INFO - 2015-11-21 03:47:42,329 INFO : Running cycle 1/1 for dromaeo_css test... 03:47:42 INFO - 2015-11-21 03:47:42,329 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7FOYgS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:47:54 INFO - 2015-11-21 03:47:54,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 142172160 03:47:54 INFO - 2015-11-21 03:47:54,072 DEBUG : BROWSER_OUTPUT: 03:48:44 INFO - 2015-11-21 03:48:44,902 DEBUG : BROWSER_OUTPUT: 1448106524901 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] 03:50:54 INFO - 2015-11-21 03:50:54,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49375/tests/dromaeo/cssquery-ext.html) 03:50:56 INFO - 2015-11-21 03:50:56,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 260947968 03:50:56 INFO - 2015-11-21 03:50:56,147 DEBUG : BROWSER_OUTPUT: 03:53:58 INFO - 2015-11-21 03:53:58,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-ext.html (next: http://localhost:49375/tests/dromaeo/cssquery-jquery.html) 03:53:59 INFO - 2015-11-21 03:53:59,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 213274624 03:53:59 INFO - 2015-11-21 03:53:59,091 DEBUG : BROWSER_OUTPUT: 03:57:01 INFO - 2015-11-21 03:57:01,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49375/tests/dromaeo/cssquery-mootools.html) 03:57:01 INFO - 2015-11-21 03:57:01,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 212295680 03:57:01 INFO - 2015-11-21 03:57:01,629 DEBUG : BROWSER_OUTPUT: 04:00:03 INFO - 2015-11-21 04:00:03,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49375/tests/dromaeo/cssquery-prototype.html) 04:00:03 INFO - 2015-11-21 04:00:03,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 199331840 04:00:03 INFO - 2015-11-21 04:00:03,995 DEBUG : BROWSER_OUTPUT: 04:03:06 INFO - 2015-11-21 04:03:06,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49375/tests/dromaeo/cssquery-yui.html) 04:03:07 INFO - 2015-11-21 04:03:07,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 203829248 04:03:07 INFO - 2015-11-21 04:03:07,003 DEBUG : BROWSER_OUTPUT: 04:06:09 INFO - 2015-11-21 04:06:09,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-yui.html (next: http://localhost:49375/tests/dromaeo/cssquery-dojo.html) 04:06:09 INFO - 2015-11-21 04:06:09,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 227782656 04:06:09 INFO - 2015-11-21 04:06:09,869 DEBUG : BROWSER_OUTPUT: 04:06:09 INFO - 2015-11-21 04:06:09,869 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:06:09 INFO - 2015-11-21 04:06:09,869 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:06:09 INFO - 2015-11-21 04:06:09,869 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:06:09 INFO - 2015-11-21 04:06:09,870 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:06:09 INFO - 2015-11-21 04:06:09,870 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3158.368326334733;3237.190702324419;3286.408446479633;3286.5727455430806;3316.8839090631827;5299.867503312419;5408.756605952732;5442.537384322332;5444.128939369702;5464.590155738316;5416.862458883629;5449;5466.34403871535;5482.259894914196;5559.804642001969;4943.777530011149;5009.04828082665;5013.849584512453;5037.4710655381205;5046.722430266353;4830.299606557047;5084.3644544431945;5092.439831618519;5122.15484445068;5152.969406118791;4883.584895283923;4904.803807847682;4956.40523137224;4967.900641987176;4982.6761260518315;4992.400911890596;5001.8499445016705;5009.298698182258;5017.172166592508;5042.243663450475;4830.8792280193275;4931.186354251544;4970.353853998993;4972.5276098770555;5003.399592048978;5239.5546378557865;5269.578433725293;5287.048331300364;5289.312389389354;5315.335583052119;5894.58737888348;5952.1964534787685;5958.314793798725;5968.850778730523;5969.164316995624;5778.046622307356;5887.146363777271;5913.556483263773;5967.671778052206;5992.43071908168;5444.6188766785945;5500.4499550044675;5516.951779161946;5522.751476183541;5567.526760225345;5977.790777322773;6083.787067452707;6091.511430256314;6098.207233059674;6105.48103411215;5585.469380408855;5732.226149469851;5780.248567686174;5940.79207227745;5956.076808094752;5960.165576819249;5961.850953726105;5967.671778052249;5970.9701451492465;6017.518598512196;5870.7945221917025;5892.882142357214;5942.138389933435;5952.910706339322;5955.374685657944;5674.4892959633835;5806.564507661942;5817.185594016841;5846.181534585162;5886.705664716747;4484.775761211927;4526.6152377047665;4528.230200865861;4537.3647689323525;4577.0159415725775;4047.716659833842;4062.106336605942;4079.8776036718946;4089.5297040840683;4107.527634322091;5327.547158491571;5427.240186373911;5643.351014633287;5645.520130788929;5664.20701101846;5851.61964472308;5895.145203945404;5943.465088142088;5963.821085367446;6013.4888534474185;5456.263404440349;5486.259354987105;5499.560035197174;5503.669779813224;5550.777968881281;4989.501049894981;5057.31726216956;5068.467810879878;5084.415292241366;5089.185730283137;5904.7933322334375;5947.9405205949115;5961.225040744675;5968.791092311835;6017.458428741435;5823.155642431909;5972.701364931823;5983.850403739942;5988.880222395441;6003.549733770072;5861.560382971209;5998.3401825798255;6127.724252408563;6146.446819786241;6159.753609855556;5722.771089156554;5756.769729210785;5761.193432919311;5775.6823374714795;5807.8548036299435;5912;5936.910946335895;5970.582059255984;5976.46211840919;5988.910166347421;5452.618316717951;5785.334686510937;5808.94191058084;5835.503982161394;5842.912356314744;5684.261046063985;5723.542116630742;5748.6838223898085;5778.479936805707;5824.767009319579;5645.435456454322;5660.462256085665;5674.631148975303;5684.289463817023;5685.744141513725;5508.476694713996;5652.660840349427;5727.455891690282;5797.826065218051;5800.419958004166;5659.830205093854;5744.339400968942;5772.855678607901;5782.566307527037;5826.504747096545 04:06:09 INFO - 2015-11-21 04:06:09,871 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.8313864271396;589.7346194212605;606.9241344831895;610.41095342994;610.5634471352985;30143.69856301439;30938;30943.38113237734;40088.39867401984;40374.39438408426;41136;41560;41592.79203603978;41706.58293417073;41758.16483670325;8751.86872196916;8841.071687472819;8912.910870891274;8917.910820891806;8936.776580585505;7777.2222777722345;7923.247291507327;8610.87083693742;10504.78990420191;10726.03465688088;10495.685129446128;10614.787704245911;10620.256582039261;10625.25623206372;10625.84061239082;7851.411144164211;10391.064804167623;10435.582576696923;10506.52720627566;10509.84235236472;7626.771196864048;10505.78988420235;10728.356298622108;10740.892591074067;10752.838707419394;38318.61681383178;38460;38731.8380448587;38753.22493550113;38795.22409551793;3340.5323254744353;3356.47974563943;3469.0286719718265;3512.2799826035857;3667.7065834733426;29232.70767292321;29745.25636859074;29766.851165744032;29910.252243693863;30079.248018799706;3403.3873902697505;3407.812570308632;3419.128122328815;3480.095175254427;3498.7201023918024;264029;264664;266375;266460;266732.666336669;52529.737351313;59410.10884836731;59595.70202148962;59687.701561491915;59856.401435985084;49093.2636010453;68792.31207687859;70762.29237707557;70848.64575677089;70907;15060.924695376452;15148.091114533163;15270.31283592241;15345.693086138215;15360.769588456182;11390.487428065757;11484.712882177846;11506.194566380273;11534.192606517463;11556.479958401893;20137.899310503646;20428.59142817165;20432.387028389174;20467.79532204659;20521;7486.401087913063;7672.616369181518;7786.610669466504;7801.726939557088;7805.4824221774315;872.5986046418718;921.5392303848076;926.559884055082;1000.6047611193537;1084.295208114716;27765.167044988684;28565.428691426056;28675;28804.42391152165;29021.274468138043;997.1972562087589;1009.6970908727352;1035.2701345551368;1117.9105671546256;1118.5246270335076;14205.289735513183;14719.55841324762;14761.483348082766;14908.850911490747;14993.17537535446;321186;325036;325087;325108;325439;50764.49235507598;50785.492145078075;50912.49087509151;50983;51000.489995099575;1326.1512631915582;1333.2533781082625;1336.3719052045524;1339.926304053267;1340.5509154433373;26339.341516461474;27477.31306717348;27513.44973100567;27700.307492312855;27900.16299511018;45776.771116144206;46034.539654603024;46041.53958460507;46065.76967115277;46070.76964615155;303836;304168;304172;304812;305150;27494.312642184104;27982;30505.389892201587;31319.686803131677;31790.52314215335;37028.81485592555;37374;37531.06172345713;37710.434343485416;37988.81005594954;31553.52669710002;31836.52245216277;31939.36121277515;32079.35841283208;32345.676543234265;29008.12975610735;33525.329493410485;34040.48939265864;34210.48684269688;37699;34534.82732586321;34906.12734681653;35076;35081.473777893865;35140.12149696278;31535.684643153276;31834.840825795724;32037.252155010647;32092;32109.839450802596;22264.554708906056;22338.853045162887;22607.88696056509;22809.771902281427;22815.201467948544 04:06:09 INFO - 2015-11-21 04:06:09,874 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.1647653299946;356.47598030894574;356.74670983601624;361.7937775467983;363.84718418264333;14817.110973341607;14994.325255363508;16514.256858441368;16833.15834208291;17599.736003959933;10305.948470257637;10540.525676344563;16374.918125409386;17490.56273593161;17493.300267989263;4663.277192035232;4775.2598347256235;4783.354247176621;4786.952130478703;4787.066522028188;3723.957291958256;3803.3724435468116;4755.595774359183;4792.688475249115;5128.666636668605;5303.496167864047;5304.575633949275;5326.7070311132875;5342.652727572715;5347.839564813062;5193.298904647881;5284.577233821324;5289.550388217006;5319.7340132993195;5322.20166974953;5125.051865404912;5130.51260130287;5134.127198376285;5134.255532947702;5134.794608215667;11930.164888457812;17316.65366692659;19926.70109948352;20431.591368172703;20487.180512779472;2200.1309482754223;2218.279059305716;2256.435891027243;2260.581792368417;2304.7003889494426;8936.106389361077;9041.186293233575;9055.954720226422;9122.908770912272;9222.40054396462;1741.7300318450662;1822.1891258390021;1823.7811462624438;1842.5854182808894;1887.8489720822301;63332.366676333106;63741.681291593246;64673.3532664672;66347.3365266346;69398.65300673514;15652.843471565366;16131.274092665859;16263;16268.593285167728;16379.181040947906;25301.873490632795;25382.873085634452;25436.872815636172;25464.236072917844;25585.360365991;8809.735707928772;8860.158284962918;8906.910930890737;8960.551972401354;8986.415882967585;7458.105027396748;7500.587467689329;7537.170911199763;7552.8489430212185;7575.886361704579;7867.527948323119;7921.801954951173;7933.484323519068;7979.880301795478;8032.638531266107;1812.7009043507937;1827.4883032750852;2261.118163916074;3048.679888611664;3156;924.5331107790523;940.9341346105844;983;1001.2990906365428;1019.4036488654073;15790.763138552931;16082.839171608368;16605.66788664244;17897;18353.449396518125;886.4326830828275;923.7690577355661;952.7141857442739;952.7760976170595;998.4458625462938;8385.287250583646;9263.76840578991;9678.95160524193;9689.78877640295;9880.061394167686;510415;518726.72096150805;528321;532192;532636;77224;77689.611551943;77952;77952.22047779564;78836;1152.1704372851534;1157.2130950953265;1166.8658104317942;1172.806486929664;1174.7944109780753;15766.684666306839;15804;15855.762163567786;15974;16215.35138594443;35040.29919401649;35448;36308.455373168894;36657.26685466329;36987.81506092452;45169.54830451785;47449.28826067543;47852.28221576609;47917.76041119772;48538.5146148534;14430.783538247144;14623;14637.194954277616;14877.702445951238;14882.702345953237;9378.390404623678;10068.345557538736;10513.369197848153;17695.46913592594;18898.622027559646;8568.828623427622;9378.296627752808;9450.480223587494;9465.810683786423;9596.136347728738;9203.585838637411;9253.953730231306;9272.953635231781;9383.530823458663;9390.24878009744;9303.76740581491;9478.57346419399;9503.524823758922;9504.239660827256;9845.064718851698;14056.367463464374;14376.784348234576;14712;14965.92517037408;15263.3894644213;14291.142531448146;14400;14461.710765784836;15242.923785381003;15247.3901043957 04:06:09 INFO - 2015-11-21 04:06:09,875 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1318.433073778275;1462.2542503323305;1514.432087967012;1637.6315329050965;1760.683077046131;6531.118299029636;6978.930210697891;7170.211276759559;7174.426045916327;7175.605341706204;7259.6370181490975;7388.704451821921;7396;7424.220456852034;7442.18136005039;1931.2082046360995;1956.1392987085637;2209.1605190027767;2259.9887000564972;2278.532900755341;2212.7123473948445;2220.733511978565;2222.955540889181;2228.019671344603;2232.687423760675;2163.145557504785;2245.517213799033;2246.4945387287894;2249.134083377895;2249.4601295689;1928.2287085165976;1973.052934591397;2211.8783466909313;2243.7868402501736;2245.6294711372766;2246;2263.2531264682616;2285.382946604424;2294.862308261493;2317.9768202317928;7297.160826504967;7349.926500734978;7357.227491113463;7358.337749602561;7367.8894816577795;4558.544145585448;4633.513481084505;4638.489766125724;4659.813607455698;4663.253879379283;2986.507226307678;2987.910362689123;3033.63596368435;3034.1201051694984;3085.537169424582;1049.3861091261545;1054.219877290807;1063.9468026598638;1079.2445288298222;1090.4166271045033;10419;10485.947570262177;10533.36799792015;10550.472476376228;10558.736031599195;4107.137501124797;4226.2392769301205;4229.703920725519;4232.746035237896;4275.700700950903;8959;8993.55032248385;9030.187283144549;9046.095390460901;9052;4643.326717625925;4668.743219122913;4691.038337140878;4697;4697.224957881979;4207.537170911197;4256.2551553478015;4259.61663450291;4260.531341552427;4260.723053001545;3510.7191424685966;3557.839897204632;3616.294822509638;3623.782573045573;3634.0914771307175;1197.1978774221293;1205.9276443413423;1206.7164216409137;1214.4474264209764;1221.1879100398135;1311.849137349198;1322.4379638653727;1335.4391155714623;1349.298364850292;1349.709812390321;7017.017617533549;7125.75059872902;7264.128304603376;7271.963640181871;7294.234105418961;487.4613552025032;492.396813902966;503.12958581653214;503.1773051061468;506.501096420026;5617.129344951539;5685.687287199244;5697.401772813878;5732.254806875079;5737.913931291034;8674.262687671619;9068.455892646462;9110.590023448829;9139.040400757958;9327;8934.374593778373;9138.954305228564;9179.632814687471;9191.724248272563;9225.308101892251;6854.931450685529;6913.481488888253;7138;7145.499815013003;7145.785626431215;6830.795076147723;6866.313368663094;6874.553154044971;6876.862462750817;6879.552829066095;7733.806654833449;8129.227723366271;8137.633806478604;8146.877796833171;8195.836083278182;8243.793905152179;8350.707725229831;8355.874661880198;8494.447860889022;8502.532360720219;6491.967540162269;6520.804375868732;6540.705668244846;6563.442107420923;6601.933980660132;7477.925220747723;7536.886946695694;7542.698292068256;7545.094588649177;7549.2073332299315;5546.362168350692;6712.228093769279;6750.05499230118;6894.517383783288;7187.820304492429;6770.187577490733;6813.318668133147;6817.522773405814;6861.073755043005;6910.308969103251;6741.460683145435;6851.794446166623;6916.861662766817;6950.8609827804175;6954.826129346807;6191.535634827496;6215.471684906834;6219.253689557282;6227.844303892439;6228.28374736893;6247.875042499216;6265.686715664107;6320.273168585488;6341.7780377688405;6420.935790642221 04:06:09 INFO - 2015-11-21 04:06:09,875 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.7326342923084;298.9491786396312;303.8101186758276;306.19928885963213;307.78455081442996;6027.126066720323;6057.363976782435;6079.11852781347;6166.506679465643;6192.72132754026;6056.061310496869;6058.666773327465;6066.30237522685;6076.817695469132;6090.269167699882;4404.427424434819;4629.259318509039;4631.120087183441;4631.143238500871;4639.907201855961;4493.483249426309;4524.2082635538645;4637.04940487201;4641.767911604406;4647.117047760915;4548.113117942003;4549.203889319372;4571.428571428572;4572.382728331666;4573.176828170945;4323.524412314643;4418.1605494956175;4466.12910482456;4573.748443835588;4584.908301833962;3978.5424676162324;4003.2994226010624;4009.699272554541;4010.6189911958318;4015.0765323975647;5766.596338256324;5772.163036359746;5772.7113644317615;5773.769049238025;5779.711014449303;5283.6037297202865;5300.787968481256;5301.3373328333955;5304.840854774363;5350.180938480935;6297.716602752887;6428.19647544057;6428.967855160741;6431.935680643227;6435.806925792233;4406.25093734066;4416.6025057744955;4420.602145806893;4424.513303536608;4432.867013989586;6692.531522793406;6696.363845434676;6701.698423570902;6701.832454188684;6705.932940670579;4435.3125265583885;4493.842715504941;4528.117017181618;4528.184926713157;4538.977305113519;4580.748058856795;4581.427321584802;4582.518835522289;4583.977080114578;4585.518520555293;5299.31108955841;5325.547328477045;5334.333208348957;5334.946650533522;5339.652922560022;6540.901886471706;6543.051257567721;6553.082568440422;6553.442957348583;6558.114654521674;1588.7060893734697;1601.927913243907;1619.8947068440514;1625.1305551529874;1626.9430569929996;1053.1574740207957;1076.3272954403499;1079.8164312066967;1083.3066837224183;1087.065123993365;6271.62370257786;6272.027835685385;6277.5605707600025;6280.340564240781;6283.968580157161;6671.132752742113;6713.093732346071;6713.0937323461685;6720.22717387497;6728.091707619409;6093.786717464867;6242.5942313750365;6243.43809057178;6250.874982500324;6255;3518.5425894633536;3614.7469677122876;3619.4570814378053;3620.5474315710535;3621.3300539400293;6751.729930802811;6940.063091482585;6999.160100787938;7008.684609192598;7024.367806897404;6960.37356637905;6963.79108626742;6966.9303306967295;6985.406240469617;6988.79033628992;6842.692078856364;6954.061201737802;6959;6975.651217439107;6979.755708550177;6726.327367263235;6756.871585450567;6762.898556521558;6766.7969960901255;6767.627780472121;6648.966755166193;6670.933290667225;6683.9639855822425;6686.732530698718;6697.531172817856;6804.829879253059;7029.824254393681;7034.683439245144;7035.507514473938;7040.823979400556;4423.62399196072;4453.866384008485;4457.064016556559;4461.152381047591;4464.642828573771;6761.966190169214;6791;6799.2520822708475;6805.353491418307;6806.319368063154;6476.319986401549;6608.8347791305605;6618.238902526078;6619.27188009309;6620.404163625297;6574.408303252731;6580.045893345534;6587.341265873374;6593.571417857824;6598.736050558116;6386.68066596659;6488;6492.31830657793;6494.577852439576;6503.25212600557;6642.933570664231;6646.700898459484;6649.767258146136;6649.966750166412;6657.367550082734;6464.515161362822;6471.417572418317;6473.902891456726;6478;6486 04:06:09 INFO - 2015-11-21 04:06:09,876 DEBUG : BROWSER_OUTPUT: |5;yui.html;744.7132853851266;796.1878883538791;823.7693445835166;830.3979614779286;850.1583432401924;10162.542685579148;10181.389116652997;10208.897911020897;10240.692779216617;10301.742456438575;12166.75666486672;12459.439325230363;12880;12976.610701678941;13048.934755326234;793.9325157361617;803.1045384396415;803.337246771416;803.4737247103157;804.5012092502627;803.4135081390589;804.2560631415946;804.8189157439588;804.859149648812;805.8106345008919;840.4285086141422;842.2125312832521;844.5819319436887;850.2857599616322;852.6333676519125;843.633019636457;845.0915266088948;846.851800934837;850.4684572142411;852.2713080316364;614.7878981751288;616.2389449030444;616.2389449030488;617.3641149615858;623.8502759337772;12199.268043917393;12351.752964940652;12352.197107188003;12355.691107722289;12358.44387002587;10663.946680266548;10782.299150555189;10854.511546980404;11036.11711063121;11247.268927519684;9831.852522212173;9842.409455432697;9855.655052073143;9901.35641183328;9954.800903981879;3708.4251940948925;3711.4432835074685;3717.237966216919;3773.5094437723196;3841.0397400649836;39848.40227396591;40667.55994640302;44403.333949990774;45091.54908450939;46516.76741616304;8726.132459854593;9650.420974741539;9850.408975461496;9954.303198776017;10387.428691421894;15114;16365.918170409072;16548.669026619402;16594.6681066378;16620.501384958472;7123.536970096927;7166.820829479305;7275.599842008634;7595.810104747315;7608.619569021637;4162.521310049323;4375.5405682403525;4411.139827733561;4425.535318791481;4427.313766366218;3138.544910987894;3170.556122142902;3170.6353769316825;3171.3657268546385;3173.2225604726527;568.8435680187981;569.2855466389655;570.7916610437161;573.3320681406199;585.4467528185824;642.6497558830449;663.7477758451757;667.7462564225564;681.3561184680528;683.9145106861642;7649.770506884803;8127.471714338549;8293.377996650275;8393.580320983927;8459.407841451039;636.522608043967;644.4296797334299;654.7053825778419;668.7458765669014;696.2271878215178;3685.7972811495624;3693.575238847513;3768.2086761779783;3881.5536213335263;3888.202918401721;56098.71950640221;56840.758090077536;57413.13880291799;57517.424825752045;58043.70978145167;49493;50196.74901625468;50637.74681126644;50707.74646126746;51156.48843511517;46038;46290.30564541535;46308.3053754194;47131.29303060457;48149.74053373039;7427.740029098955;7541.811454713676;7610.124835643972;7642.5032372895585;7743.883841742266;34783;35113.824430877685;35293.82353088218;35871.82064089663;36529.26941461103;38714.22571548609;39613.207735845695;42846.57153428426;42922.78538607287;43694;10350.430726310125;10516.894831051897;10808.351498910091;10849.186311026546;10873.619423320146;11314.943425282821;11611.303321800719;11694.766104678029;11924.165308428326;11980.820287695866;9959.850602240827;9966.152877005246;10107.444090575089;10430.895691043295;10577.100946419641;10427.791444170922;10652.041316281571;10704.411257380607;10971.890281097407;11000.669979900296;10821.404822734825;10919.126469882549;11119.610813621484;11220.1023918088;11261.943690281496;9055.501947392957;9212;9238.584263708015;9339.85990210161;9583.664571739955;8688.739337819876;8787.209151176425;8992.997337015278;9058.728238152866;9588.857773041616 04:06:09 INFO - 2015-11-21 04:06:09,876 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:06:09 INFO - 2015-11-21 04:06:09,876 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:06:09 INFO - 2015-11-21 04:06:09,876 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1014 04:06:09 INFO - 2015-11-21 04:06:09,876 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:06:09 INFO - 2015-11-21 04:06:09,876 DEBUG : BROWSER_OUTPUT: __startTimestamp1448107569865__endTimestamp 04:06:09 INFO - 2015-11-21 04:06:09,876 DEBUG : BROWSER_OUTPUT: 04:06:09 INFO - 2015-11-21 04:06:09,877 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:06:09 INFO - 2015-11-21 04:06:09,877 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:06:09 INFO - 2015-11-21 04:06:09,877 DEBUG : BROWSER_OUTPUT: 04:06:09 INFO - 2015-11-21 04:06:09,877 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5463.12 Median:5674.49 stddev:614.64 (10.8%) stddev-sans-first:589.34 04:06:09 INFO - 2015-11-21 04:06:09,877 DEBUG : BROWSER_OUTPUT: Values: 3158.4 3237.2 3286.4 3286.6 3316.9 5299.9 5408.8 5442.5 5444.1 5464.6 5416.9 5449.0 5466.3 5482.3 5559.8 4943.8 5009.0 5013.8 5037.5 5046.7 4830.3 5084.4 5092.4 5122.2 5153.0 4883.6 4904.8 4956.4 4967.9 4982.7 4992.4 5001.8 5009.3 5017.2 5042.2 4830.9 4931.2 4970.4 4972.5 5003.4 5239.6 5269.6 5287.0 5289.3 5315.3 5894.6 5952.2 5958.3 5968.9 5969.2 5778.0 5887.1 5913.6 5967.7 5992.4 5444.6 5500.4 5517.0 5522.8 5567.5 5977.8 6083.8 6091.5 6098.2 6105.5 5585.5 5732.2 5780.2 5940.8 5956.1 5960.2 5961.9 5967.7 5971.0 6017.5 5870.8 5892.9 5942.1 5952.9 5955.4 5674.5 5806.6 5817.2 5846.2 5886.7 4484.8 4526.6 4528.2 4537.4 4577.0 4047.7 4062.1 4079.9 4089.5 4107.5 5327.5 5427.2 5643.4 5645.5 5664.2 5851.6 5895.1 5943.5 5963.8 6013.5 5456.3 5486.3 5499.6 5503.7 5550.8 4989.5 5057.3 5068.5 5084.4 5089.2 5904.8 5947.9 5961.2 5968.8 6017.5 5823.2 5972.7 5983.9 5988.9 6003.5 5861.6 5998.3 6127.7 6146.4 6159.8 5722.8 5756.8 5761.2 5775.7 5807.9 5912.0 5936.9 5970.6 5976.5 5988.9 5452.6 5785.3 5808.9 5835.5 5842.9 5684.3 5723.5 5748.7 5778.5 5824.8 5645.4 5660.5 5674.6 5684.3 5685.7 5508.5 5652.7 5727.5 5797.8 5800.4 5659.8 5744.3 5772.9 5782.6 5826.5 04:06:09 INFO - 2015-11-21 04:06:09,877 DEBUG : BROWSER_OUTPUT: 04:06:09 INFO - 2015-11-21 04:06:09,877 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46317.35 Median:32058.31 stddev:78291.41 (244.2%) stddev-sans-first:78435.64 04:06:09 INFO - 2015-11-21 04:06:09,878 DEBUG : BROWSER_OUTPUT: Values: 552.8 589.7 606.9 610.4 610.6 30143.7 30938.0 30943.4 40088.4 40374.4 41136.0 41560.0 41592.8 41706.6 41758.2 8751.9 8841.1 8912.9 8917.9 8936.8 7777.2 7923.2 8610.9 10504.8 10726.0 10495.7 10614.8 10620.3 10625.3 10625.8 7851.4 10391.1 10435.6 10506.5 10509.8 7626.8 10505.8 10728.4 10740.9 10752.8 38318.6 38460.0 38731.8 38753.2 38795.2 3340.5 3356.5 3469.0 3512.3 3667.7 29232.7 29745.3 29766.9 29910.3 30079.2 3403.4 3407.8 3419.1 3480.1 3498.7 264029.0 264664.0 266375.0 266460.0 266732.7 52529.7 59410.1 59595.7 59687.7 59856.4 49093.3 68792.3 70762.3 70848.6 70907.0 15060.9 15148.1 15270.3 15345.7 15360.8 11390.5 11484.7 11506.2 11534.2 11556.5 20137.9 20428.6 20432.4 20467.8 20521.0 7486.4 7672.6 7786.6 7801.7 7805.5 872.6 921.5 926.6 1000.6 1084.3 27765.2 28565.4 28675.0 28804.4 29021.3 997.2 1009.7 1035.3 1117.9 1118.5 14205.3 14719.6 14761.5 14908.9 14993.2 321186.0 325036.0 325087.0 325108.0 325439.0 50764.5 50785.5 50912.5 50983.0 51000.5 1326.2 1333.3 1336.4 1339.9 1340.6 26339.3 27477.3 27513.4 27700.3 27900.2 45776.8 46034.5 46041.5 46065.8 46070.8 303836.0 304168.0 304172.0 304812.0 305150.0 27494.3 27982.0 30505.4 31319.7 31790.5 37028.8 37374.0 37531.1 37710.4 37988.8 31553.5 31836.5 31939.4 32079.4 32345.7 29008.1 33525.3 34040.5 34210.5 37699.0 34534.8 34906.1 35076.0 35081.5 35140.1 31535.7 31834.8 32037.3 32092.0 32109.8 22264.6 22338.9 22607.9 22809.8 22815.2 04:06:09 INFO - 2015-11-21 04:06:09,878 DEBUG : BROWSER_OUTPUT: 04:06:09 INFO - 2015-11-21 04:06:09,879 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28823.41 Median:26102.44 stddev:85715.13 (328.4%) stddev-sans-first:85928.92 04:06:09 INFO - 2015-11-21 04:06:09,879 DEBUG : BROWSER_OUTPUT: Values: 353.2 356.5 356.7 361.8 363.8 14817.1 14994.3 16514.3 16833.2 17599.7 10305.9 10540.5 16374.9 17490.6 17493.3 4663.3 4775.3 4783.4 4787.0 4787.1 3724.0 3803.4 4755.6 4792.7 5128.7 5303.5 5304.6 5326.7 5342.7 5347.8 5193.3 5284.6 5289.6 5319.7 5322.2 5125.1 5130.5 5134.1 5134.3 5134.8 11930.2 17316.7 19926.7 20431.6 20487.2 2200.1 2218.3 2256.4 2260.6 2304.7 8936.1 9041.2 9056.0 9122.9 9222.4 1741.7 1822.2 1823.8 1842.6 1887.8 63332.4 63741.7 64673.4 66347.3 69398.7 15652.8 16131.3 16263.0 16268.6 16379.2 25301.9 25382.9 25436.9 25464.2 25585.4 8809.7 8860.2 8906.9 8960.6 8986.4 7458.1 7500.6 7537.2 7552.8 7575.9 7867.5 7921.8 7933.5 7979.9 8032.6 1812.7 1827.5 2261.1 3048.7 3156.0 924.5 940.9 983.0 1001.3 1019.4 15790.8 16082.8 16605.7 17897.0 18353.4 886.4 923.8 952.7 952.8 998.4 8385.3 9263.8 9679.0 9689.8 9880.1 510415.0 518726.7 528321.0 532192.0 532636.0 77224.0 77689.6 77952.0 77952.2 78836.0 1152.2 1157.2 1166.9 1172.8 1174.8 15766.7 15804.0 15855.8 15974.0 16215.4 35040.3 35448.0 36308.5 36657.3 36987.8 45169.5 47449.3 47852.3 47917.8 48538.5 14430.8 14623.0 14637.2 14877.7 14882.7 9378.4 10068.3 10513.4 17695.5 18898.6 8568.8 9378.3 9450.5 9465.8 9596.1 9203.6 9254.0 9273.0 9383.5 9390.2 9303.8 9478.6 9503.5 9504.2 9845.1 14056.4 14376.8 14712.0 14965.9 15263.4 14291.1 14400.0 14461.7 15242.9 15247.4 04:06:09 INFO - 2015-11-21 04:06:09,879 DEBUG : BROWSER_OUTPUT: 04:06:09 INFO - 2015-11-21 04:06:09,879 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5296.50 Median:5964.72 stddev:2747.55 (46.1%) stddev-sans-first:2738.99 04:06:09 INFO - 2015-11-21 04:06:09,879 DEBUG : BROWSER_OUTPUT: Values: 1318.4 1462.3 1514.4 1637.6 1760.7 6531.1 6978.9 7170.2 7174.4 7175.6 7259.6 7388.7 7396.0 7424.2 7442.2 1931.2 1956.1 2209.2 2260.0 2278.5 2212.7 2220.7 2223.0 2228.0 2232.7 2163.1 2245.5 2246.5 2249.1 2249.5 1928.2 1973.1 2211.9 2243.8 2245.6 2246.0 2263.3 2285.4 2294.9 2318.0 7297.2 7349.9 7357.2 7358.3 7367.9 4558.5 4633.5 4638.5 4659.8 4663.3 2986.5 2987.9 3033.6 3034.1 3085.5 1049.4 1054.2 1063.9 1079.2 1090.4 10419.0 10485.9 10533.4 10550.5 10558.7 4107.1 4226.2 4229.7 4232.7 4275.7 8959.0 8993.6 9030.2 9046.1 9052.0 4643.3 4668.7 4691.0 4697.0 4697.2 4207.5 4256.3 4259.6 4260.5 4260.7 3510.7 3557.8 3616.3 3623.8 3634.1 1197.2 1205.9 1206.7 1214.4 1221.2 1311.8 1322.4 1335.4 1349.3 1349.7 7017.0 7125.8 7264.1 7272.0 7294.2 487.5 492.4 503.1 503.2 506.5 5617.1 5685.7 5697.4 5732.3 5737.9 8674.3 9068.5 9110.6 9139.0 9327.0 8934.4 9139.0 9179.6 9191.7 9225.3 6854.9 6913.5 7138.0 7145.5 7145.8 6830.8 6866.3 6874.6 6876.9 6879.6 7733.8 8129.2 8137.6 8146.9 8195.8 8243.8 8350.7 8355.9 8494.4 8502.5 6492.0 6520.8 6540.7 6563.4 6601.9 7477.9 7536.9 7542.7 7545.1 7549.2 5546.4 6712.2 6750.1 6894.5 7187.8 6770.2 6813.3 6817.5 6861.1 6910.3 6741.5 6851.8 6916.9 6950.9 6954.8 6191.5 6215.5 6219.3 6227.8 6228.3 6247.9 6265.7 6320.3 6341.8 6420.9 04:06:09 INFO - 2015-11-21 04:06:09,879 DEBUG : BROWSER_OUTPUT: 04:06:09 INFO - 2015-11-21 04:06:09,879 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5418.15 Median:6217.66 stddev:1676.39 (27.0%) stddev-sans-first:1636.47 04:06:09 INFO - 2015-11-21 04:06:09,880 DEBUG : BROWSER_OUTPUT: Values: 298.7 298.9 303.8 306.2 307.8 6027.1 6057.4 6079.1 6166.5 6192.7 6056.1 6058.7 6066.3 6076.8 6090.3 4404.4 4629.3 4631.1 4631.1 4639.9 4493.5 4524.2 4637.0 4641.8 4647.1 4548.1 4549.2 4571.4 4572.4 4573.2 4323.5 4418.2 4466.1 4573.7 4584.9 3978.5 4003.3 4009.7 4010.6 4015.1 5766.6 5772.2 5772.7 5773.8 5779.7 5283.6 5300.8 5301.3 5304.8 5350.2 6297.7 6428.2 6429.0 6431.9 6435.8 4406.3 4416.6 4420.6 4424.5 4432.9 6692.5 6696.4 6701.7 6701.8 6705.9 4435.3 4493.8 4528.1 4528.2 4539.0 4580.7 4581.4 4582.5 4584.0 4585.5 5299.3 5325.5 5334.3 5334.9 5339.7 6540.9 6543.1 6553.1 6553.4 6558.1 1588.7 1601.9 1619.9 1625.1 1626.9 1053.2 1076.3 1079.8 1083.3 1087.1 6271.6 6272.0 6277.6 6280.3 6284.0 6671.1 6713.1 6713.1 6720.2 6728.1 6093.8 6242.6 6243.4 6250.9 6255.0 3518.5 3614.7 3619.5 3620.5 3621.3 6751.7 6940.1 6999.2 7008.7 7024.4 6960.4 6963.8 6966.9 6985.4 6988.8 6842.7 6954.1 6959.0 6975.7 6979.8 6726.3 6756.9 6762.9 6766.8 6767.6 6649.0 6670.9 6684.0 6686.7 6697.5 6804.8 7029.8 7034.7 7035.5 7040.8 4423.6 4453.9 4457.1 4461.2 4464.6 6762.0 6791.0 6799.3 6805.4 6806.3 6476.3 6608.8 6618.2 6619.3 6620.4 6574.4 6580.0 6587.3 6593.6 6598.7 6386.7 6488.0 6492.3 6494.6 6503.3 6642.9 6646.7 6649.8 6650.0 6657.4 6464.5 6471.4 6473.9 6478.0 6486.0 04:06:09 INFO - 2015-11-21 04:06:09,880 DEBUG : BROWSER_OUTPUT: 04:06:09 INFO - 2015-11-21 04:06:09,880 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13175.93 Median:50417.25 stddev:15522.18 (30.8%) stddev-sans-first:15537.65 04:06:09 INFO - 2015-11-21 04:06:09,882 DEBUG : BROWSER_OUTPUT: Values: 744.7 796.2 823.8 830.4 850.2 10162.5 10181.4 10208.9 10240.7 10301.7 12166.8 12459.4 12880.0 12976.6 13048.9 793.9 803.1 803.3 803.5 804.5 803.4 804.3 804.8 804.9 805.8 840.4 842.2 844.6 850.3 852.6 843.6 845.1 846.9 850.5 852.3 614.8 616.2 616.2 617.4 623.9 12199.3 12351.8 12352.2 12355.7 12358.4 10663.9 10782.3 10854.5 11036.1 11247.3 9831.9 9842.4 9855.7 9901.4 9954.8 3708.4 3711.4 3717.2 3773.5 3841.0 39848.4 40667.6 44403.3 45091.5 46516.8 8726.1 9650.4 9850.4 9954.3 10387.4 15114.0 16365.9 16548.7 16594.7 16620.5 7123.5 7166.8 7275.6 7595.8 7608.6 4162.5 4375.5 4411.1 4425.5 4427.3 3138.5 3170.6 3170.6 3171.4 3173.2 568.8 569.3 570.8 573.3 585.4 642.6 663.7 667.7 681.4 683.9 7649.8 8127.5 8293.4 8393.6 8459.4 636.5 644.4 654.7 668.7 696.2 3685.8 3693.6 3768.2 3881.6 3888.2 56098.7 56840.8 57413.1 57517.4 58043.7 49493.0 50196.7 50637.7 50707.7 51156.5 46038.0 46290.3 46308.3 47131.3 48149.7 7427.7 7541.8 7610.1 7642.5 7743.9 34783.0 35113.8 35293.8 35871.8 36529.3 38714.2 39613.2 42846.6 42922.8 43694.0 10350.4 10516.9 10808.4 10849.2 10873.6 11314.9 11611.3 11694.8 11924.2 11980.8 9959.9 9966.2 10107.4 10430.9 10577.1 10427.8 10652.0 10704.4 10971.9 11000.7 10821.4 10919.1 11119.6 11220.1 11261.9 9055.5 9212.0 9238.6 9339.9 9583.7 8688.7 8787.2 8993.0 9058.7 9588.9 04:06:09 INFO - 2015-11-21 04:06:09,882 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:06:09 INFO - 2015-11-21 04:06:09,882 DEBUG : BROWSER_OUTPUT: 04:06:10 INFO - 2015-11-21 04:06:10,598 INFO : Browser exited with error code: 0 04:06:10 INFO - 2015-11-21 04:06:10,614 INFO : Completed test dromaeo_css (00:18:33) 04:06:10 INFO - 2015-11-21 04:06:10,614 INFO : Starting test kraken 04:06:10 INFO - 2015-11-21 04:06:10,614 DEBUG : operating with platform_type : linux_ 04:06:10 INFO - 2015-11-21 04:06:10,614 INFO : Initialising browser for kraken test... 04:06:10 INFO - 2015-11-21 04:06:10,620 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYxvn2I/profile http://localhost:49375/getInfo.html 04:06:14 INFO - 2015-11-21 04:06:14,171 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:06:14 INFO - 2015-11-21 04:06:14,171 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:06:14 INFO - 2015-11-21 04:06:14,171 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:06:14 INFO - 2015-11-21 04:06:14,171 DEBUG : BROWSER_OUTPUT: __metrics 04:06:14 INFO - 2015-11-21 04:06:14,300 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:06:15 INFO - 2015-11-21 04:06:15,390 INFO : Browser initialized. 04:06:15 INFO - 2015-11-21 04:06:15,391 INFO : Running cycle 1/1 for kraken test... 04:06:15 INFO - 2015-11-21 04:06:15,391 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYxvn2I/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:06:27 INFO - 2015-11-21 04:06:27,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 141721600 04:06:27 INFO - 2015-11-21 04:06:27,167 DEBUG : BROWSER_OUTPUT: 04:06:29 INFO - 2015-11-21 04:06:29,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-beat-detection) 04:06:30 INFO - 2015-11-21 04:06:30,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 175628288 04:06:30 INFO - 2015-11-21 04:06:30,211 DEBUG : BROWSER_OUTPUT: 04:06:32 INFO - 2015-11-21 04:06:32,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-dft) 04:06:33 INFO - 2015-11-21 04:06:33,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 167636992 04:06:33 INFO - 2015-11-21 04:06:33,434 DEBUG : BROWSER_OUTPUT: 04:06:36 INFO - 2015-11-21 04:06:36,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-fft) 04:06:36 INFO - 2015-11-21 04:06:36,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 150994944 04:06:36 INFO - 2015-11-21 04:06:36,876 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2015-11-21 04:06:38,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-oscillator) 04:06:39 INFO - 2015-11-21 04:06:39,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 153763840 04:06:39 INFO - 2015-11-21 04:06:39,409 DEBUG : BROWSER_OUTPUT: 04:06:41 INFO - 2015-11-21 04:06:41,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:06:42 INFO - 2015-11-21 04:06:42,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 155754496 04:06:42 INFO - 2015-11-21 04:06:42,145 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-21 04:06:45,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-darkroom) 04:06:45 INFO - 2015-11-21 04:06:45,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 155521024 04:06:45 INFO - 2015-11-21 04:06:45,572 DEBUG : BROWSER_OUTPUT: 04:06:48 INFO - 2015-11-21 04:06:48,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:49 INFO - 2015-11-21 04:06:49,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 156585984 04:06:49 INFO - 2015-11-21 04:06:49,527 DEBUG : BROWSER_OUTPUT: 04:06:52 INFO - 2015-11-21 04:06:52,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49375/tests/kraken/driver.html?testName=json-parse-financial) 04:06:52 INFO - 2015-11-21 04:06:52,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 156278784 04:06:52 INFO - 2015-11-21 04:06:52,843 DEBUG : BROWSER_OUTPUT: 04:06:54 INFO - 2015-11-21 04:06:54,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49375/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:54 INFO - 2015-11-21 04:06:54,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 165249024 04:06:54 INFO - 2015-11-21 04:06:54,972 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-21 04:06:56,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:57 INFO - 2015-11-21 04:06:57,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 165945344 04:06:57 INFO - 2015-11-21 04:06:57,390 DEBUG : BROWSER_OUTPUT: 04:06:59 INFO - 2015-11-21 04:06:59,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:59 INFO - 2015-11-21 04:06:59,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 172027904 04:06:59 INFO - 2015-11-21 04:06:59,996 DEBUG : BROWSER_OUTPUT: 04:07:02 INFO - 2015-11-21 04:07:02,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:07:02 INFO - 2015-11-21 04:07:02,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 182566912 04:07:02 INFO - 2015-11-21 04:07:02,992 DEBUG : BROWSER_OUTPUT: 04:07:05 INFO - 2015-11-21 04:07:05,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:07:06 INFO - 2015-11-21 04:07:06,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 181084160 04:07:06 INFO - 2015-11-21 04:07:06,114 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2015-11-21 04:07:07,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49375/tests/kraken/driver.html?testName=ai-astar) 04:07:08 INFO - 2015-11-21 04:07:08,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 239755264 04:07:08 INFO - 2015-11-21 04:07:08,055 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,057 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:08 INFO - 2015-11-21 04:07:08,057 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:08 INFO - 2015-11-21 04:07:08,057 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:08 INFO - 2015-11-21 04:07:08,057 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:08 INFO - 2015-11-21 04:07:08,057 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;103;110;111;109;99;108;108;108 04:07:08 INFO - 2015-11-21 04:07:08,058 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;124;155;176;127;165;159;128;167;124 04:07:08 INFO - 2015-11-21 04:07:08,058 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;161;162;160;159;160;161;161;162 04:07:08 INFO - 2015-11-21 04:07:08,058 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;81;94;71;72;72;105;92;71 04:07:08 INFO - 2015-11-21 04:07:08,058 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;137;90;90;91;131;90;91;133 04:07:08 INFO - 2015-11-21 04:07:08,058 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;108;109;109;109;109;109;109;109 04:07:08 INFO - 2015-11-21 04:07:08,059 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;146;145;147;147;147;146;146 04:07:08 INFO - 2015-11-21 04:07:08,059 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;97;95;96;96;96;96;96 04:07:08 INFO - 2015-11-21 04:07:08,059 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;59;59;59;59;60;68;56;57 04:07:08 INFO - 2015-11-21 04:07:08,059 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;69;69;69;68;73;74;70 04:07:08 INFO - 2015-11-21 04:07:08,059 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;85;84;84;84;85;86;85;86 04:07:08 INFO - 2015-11-21 04:07:08,059 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;117;118;115;122;119;117;116;125;123 04:07:08 INFO - 2015-11-21 04:07:08,060 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;145;140;151;163;147;151;150;150;140 04:07:08 INFO - 2015-11-21 04:07:08,060 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;67;68;68;67;65;67;67;66 04:07:08 INFO - 2015-11-21 04:07:08,060 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:08 INFO - 2015-11-21 04:07:08,060 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:07:08 INFO - 2015-11-21 04:07:08,060 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,921 04:07:08 INFO - 2015-11-21 04:07:08,061 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:07:08 INFO - 2015-11-21 04:07:08,061 DEBUG : BROWSER_OUTPUT: __startTimestamp1448107628056__endTimestamp 04:07:08 INFO - 2015-11-21 04:07:08,061 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,062 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:08 INFO - 2015-11-21 04:07:08,062 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:07:08 INFO - 2015-11-21 04:07:08,063 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,063 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.40 Median:109.50 stddev:3.66 (3.3%) stddev-sans-first:3.87 04:07:08 INFO - 2015-11-21 04:07:08,063 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 103.0 110.0 111.0 109.0 99.0 108.0 108.0 108.0 04:07:08 INFO - 2015-11-21 04:07:08,063 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,063 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.50 Median:157.00 stddev:20.00 (12.7%) stddev-sans-first:21.19 04:07:08 INFO - 2015-11-21 04:07:08,063 DEBUG : BROWSER_OUTPUT: Values: 150.0 124.0 155.0 176.0 127.0 165.0 159.0 128.0 167.0 124.0 04:07:08 INFO - 2015-11-21 04:07:08,063 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,063 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.05 (0.7%) stddev-sans-first:1.05 04:07:08 INFO - 2015-11-21 04:07:08,063 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 162.0 160.0 159.0 160.0 161.0 161.0 162.0 04:07:08 INFO - 2015-11-21 04:07:08,063 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,064 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:72.00 stddev:12.40 (17.2%) stddev-sans-first:12.79 04:07:08 INFO - 2015-11-21 04:07:08,064 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 81.0 94.0 71.0 72.0 72.0 105.0 92.0 71.0 04:07:08 INFO - 2015-11-21 04:07:08,064 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,065 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.50 Median:90.50 stddev:20.87 (23.1%) stddev-sans-first:21.64 04:07:08 INFO - 2015-11-21 04:07:08,065 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 137.0 90.0 90.0 91.0 131.0 90.0 91.0 133.0 04:07:08 INFO - 2015-11-21 04:07:08,065 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,065 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:07:08 INFO - 2015-11-21 04:07:08,065 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 108.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 04:07:08 INFO - 2015-11-21 04:07:08,065 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,065 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:07:08 INFO - 2015-11-21 04:07:08,066 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 146.0 145.0 147.0 147.0 147.0 146.0 146.0 04:07:08 INFO - 2015-11-21 04:07:08,066 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,066 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 04:07:08 INFO - 2015-11-21 04:07:08,066 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 97.0 95.0 96.0 96.0 96.0 96.0 96.0 04:07:08 INFO - 2015-11-21 04:07:08,066 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,066 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.40 Median:59.00 stddev:3.24 (5.5%) stddev-sans-first:3.43 04:07:08 INFO - 2015-11-21 04:07:08,066 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 59.0 59.0 59.0 59.0 60.0 68.0 56.0 57.0 04:07:08 INFO - 2015-11-21 04:07:08,066 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,066 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.00 stddev:2.11 (3.1%) stddev-sans-first:2.22 04:07:08 INFO - 2015-11-21 04:07:08,066 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 69.0 69.0 69.0 68.0 73.0 74.0 70.0 04:07:08 INFO - 2015-11-21 04:07:08,066 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,066 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.83 04:07:08 INFO - 2015-11-21 04:07:08,067 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 85.0 84.0 84.0 84.0 85.0 86.0 85.0 86.0 04:07:08 INFO - 2015-11-21 04:07:08,067 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,067 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:120.50 stddev:4.29 (3.6%) stddev-sans-first:3.44 04:07:08 INFO - 2015-11-21 04:07:08,067 DEBUG : BROWSER_OUTPUT: Values: 128.0 117.0 118.0 115.0 122.0 119.0 117.0 116.0 125.0 123.0 04:07:08 INFO - 2015-11-21 04:07:08,067 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,067 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:150.00 stddev:6.87 (4.6%) stddev-sans-first:6.95 04:07:08 INFO - 2015-11-21 04:07:08,067 DEBUG : BROWSER_OUTPUT: Values: 142.0 145.0 140.0 151.0 163.0 147.0 151.0 150.0 150.0 140.0 04:07:08 INFO - 2015-11-21 04:07:08,067 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,067 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 04:07:08 INFO - 2015-11-21 04:07:08,067 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 67.0 68.0 68.0 67.0 65.0 67.0 67.0 66.0 04:07:08 INFO - 2015-11-21 04:07:08,067 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:08 INFO - 2015-11-21 04:07:08,067 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-21 04:07:08,874 INFO : Browser exited with error code: 0 04:07:08 INFO - 2015-11-21 04:07:08,927 INFO : Completed test kraken (00:00:58) 04:07:08 INFO - 2015-11-21 04:07:08,927 INFO : Starting test v8_7 04:07:08 INFO - 2015-11-21 04:07:08,927 DEBUG : operating with platform_type : linux_ 04:07:08 INFO - 2015-11-21 04:07:08,927 INFO : Initialising browser for v8_7 test... 04:07:08 INFO - 2015-11-21 04:07:08,933 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW1ICGf/profile http://localhost:49375/getInfo.html 04:07:12 INFO - 2015-11-21 04:07:12,375 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:07:12 INFO - 2015-11-21 04:07:12,376 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:07:12 INFO - 2015-11-21 04:07:12,376 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:07:12 INFO - 2015-11-21 04:07:12,376 DEBUG : BROWSER_OUTPUT: __metrics 04:07:12 INFO - 2015-11-21 04:07:12,493 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:07:13 INFO - 2015-11-21 04:07:13,553 INFO : Browser initialized. 04:07:13 INFO - 2015-11-21 04:07:13,554 INFO : Running cycle 1/1 for v8_7 test... 04:07:13 INFO - 2015-11-21 04:07:13,554 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW1ICGf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:07:25 INFO - 2015-11-21 04:07:25,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 142254080 04:07:25 INFO - 2015-11-21 04:07:25,306 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2015-11-21 04:07:46,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49375/tests/v8_7/run.html (next: http://localhost:49375/tests/v8_7/run.html) 04:07:46 INFO - 2015-11-21 04:07:46,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 575197184 04:07:46 INFO - 2015-11-21 04:07:46,896 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2015-11-21 04:07:46,897 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:46 INFO - 2015-11-21 04:07:46,897 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:46 INFO - 2015-11-21 04:07:46,897 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:46 INFO - 2015-11-21 04:07:46,897 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:46 INFO - 2015-11-21 04:07:46,898 DEBUG : BROWSER_OUTPUT: |0;Richards;163.15875346712352 04:07:46 INFO - 2015-11-21 04:07:46,898 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.62826002335538 04:07:46 INFO - 2015-11-21 04:07:46,898 DEBUG : BROWSER_OUTPUT: |2;Encrypt;288.51702250432777 04:07:46 INFO - 2015-11-21 04:07:46,898 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5015 04:07:46 INFO - 2015-11-21 04:07:46,898 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1103.7527593818984 04:07:46 INFO - 2015-11-21 04:07:46,898 DEBUG : BROWSER_OUTPUT: |5;Earley;785.0980392156863 04:07:46 INFO - 2015-11-21 04:07:46,898 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 04:07:46 INFO - 2015-11-21 04:07:46,898 DEBUG : BROWSER_OUTPUT: |7;RegExp;26526.315789473683 04:07:46 INFO - 2015-11-21 04:07:46,899 DEBUG : BROWSER_OUTPUT: |8;Splay;654.8788474132285 04:07:46 INFO - 2015-11-21 04:07:46,899 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:07:46 INFO - 2015-11-21 04:07:46,899 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:46 INFO - 2015-11-21 04:07:46,899 DEBUG : BROWSER_OUTPUT: __startTimestamp1448107666896__endTimestamp 04:07:46 INFO - 2015-11-21 04:07:46,900 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2015-11-21 04:07:46,900 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:46 INFO - 2015-11-21 04:07:46,900 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:07:46 INFO - 2015-11-21 04:07:46,900 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2015-11-21 04:07:46,900 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.16 Median:163.16 stddev:0.00 (0.0%) 04:07:46 INFO - 2015-11-21 04:07:46,901 DEBUG : BROWSER_OUTPUT: Values: 163.2 04:07:46 INFO - 2015-11-21 04:07:46,901 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2015-11-21 04:07:46,901 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.63 Median:194.63 stddev:0.00 (0.0%) 04:07:46 INFO - 2015-11-21 04:07:46,901 DEBUG : BROWSER_OUTPUT: Values: 194.6 04:07:46 INFO - 2015-11-21 04:07:46,901 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2015-11-21 04:07:46,902 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:288.52 Median:288.52 stddev:0.00 (0.0%) 04:07:46 INFO - 2015-11-21 04:07:46,902 DEBUG : BROWSER_OUTPUT: Values: 288.5 04:07:46 INFO - 2015-11-21 04:07:46,902 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2015-11-21 04:07:46,902 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5015.00 Median:5015.00 stddev:0.00 (0.0%) 04:07:46 INFO - 2015-11-21 04:07:46,903 DEBUG : BROWSER_OUTPUT: Values: 5015.0 04:07:46 INFO - 2015-11-21 04:07:46,903 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2015-11-21 04:07:46,903 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1103.75 Median:1103.75 stddev:0.00 (0.0%) 04:07:46 INFO - 2015-11-21 04:07:46,903 DEBUG : BROWSER_OUTPUT: Values: 1103.8 04:07:46 INFO - 2015-11-21 04:07:46,904 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2015-11-21 04:07:46,904 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:785.10 Median:785.10 stddev:0.00 (0.0%) 04:07:46 INFO - 2015-11-21 04:07:46,904 DEBUG : BROWSER_OUTPUT: Values: 785.1 04:07:46 INFO - 2015-11-21 04:07:46,904 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2015-11-21 04:07:46,904 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 04:07:46 INFO - 2015-11-21 04:07:46,905 DEBUG : BROWSER_OUTPUT: Values: 12132.5 04:07:46 INFO - 2015-11-21 04:07:46,905 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2015-11-21 04:07:46,905 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26526.32 Median:26526.32 stddev:0.00 (0.0%) 04:07:46 INFO - 2015-11-21 04:07:46,905 DEBUG : BROWSER_OUTPUT: Values: 26526.3 04:07:46 INFO - 2015-11-21 04:07:46,905 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2015-11-21 04:07:46,905 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:654.88 Median:654.88 stddev:0.00 (0.0%) 04:07:46 INFO - 2015-11-21 04:07:46,905 DEBUG : BROWSER_OUTPUT: Values: 654.9 04:07:46 INFO - 2015-11-21 04:07:46,905 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2015-11-21 04:07:46,905 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:07:46 INFO - 2015-11-21 04:07:46,905 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:07:46 INFO - 2015-11-21 04:07:46,906 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:46 INFO - 2015-11-21 04:07:46,906 DEBUG : BROWSER_OUTPUT: 04:07:47 INFO - 2015-11-21 04:07:47,713 INFO : Browser exited with error code: 0 04:07:47 INFO - 2015-11-21 04:07:47,728 INFO : Completed test v8_7 (00:00:38) 04:07:47 INFO - 2015-11-21 04:07:47,979 INFO : Completed test suite (00:20:11) 04:07:47 INFO - 2015-11-21 04:07:47,979 DEBUG : Working with test: dromaeo_css 04:07:47 INFO - 2015-11-21 04:07:47,980 DEBUG : Generating results file: dromaeo_css 04:07:47 INFO - 2015-11-21 04:07:47,981 DEBUG : Working with test: kraken 04:07:47 INFO - 2015-11-21 04:07:47,981 DEBUG : Generating results file: kraken 04:07:47 INFO - 2015-11-21 04:07:47,981 INFO : javascript benchmark 04:07:47 INFO - 2015-11-21 04:07:47,981 DEBUG : Working with test: v8_7 04:07:47 INFO - 2015-11-21 04:07:47,981 DEBUG : Generating results file: v8_7 04:07:47 INFO - 2015-11-21 04:07:47,982 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:48 INFO - 2015-11-21 04:07:48,024 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 04:07:48 INFO - 2015-11-21 04:07:48,024 DEBUG : process_Request line: dromaeo_css 6979.34 graph.html#tests=[[72,63,35]] 04:07:48 INFO - 2015-11-21 04:07:48,024 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:48 INFO - 2015-11-21 04:07:48,050 DEBUG : process_Request line: kraken 1499.40 graph.html#tests=[[232,63,35]] 04:07:48 INFO - 2015-11-21 04:07:48,050 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:48 INFO - 2015-11-21 04:07:48,073 DEBUG : process_Request line: v8_7 20829.72 graph.html#tests=[[230,63,35]] 04:07:48 INFO - 2015-11-21 04:07:48,074 INFO : javascript benchmark 04:07:48 INFO - 2015-11-21 04:07:48,078 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3158.368326334733, 3237.190702324419, 3286.408446479633, 3286.5727455430806, 3316.8839090631827, 5299.867503312419, 5408.756605952732, 5442.537384322332, 5444.128939369702, 5464.590155738316, 5416.862458883629, 5449.0, 5466.34403871535, 5482.259894914196, 5559.804642001969, 4943.777530011149, 5009.04828082665, 5013.849584512453, 5037.4710655381205, 5046.722430266353, 4830.299606557047, 5084.3644544431945, 5092.439831618519, 5122.15484445068, 5152.969406118791, 4883.584895283923, 4904.803807847682, 4956.40523137224, 4967.900641987176, 4982.6761260518315, 4992.400911890596, 5001.8499445016705, 5009.298698182258, 5017.172166592508, 5042.243663450475, 4830.8792280193275, 4931.186354251544, 4970.353853998993, 4972.5276098770555, 5003.399592048978, 5239.5546378557865, 5269.578433725293, 5287.048331300364, 5289.312389389354, 5315.335583052119, 5894.58737888348, 5952.1964534787685, 5958.314793798725, 5968.850778730523, 5969.164316995624, 5778.046622307356, 5887.146363777271, 5913.556483263773, 5967.671778052206, 5992.43071908168, 5444.6188766785945, 5500.4499550044675, 5516.951779161946, 5522.751476183541, 5567.526760225345, 5977.790777322773, 6083.787067452707, 6091.511430256314, 6098.207233059674, 6105.48103411215, 5585.469380408855, 5732.226149469851, 5780.248567686174, 5940.79207227745, 5956.076808094752, 5960.165576819249, 5961.850953726105, 5967.671778052249, 5970.9701451492465, 6017.518598512196, 5870.7945221917025, 5892.882142357214, 5942.138389933435, 5952.910706339322, 5955.374685657944, 5674.4892959633835, 5806.564507661942, 5817.185594016841, 5846.181534585162, 5886.705664716747, 4484.775761211927, 4526.6152377047665, 4528.230200865861, 4537.3647689323525, 4577.0159415725775, 4047.716659833842, 4062.106336605942, 4079.8776036718946, 4089.5297040840683, 4107.527634322091, 5327.547158491571, 5427.240186373911, 5643.351014633287, 5645.520130788929, 5664.20701101846, 5851.61964472308, 5895.145203945404, 5943.465088142088, 5963.821085367446, 6013.4888534474185, 5456.263404440349, 5486.259354987105, 5499.560035197174, 5503.669779813224, 5550.777968881281, 4989.501049894981, 5057.31726216956, 5068.467810879878, 5084.415292241366, 5089.185730283137, 5904.7933322334375, 5947.9405205949115, 5961.225040744675, 5968.791092311835, 6017.458428741435, 5823.155642431909, 5972.701364931823, 5983.850403739942, 5988.880222395441, 6003.549733770072, 5861.560382971209, 5998.3401825798255, 6127.724252408563, 6146.446819786241, 6159.753609855556, 5722.771089156554, 5756.769729210785, 5761.193432919311, 5775.6823374714795, 5807.8548036299435, 5912.0, 5936.910946335895, 5970.582059255984, 5976.46211840919, 5988.910166347421, 5452.618316717951, 5785.334686510937, 5808.94191058084, 5835.503982161394, 5842.912356314744, 5684.261046063985, 5723.542116630742, 5748.6838223898085, 5778.479936805707, 5824.767009319579, 5645.435456454322, 5660.462256085665, 5674.631148975303, 5684.289463817023, 5685.744141513725, 5508.476694713996, 5652.660840349427, 5727.455891690282, 5797.826065218051, 5800.419958004166, 5659.830205093854, 5744.339400968942, 5772.855678607901, 5782.566307527037, 5826.504747096545], "unit": "ms", "name": "dojo.html", "value": 5422.891419811346}, {"lowerIsBetter": false, "replicates": [552.8313864271396, 589.7346194212605, 606.9241344831895, 610.41095342994, 610.5634471352985, 30143.69856301439, 30938.0, 30943.38113237734, 40088.39867401984, 40374.39438408426, 41136.0, 41560.0, 41592.79203603978, 41706.58293417073, 41758.16483670325, 8751.86872196916, 8841.071687472819, 8912.910870891274, 8917.910820891806, 8936.776580585505, 7777.2222777722345, 7923.247291507327, 8610.87083693742, 10504.78990420191, 10726.03465688088, 10495.685129446128, 10614.787704245911, 10620.256582039261, 10625.25623206372, 10625.84061239082, 7851.411144164211, 10391.064804167623, 10435.582576696923, 10506.52720627566, 10509.84235236472, 7626.771196864048, 10505.78988420235, 10728.356298622108, 10740.892591074067, 10752.838707419394, 38318.61681383178, 38460.0, 38731.8380448587, 38753.22493550113, 38795.22409551793, 3340.5323254744353, 3356.47974563943, 3469.0286719718265, 3512.2799826035857, 3667.7065834733426, 29232.70767292321, 29745.25636859074, 29766.851165744032, 29910.252243693863, 30079.248018799706, 3403.3873902697505, 3407.812570308632, 3419.128122328815, 3480.095175254427, 3498.7201023918024, 264029.0, 264664.0, 266375.0, 266460.0, 266732.666336669, 52529.737351313, 59410.10884836731, 59595.70202148962, 59687.701561491915, 59856.401435985084, 49093.2636010453, 68792.31207687859, 70762.29237707557, 70848.64575677089, 70907.0, 15060.924695376452, 15148.091114533163, 15270.31283592241, 15345.693086138215, 15360.769588456182, 11390.487428065757, 11484.712882177846, 11506.194566380273, 11534.192606517463, 11556.479958401893, 20137.899310503646, 20428.59142817165, 20432.387028389174, 20467.79532204659, 20521.0, 7486.401087913063, 7672.616369181518, 7786.610669466504, 7801.726939557088, 7805.4824221774315, 872.5986046418718, 921.5392303848076, 926.559884055082, 1000.6047611193537, 1084.295208114716, 27765.167044988684, 28565.428691426056, 28675.0, 28804.42391152165, 29021.274468138043, 997.1972562087589, 1009.6970908727352, 1035.2701345551368, 1117.9105671546256, 1118.5246270335076, 14205.289735513183, 14719.55841324762, 14761.483348082766, 14908.850911490747, 14993.17537535446, 321186.0, 325036.0, 325087.0, 325108.0, 325439.0, 50764.49235507598, 50785.492145078075, 50912.49087509151, 50983.0, 51000.489995099575, 1326.1512631915582, 1333.2533781082625, 1336.3719052045524, 1339.926304053267, 1340.5509154433373, 26339.341516461474, 27477.31306717348, 27513.44973100567, 27700.307492312855, 27900.16299511018, 45776.771116144206, 46034.539654603024, 46041.53958460507, 46065.76967115277, 46070.76964615155, 303836.0, 304168.0, 304172.0, 304812.0, 305150.0, 27494.312642184104, 27982.0, 30505.389892201587, 31319.686803131677, 31790.52314215335, 37028.81485592555, 37374.0, 37531.06172345713, 37710.434343485416, 37988.81005594954, 31553.52669710002, 31836.52245216277, 31939.36121277515, 32079.35841283208, 32345.676543234265, 29008.12975610735, 33525.329493410485, 34040.48939265864, 34210.48684269688, 37699.0, 34534.82732586321, 34906.12734681653, 35076.0, 35081.473777893865, 35140.12149696278, 31535.684643153276, 31834.840825795724, 32037.252155010647, 32092.0, 32109.839450802596, 22264.554708906056, 22338.853045162887, 22607.88696056509, 22809.771902281427, 22815.201467948544], "unit": "ms", "name": "ext.html", "value": 18349.80508703335}, {"lowerIsBetter": false, "replicates": [353.1647653299946, 356.47598030894574, 356.74670983601624, 361.7937775467983, 363.84718418264333, 14817.110973341607, 14994.325255363508, 16514.256858441368, 16833.15834208291, 17599.736003959933, 10305.948470257637, 10540.525676344563, 16374.918125409386, 17490.56273593161, 17493.300267989263, 4663.277192035232, 4775.2598347256235, 4783.354247176621, 4786.952130478703, 4787.066522028188, 3723.957291958256, 3803.3724435468116, 4755.595774359183, 4792.688475249115, 5128.666636668605, 5303.496167864047, 5304.575633949275, 5326.7070311132875, 5342.652727572715, 5347.839564813062, 5193.298904647881, 5284.577233821324, 5289.550388217006, 5319.7340132993195, 5322.20166974953, 5125.051865404912, 5130.51260130287, 5134.127198376285, 5134.255532947702, 5134.794608215667, 11930.164888457812, 17316.65366692659, 19926.70109948352, 20431.591368172703, 20487.180512779472, 2200.1309482754223, 2218.279059305716, 2256.435891027243, 2260.581792368417, 2304.7003889494426, 8936.106389361077, 9041.186293233575, 9055.954720226422, 9122.908770912272, 9222.40054396462, 1741.7300318450662, 1822.1891258390021, 1823.7811462624438, 1842.5854182808894, 1887.8489720822301, 63332.366676333106, 63741.681291593246, 64673.3532664672, 66347.3365266346, 69398.65300673514, 15652.843471565366, 16131.274092665859, 16263.0, 16268.593285167728, 16379.181040947906, 25301.873490632795, 25382.873085634452, 25436.872815636172, 25464.236072917844, 25585.360365991, 8809.735707928772, 8860.158284962918, 8906.910930890737, 8960.551972401354, 8986.415882967585, 7458.105027396748, 7500.587467689329, 7537.170911199763, 7552.8489430212185, 7575.886361704579, 7867.527948323119, 7921.801954951173, 7933.484323519068, 7979.880301795478, 8032.638531266107, 1812.7009043507937, 1827.4883032750852, 2261.118163916074, 3048.679888611664, 3156.0, 924.5331107790523, 940.9341346105844, 983.0, 1001.2990906365428, 1019.4036488654073, 15790.763138552931, 16082.839171608368, 16605.66788664244, 17897.0, 18353.449396518125, 886.4326830828275, 923.7690577355661, 952.7141857442739, 952.7760976170595, 998.4458625462938, 8385.287250583646, 9263.76840578991, 9678.95160524193, 9689.78877640295, 9880.061394167686, 510415.0, 518726.72096150805, 528321.0, 532192.0, 532636.0, 77224.0, 77689.611551943, 77952.0, 77952.22047779564, 78836.0, 1152.1704372851534, 1157.2130950953265, 1166.8658104317942, 1172.806486929664, 1174.7944109780753, 15766.684666306839, 15804.0, 15855.762163567786, 15974.0, 16215.35138594443, 35040.29919401649, 35448.0, 36308.455373168894, 36657.26685466329, 36987.81506092452, 45169.54830451785, 47449.28826067543, 47852.28221576609, 47917.76041119772, 48538.5146148534, 14430.783538247144, 14623.0, 14637.194954277616, 14877.702445951238, 14882.702345953237, 9378.390404623678, 10068.345557538736, 10513.369197848153, 17695.46913592594, 18898.622027559646, 8568.828623427622, 9378.296627752808, 9450.480223587494, 9465.810683786423, 9596.136347728738, 9203.585838637411, 9253.953730231306, 9272.953635231781, 9383.530823458663, 9390.24878009744, 9303.76740581491, 9478.57346419399, 9503.524823758922, 9504.239660827256, 9845.064718851698, 14056.367463464374, 14376.784348234576, 14712.0, 14965.92517037408, 15263.3894644213, 14291.142531448146, 14400.0, 14461.710765784836, 15242.923785381003, 15247.3901043957], "unit": "ms", "name": "jquery.html", "value": 9139.830284356492}, {"lowerIsBetter": false, "replicates": [1318.433073778275, 1462.2542503323305, 1514.432087967012, 1637.6315329050965, 1760.683077046131, 6531.118299029636, 6978.930210697891, 7170.211276759559, 7174.426045916327, 7175.605341706204, 7259.6370181490975, 7388.704451821921, 7396.0, 7424.220456852034, 7442.18136005039, 1931.2082046360995, 1956.1392987085637, 2209.1605190027767, 2259.9887000564972, 2278.532900755341, 2212.7123473948445, 2220.733511978565, 2222.955540889181, 2228.019671344603, 2232.687423760675, 2163.145557504785, 2245.517213799033, 2246.4945387287894, 2249.134083377895, 2249.4601295689, 1928.2287085165976, 1973.052934591397, 2211.8783466909313, 2243.7868402501736, 2245.6294711372766, 2246.0, 2263.2531264682616, 2285.382946604424, 2294.862308261493, 2317.9768202317928, 7297.160826504967, 7349.926500734978, 7357.227491113463, 7358.337749602561, 7367.8894816577795, 4558.544145585448, 4633.513481084505, 4638.489766125724, 4659.813607455698, 4663.253879379283, 2986.507226307678, 2987.910362689123, 3033.63596368435, 3034.1201051694984, 3085.537169424582, 1049.3861091261545, 1054.219877290807, 1063.9468026598638, 1079.2445288298222, 1090.4166271045033, 10419.0, 10485.947570262177, 10533.36799792015, 10550.472476376228, 10558.736031599195, 4107.137501124797, 4226.2392769301205, 4229.703920725519, 4232.746035237896, 4275.700700950903, 8959.0, 8993.55032248385, 9030.187283144549, 9046.095390460901, 9052.0, 4643.326717625925, 4668.743219122913, 4691.038337140878, 4697.0, 4697.224957881979, 4207.537170911197, 4256.2551553478015, 4259.61663450291, 4260.531341552427, 4260.723053001545, 3510.7191424685966, 3557.839897204632, 3616.294822509638, 3623.782573045573, 3634.0914771307175, 1197.1978774221293, 1205.9276443413423, 1206.7164216409137, 1214.4474264209764, 1221.1879100398135, 1311.849137349198, 1322.4379638653727, 1335.4391155714623, 1349.298364850292, 1349.709812390321, 7017.017617533549, 7125.75059872902, 7264.128304603376, 7271.963640181871, 7294.234105418961, 487.4613552025032, 492.396813902966, 503.12958581653214, 503.1773051061468, 506.501096420026, 5617.129344951539, 5685.687287199244, 5697.401772813878, 5732.254806875079, 5737.913931291034, 8674.262687671619, 9068.455892646462, 9110.590023448829, 9139.040400757958, 9327.0, 8934.374593778373, 9138.954305228564, 9179.632814687471, 9191.724248272563, 9225.308101892251, 6854.931450685529, 6913.481488888253, 7138.0, 7145.499815013003, 7145.785626431215, 6830.795076147723, 6866.313368663094, 6874.553154044971, 6876.862462750817, 6879.552829066095, 7733.806654833449, 8129.227723366271, 8137.633806478604, 8146.877796833171, 8195.836083278182, 8243.793905152179, 8350.707725229831, 8355.874661880198, 8494.447860889022, 8502.532360720219, 6491.967540162269, 6520.804375868732, 6540.705668244846, 6563.442107420923, 6601.933980660132, 7477.925220747723, 7536.886946695694, 7542.698292068256, 7545.094588649177, 7549.2073332299315, 5546.362168350692, 6712.228093769279, 6750.05499230118, 6894.517383783288, 7187.820304492429, 6770.187577490733, 6813.318668133147, 6817.522773405814, 6861.073755043005, 6910.308969103251, 6741.460683145435, 6851.794446166623, 6916.861662766817, 6950.8609827804175, 6954.826129346807, 6191.535634827496, 6215.471684906834, 6219.253689557282, 6227.844303892439, 6228.28374736893, 6247.875042499216, 6265.686715664107, 6320.273168585488, 6341.7780377688405, 6420.935790642221], "unit": "ms", "name": "mootools.html", "value": 4308.632811862725}, {"lowerIsBetter": false, "replicates": [298.7326342923084, 298.9491786396312, 303.8101186758276, 306.19928885963213, 307.78455081442996, 6027.126066720323, 6057.363976782435, 6079.11852781347, 6166.506679465643, 6192.72132754026, 6056.061310496869, 6058.666773327465, 6066.30237522685, 6076.817695469132, 6090.269167699882, 4404.427424434819, 4629.259318509039, 4631.120087183441, 4631.143238500871, 4639.907201855961, 4493.483249426309, 4524.2082635538645, 4637.04940487201, 4641.767911604406, 4647.117047760915, 4548.113117942003, 4549.203889319372, 4571.428571428572, 4572.382728331666, 4573.176828170945, 4323.524412314643, 4418.1605494956175, 4466.12910482456, 4573.748443835588, 4584.908301833962, 3978.5424676162324, 4003.2994226010624, 4009.699272554541, 4010.6189911958318, 4015.0765323975647, 5766.596338256324, 5772.163036359746, 5772.7113644317615, 5773.769049238025, 5779.711014449303, 5283.6037297202865, 5300.787968481256, 5301.3373328333955, 5304.840854774363, 5350.180938480935, 6297.716602752887, 6428.19647544057, 6428.967855160741, 6431.935680643227, 6435.806925792233, 4406.25093734066, 4416.6025057744955, 4420.602145806893, 4424.513303536608, 4432.867013989586, 6692.531522793406, 6696.363845434676, 6701.698423570902, 6701.832454188684, 6705.932940670579, 4435.3125265583885, 4493.842715504941, 4528.117017181618, 4528.184926713157, 4538.977305113519, 4580.748058856795, 4581.427321584802, 4582.518835522289, 4583.977080114578, 4585.518520555293, 5299.31108955841, 5325.547328477045, 5334.333208348957, 5334.946650533522, 5339.652922560022, 6540.901886471706, 6543.051257567721, 6553.082568440422, 6553.442957348583, 6558.114654521674, 1588.7060893734697, 1601.927913243907, 1619.8947068440514, 1625.1305551529874, 1626.9430569929996, 1053.1574740207957, 1076.3272954403499, 1079.8164312066967, 1083.3066837224183, 1087.065123993365, 6271.62370257786, 6272.027835685385, 6277.5605707600025, 6280.340564240781, 6283.968580157161, 6671.132752742113, 6713.093732346071, 6713.0937323461685, 6720.22717387497, 6728.091707619409, 6093.786717464867, 6242.5942313750365, 6243.43809057178, 6250.874982500324, 6255.0, 3518.5425894633536, 3614.7469677122876, 3619.4570814378053, 3620.5474315710535, 3621.3300539400293, 6751.729930802811, 6940.063091482585, 6999.160100787938, 7008.684609192598, 7024.367806897404, 6960.37356637905, 6963.79108626742, 6966.9303306967295, 6985.406240469617, 6988.79033628992, 6842.692078856364, 6954.061201737802, 6959.0, 6975.651217439107, 6979.755708550177, 6726.327367263235, 6756.871585450567, 6762.898556521558, 6766.7969960901255, 6767.627780472121, 6648.966755166193, 6670.933290667225, 6683.9639855822425, 6686.732530698718, 6697.531172817856, 6804.829879253059, 7029.824254393681, 7034.683439245144, 7035.507514473938, 7040.823979400556, 4423.62399196072, 4453.866384008485, 4457.064016556559, 4461.152381047591, 4464.642828573771, 6761.966190169214, 6791.0, 6799.2520822708475, 6805.353491418307, 6806.319368063154, 6476.319986401549, 6608.8347791305605, 6618.238902526078, 6619.27188009309, 6620.404163625297, 6574.408303252731, 6580.045893345534, 6587.341265873374, 6593.571417857824, 6598.736050558116, 6386.68066596659, 6488.0, 6492.31830657793, 6494.577852439576, 6503.25212600557, 6642.933570664231, 6646.700898459484, 6649.767258146136, 6649.966750166412, 6657.367550082734, 6464.515161362822, 6471.417572418317, 6473.902891456726, 6478.0, 6486.0], "unit": "ms", "name": "prototype.html", "value": 4857.601805107408}, {"lowerIsBetter": false, "replicates": [744.7132853851266, 796.1878883538791, 823.7693445835166, 830.3979614779286, 850.1583432401924, 10162.542685579148, 10181.389116652997, 10208.897911020897, 10240.692779216617, 10301.742456438575, 12166.75666486672, 12459.439325230363, 12880.0, 12976.610701678941, 13048.934755326234, 793.9325157361617, 803.1045384396415, 803.337246771416, 803.4737247103157, 804.5012092502627, 803.4135081390589, 804.2560631415946, 804.8189157439588, 804.859149648812, 805.8106345008919, 840.4285086141422, 842.2125312832521, 844.5819319436887, 850.2857599616322, 852.6333676519125, 843.633019636457, 845.0915266088948, 846.851800934837, 850.4684572142411, 852.2713080316364, 614.7878981751288, 616.2389449030444, 616.2389449030488, 617.3641149615858, 623.8502759337772, 12199.268043917393, 12351.752964940652, 12352.197107188003, 12355.691107722289, 12358.44387002587, 10663.946680266548, 10782.299150555189, 10854.511546980404, 11036.11711063121, 11247.268927519684, 9831.852522212173, 9842.409455432697, 9855.655052073143, 9901.35641183328, 9954.800903981879, 3708.4251940948925, 3711.4432835074685, 3717.237966216919, 3773.5094437723196, 3841.0397400649836, 39848.40227396591, 40667.55994640302, 44403.333949990774, 45091.54908450939, 46516.76741616304, 8726.132459854593, 9650.420974741539, 9850.408975461496, 9954.303198776017, 10387.428691421894, 15114.0, 16365.918170409072, 16548.669026619402, 16594.6681066378, 16620.501384958472, 7123.536970096927, 7166.820829479305, 7275.599842008634, 7595.810104747315, 7608.619569021637, 4162.521310049323, 4375.5405682403525, 4411.139827733561, 4425.535318791481, 4427.313766366218, 3138.544910987894, 3170.556122142902, 3170.6353769316825, 3171.3657268546385, 3173.2225604726527, 568.8435680187981, 569.2855466389655, 570.7916610437161, 573.3320681406199, 585.4467528185824, 642.6497558830449, 663.7477758451757, 667.7462564225564, 681.3561184680528, 683.9145106861642, 7649.770506884803, 8127.471714338549, 8293.377996650275, 8393.580320983927, 8459.407841451039, 636.522608043967, 644.4296797334299, 654.7053825778419, 668.7458765669014, 696.2271878215178, 3685.7972811495624, 3693.575238847513, 3768.2086761779783, 3881.5536213335263, 3888.202918401721, 56098.71950640221, 56840.758090077536, 57413.13880291799, 57517.424825752045, 58043.70978145167, 49493.0, 50196.74901625468, 50637.74681126644, 50707.74646126746, 51156.48843511517, 46038.0, 46290.30564541535, 46308.3053754194, 47131.29303060457, 48149.74053373039, 7427.740029098955, 7541.811454713676, 7610.124835643972, 7642.5032372895585, 7743.883841742266, 34783.0, 35113.824430877685, 35293.82353088218, 35871.82064089663, 36529.26941461103, 38714.22571548609, 39613.207735845695, 42846.57153428426, 42922.78538607287, 43694.0, 10350.430726310125, 10516.894831051897, 10808.351498910091, 10849.186311026546, 10873.619423320146, 11314.943425282821, 11611.303321800719, 11694.766104678029, 11924.165308428326, 11980.820287695866, 9959.850602240827, 9966.152877005246, 10107.444090575089, 10430.895691043295, 10577.100946419641, 10427.791444170922, 10652.041316281571, 10704.411257380607, 10971.890281097407, 11000.669979900296, 10821.404822734825, 10919.126469882549, 11119.610813621484, 11220.1023918088, 11261.943690281496, 9055.501947392957, 9212.0, 9238.584263708015, 9339.85990210161, 9583.664571739955, 8688.739337819876, 8787.209151176425, 8992.997337015278, 9058.728238152866, 9588.857773041616], "unit": "ms", "name": "yui.html", "value": 6071.336141490029}], "name": "dromaeo_css", "value": 6979.339127866247}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 103.0, 110.0, 111.0, 109.0, 99.0, 108.0, 108.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [150.0, 124.0, 155.0, 176.0, 127.0, 165.0, 159.0, 128.0, 167.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 162.0, 160.0, 159.0, 160.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 81.0, 94.0, 71.0, 72.0, 72.0, 105.0, 92.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 137.0, 90.0, 90.0, 91.0, 131.0, 90.0, 91.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 103.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 145.0, 147.0, 147.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 60.0, 68.0, 56.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 73.0, 74.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 86.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [128.0, 117.0, 118.0, 115.0, 122.0, 119.0, 117.0, 116.0, 125.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.0}, {"lowerIsBetter": true, "replicates": [142.0, 145.0, 140.0, 151.0, 163.0, 147.0, 151.0, 150.0, 150.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 68.0, 68.0, 67.0, 65.0, 67.0, 67.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1499.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.15875346712352], "unit": "score", "name": "Richards", "value": 216.36595800000006}, {"lowerIsBetter": false, "replicates": [194.62826002335538], "unit": "score", "name": "DeltaBlue", "value": 339.714284}, {"lowerIsBetter": false, "replicates": [288.51702250432777], "unit": "score", "name": "Encrypt", "value": 922.5833459999998}, {"lowerIsBetter": false, "replicates": [5015.0], "unit": "score", "name": "Decrypt", "value": 53.07696909272185}, {"lowerIsBetter": false, "replicates": [1103.7527593818984], "unit": "score", "name": "RayTrace", "value": 670.4300340000001}, {"lowerIsBetter": false, "replicates": [785.0980392156863], "unit": "score", "name": "Earley", "value": 848.8914335664339}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [26526.315789473683], "unit": "score", "name": "RegExp", "value": 34.34268849206351}, {"lowerIsBetter": false, "replicates": [654.8788474132285], "unit": "score", "name": "Splay", "value": 124.43675700000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20829.7203842173}]} 04:07:48 INFO - RETURN: dromaeo_css: 6979.34 04:07:48 INFO - RETURN: kraken: 1499.40 04:07:48 INFO - RETURN: v8_7: 20829.72 04:07:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20829.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1499.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6979.34"}}} 04:07:48 INFO - Return code: 0 04:07:48 INFO - # TBPL SUCCESS # 04:07:48 INFO - Running post-action listener: _resource_record_post_action 04:07:48 INFO - Running post-run listener: _resource_record_post_run 04:07:49 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 497733632; Read time: 0; Write time: 351212 04:07:49 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 88068096; Read time: 0; Write time: 33216 04:07:49 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 303837184; Read time: 0; Write time: 215600 04:07:49 INFO - Running post-run listener: _upload_blobber_files 04:07:49 INFO - Blob upload gear active. 04:07:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:07:49 INFO - Copying logs to upload dir... 04:07:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.226930 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-21 04:07:48.811271) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 04:07:48.814508) ========= 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=6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010125 build_url: 'https://queue.taskcluster.net/v1/task/0ffqsuCvTfi3qFVyPEVWKA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 04:07:48.865085) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:07:48.865408) ========= 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=6587686cb2da90a5f91b3170000001be-1448105313.828014-1487936739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:07:48.916491) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 04:07:48.917020) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 04:07:48.917546) ========= ========= Total master_lag: 0.28 =========