builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1447984355.6 results: success (0) buildid: 20151119163036 builduid: 97d51d6fa1b141dbb1ed0852e80a538a revision: 7683624ba8265f0ea4ebb3aad1745cd978d6b57d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:35.600859) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:35.601396) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:35.601715) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006399 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:35.652337) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:35.652617) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:35.705117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:35.705367) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.029755 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:35.755543) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:35.755806) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:35.756440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:35.756716) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 17:52: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% 227M=0s 2015-11-19 17:52:36 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.220108 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:35.989577) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:35.989869) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.117928 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:36.125077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:36.125382) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7683624ba8265f0ea4ebb3aad1745cd978d6b57d --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 7683624ba8265f0ea4ebb3aad1745cd978d6b57d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 17:52:36,254 truncating revision to first 12 chars 2015-11-19 17:52:36,254 Setting DEBUG logging. 2015-11-19 17:52:36,254 attempt 1/10 2015-11-19 17:52:36,254 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7683624ba826?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 17:52:36,584 unpacking tar archive at: mozilla-inbound-7683624ba826/testing/mozharness/ program finished with exit code 0 elapsedTime=0.591836 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:36.729705) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:36.729998) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:36.736435) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:36.736705) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 17:52:36.737126) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2015-11-19 17:52:36.737418) ========= /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=76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:52:37 INFO - MultiFileLogger online at 20151119 17:52:37 in /builds/slave/test-pgo 17:52: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 17:52:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:52:37 INFO - {'append_to_log': False, 17:52:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:52:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 17:52:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:52:37 INFO - 'branch': 'Mozilla-Inbound', 17:52:37 INFO - 'buildbot_json_path': 'buildprops.json', 17:52:37 INFO - 'config_files': ('talos/linux_config.py',), 17:52:37 INFO - 'default_actions': ('clobber', 17:52:37 INFO - 'read-buildbot-config', 17:52:37 INFO - 'download-and-extract', 17:52:37 INFO - 'populate-webroot', 17:52:37 INFO - 'create-virtualenv', 17:52:37 INFO - 'install', 17:52:37 INFO - 'run-tests'), 17:52:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:52:37 INFO - 'download_minidump_stackwalk': True, 17:52:37 INFO - 'download_symbols': 'ondemand', 17:52:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:52:37 INFO - 'tooltool.py': '/tools/tooltool.py', 17:52:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:52:37 INFO - '/tools/misc-python/virtualenv.py')}, 17:52:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:52:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:52:37 INFO - 'installer_path': 'installer.exe', 17:52:37 INFO - 'log_level': 'info', 17:52:37 INFO - 'log_name': 'talos', 17:52:37 INFO - 'log_to_console': True, 17:52:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:52:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:52:37 INFO - 'opt_config_files': (), 17:52:37 INFO - 'pip_index': False, 17:52:37 INFO - 'sps_profile': False, 17:52:37 INFO - 'sps_profile_interval': 0, 17:52:37 INFO - 'suite': 'dromaeojs', 17:52:37 INFO - 'system_bits': '64', 17:52:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:52:37 INFO - 'title': 'talos-linux64-ix-011', 17:52:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:52:37 INFO - 'use_talos_json': True, 17:52:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:52:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:52:37 INFO - 'work_dir': 'build'} 17:52:37 INFO - ##### 17:52:37 INFO - ##### Running clobber step. 17:52:37 INFO - ##### 17:52:37 INFO - Running pre-action listener: _resource_record_pre_action 17:52:37 INFO - Running main action method: clobber 17:52:37 INFO - rmtree: /builds/slave/test-pgo/build 17:52:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:52:38 INFO - Running post-action listener: _resource_record_post_action 17:52:38 INFO - ##### 17:52:38 INFO - ##### Running read-buildbot-config step. 17:52:38 INFO - ##### 17:52:38 INFO - Running pre-action listener: _resource_record_pre_action 17:52:38 INFO - Running main action method: read_buildbot_config 17:52:38 INFO - Using buildbot properties: 17:52:38 INFO - { 17:52:38 INFO - "properties": { 17:52:38 INFO - "buildnumber": 1283, 17:52:38 INFO - "product": "firefox", 17:52:38 INFO - "script_repo_revision": "production", 17:52:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 17:52:38 INFO - "repository": "", 17:52:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 17:52:38 INFO - "buildid": "20151119163036", 17:52:38 INFO - "slavename": "talos-linux64-ix-011", 17:52:38 INFO - "pgo_build": "True", 17:52:38 INFO - "basedir": "/builds/slave/test-pgo", 17:52:38 INFO - "project": "", 17:52:38 INFO - "platform": "ubuntu64_hw", 17:52:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:52:38 INFO - "slavebuilddir": "test", 17:52:38 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 17:52:38 INFO - "branch": "mozilla-inbound", 17:52:38 INFO - "repo_path": "integration/mozilla-inbound", 17:52:38 INFO - "stage_platform": "linux64-pgo", 17:52:38 INFO - "builduid": "97d51d6fa1b141dbb1ed0852e80a538a", 17:52:38 INFO - "revision": "7683624ba8265f0ea4ebb3aad1745cd978d6b57d" 17:52:38 INFO - }, 17:52:38 INFO - "sourcestamp": { 17:52:38 INFO - "repository": "", 17:52:38 INFO - "hasPatch": false, 17:52:38 INFO - "project": "", 17:52:38 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 17:52:38 INFO - "changes": [ 17:52:38 INFO - { 17:52:38 INFO - "category": null, 17:52:38 INFO - "files": [ 17:52:38 INFO - { 17:52:38 INFO - "url": null, 17:52:38 INFO - "name": "https://queue.taskcluster.net/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 17:52:38 INFO - } 17:52:38 INFO - ], 17:52:38 INFO - "repository": "", 17:52:38 INFO - "rev": "7683624ba8265f0ea4ebb3aad1745cd978d6b57d", 17:52:38 INFO - "who": "sendchange", 17:52:38 INFO - "when": 1447984308, 17:52:38 INFO - "number": 6686356, 17:52:38 INFO - "comments": "", 17:52:38 INFO - "project": "", 17:52:38 INFO - "at": "Thu 19 Nov 2015 17:51:48", 17:52:38 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 17:52:38 INFO - "revlink": "", 17:52:38 INFO - "properties": [ 17:52:38 INFO - [ 17:52:38 INFO - "buildid", 17:52:38 INFO - "20151119163036", 17:52:38 INFO - "Change" 17:52:38 INFO - ], 17:52:38 INFO - [ 17:52:38 INFO - "builduid", 17:52:38 INFO - "97d51d6fa1b141dbb1ed0852e80a538a", 17:52:38 INFO - "Change" 17:52:38 INFO - ], 17:52:38 INFO - [ 17:52:38 INFO - "pgo_build", 17:52:38 INFO - "True", 17:52:38 INFO - "Change" 17:52:38 INFO - ] 17:52:38 INFO - ], 17:52:38 INFO - "revision": "7683624ba8265f0ea4ebb3aad1745cd978d6b57d" 17:52:38 INFO - } 17:52:38 INFO - ], 17:52:38 INFO - "revision": "7683624ba8265f0ea4ebb3aad1745cd978d6b57d" 17:52:38 INFO - } 17:52:38 INFO - } 17:52:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 17:52:38 INFO - Running post-action listener: _resource_record_post_action 17:52:38 INFO - ##### 17:52:38 INFO - ##### Running download-and-extract step. 17:52:38 INFO - ##### 17:52:38 INFO - Running pre-action listener: _resource_record_pre_action 17:52:38 INFO - Running main action method: download_and_extract 17:52:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:52:38 INFO - https://queue.taskcluster.net/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/test_packages.json 17:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/test_packages.json 17:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:52:49 INFO - Downloaded 1302 bytes. 17:52:49 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:52:49 INFO - Using the following test package requirements: 17:52:49 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:52:49 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:52:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:52:49 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:52:49 INFO - u'jsshell-linux-x86_64.zip'], 17:52:49 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:52:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:52:49 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:52:49 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:52:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:52:49 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:52:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:52:49 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:52:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:52:49 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:52:49 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:52:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:52:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:52:49 INFO - https://queue.taskcluster.net/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:52:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:52:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:52:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:52:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:53:10 INFO - Downloaded 22530447 bytes. 17:53:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 17:53:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:53:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:53:11 INFO - Return code: 0 17:53:11 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:53: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')]} 17:53:11 INFO - https://queue.taskcluster.net/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:53:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:53:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:53:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:53:12 INFO - Downloaded 22530447 bytes. 17:53:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 17:53:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:53:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:53:13 INFO - Return code: 0 17:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:13 INFO - https://queue.taskcluster.net/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:53:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:53:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:53:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:53:14 INFO - Downloaded 11130997 bytes. 17:53:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 17:53:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:53:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:53:15 INFO - Return code: 0 17:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:15 INFO - https://queue.taskcluster.net/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:53:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:53:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:53:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:53:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:53:18 INFO - Downloaded 57345265 bytes. 17:53:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:53:18 INFO - mkdir: /builds/slave/test-pgo/properties 17:53:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:53:18 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:53:18 INFO - Contents: 17:53:18 INFO - build_url:https://queue.taskcluster.net/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:53:18 INFO - Running post-action listener: _resource_record_post_action 17:53:18 INFO - Running post-action listener: set_extra_try_arguments 17:53:18 INFO - ##### 17:53:18 INFO - ##### Running populate-webroot step. 17:53:18 INFO - ##### 17:53:18 INFO - Running pre-action listener: _resource_record_pre_action 17:53:18 INFO - Running main action method: populate_webroot 17:53:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:53:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:53:18 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:53:18 INFO - '../fennec_ids.txt'], 17:53:18 INFO - 'tests': ['tcheck2']}, 17:53:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:53:18 INFO - '--tppagecycles', 17:53:18 INFO - '7'], 17:53:18 INFO - 'tests': ['tsvgm']}}, 17:53:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:53:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:53:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:53:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:53:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:53:18 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:53:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:53:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:18 INFO - 'talos_options': ['--e10s'], 17:53:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:53:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:18 INFO - 'tests': ['damp', 'tps']}, 17:53:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:18 INFO - 'talos_options': ['--e10s'], 17:53:18 INFO - 'tests': ['damp', 'tps']}, 17:53:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:53:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:53:18 INFO - 'other': {'tests': ['a11yr', 17:53:18 INFO - 'ts_paint', 17:53:18 INFO - 'tpaint', 17:53:18 INFO - 'sessionrestore', 17:53:18 INFO - 'sessionrestore_no_auto_restore']}, 17:53:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:53:18 INFO - 'tests': ['a11yr', 17:53:18 INFO - 'ts_paint', 17:53:18 INFO - 'tpaint', 17:53:18 INFO - 'sessionrestore', 17:53:18 INFO - 'sessionrestore_no_auto_restore']}, 17:53:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:53:18 INFO - 'tests': ['a11yr', 17:53:18 INFO - 'ts_paint', 17:53:18 INFO - 'tpaint', 17:53:18 INFO - 'sessionrestore', 17:53:18 INFO - 'sessionrestore_no_auto_restore']}, 17:53:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:53:18 INFO - 'tests': ['a11yr', 17:53:18 INFO - 'ts_paint', 17:53:18 INFO - 'tpaint', 17:53:18 INFO - 'sessionrestore', 17:53:18 INFO - 'sessionrestore_no_auto_restore']}, 17:53:18 INFO - 'other_l64': {'tests': ['a11yr', 17:53:18 INFO - 'ts_paint', 17:53:18 INFO - 'tpaint', 17:53:18 INFO - 'sessionrestore', 17:53:18 INFO - 'sessionrestore_no_auto_restore']}, 17:53:18 INFO - 'other_nol64': {'tests': ['a11yr', 17:53:18 INFO - 'ts_paint', 17:53:18 INFO - 'tpaint', 17:53:18 INFO - 'sessionrestore', 17:53:18 INFO - 'sessionrestore_no_auto_restore']}, 17:53:18 INFO - 'svgr': {'tests': ['tsvgx', 17:53:18 INFO - 'tsvgr_opacity', 17:53:18 INFO - 'tart', 17:53:18 INFO - 'tscrollx', 17:53:18 INFO - 'cart']}, 17:53:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:53:18 INFO - 'tests': ['tsvgx', 17:53:18 INFO - 'tsvgr_opacity', 17:53:18 INFO - 'tart', 17:53:18 INFO - 'tscrollx', 17:53:18 INFO - 'cart']}, 17:53:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:18 INFO - 'tests': ['tp5o']}, 17:53:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:18 INFO - 'talos_options': ['--e10s'], 17:53:18 INFO - 'tests': ['tp5o']}, 17:53:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:18 INFO - 'talos_options': ['--xperf_path', 17:53:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:53:18 INFO - 'tests': ['tp5n']}, 17:53:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:18 INFO - 'talos_options': ['--e10s', 17:53:18 INFO - '--xperf_path', 17:53:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:53:18 INFO - 'tests': ['tp5n']}}, 17:53:18 INFO - 'talos.zip': {'path': '', 17:53:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:53:18 INFO - Running post-action listener: _resource_record_post_action 17:53:18 INFO - ##### 17:53:18 INFO - ##### Running create-virtualenv step. 17:53:18 INFO - ##### 17:53:18 INFO - Running pre-action listener: _resource_record_pre_action 17:53:18 INFO - Running main action method: create_virtualenv 17:53:18 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:53:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 17:53:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:53:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:53:19 INFO - Using real prefix '/usr' 17:53:19 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:53:19 INFO - Installing distribute.............................................................................................................................................................................................done. 17:53:21 INFO - Installing pip.................done. 17:53:21 INFO - Return code: 0 17:53:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:53: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')]} 17:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53: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')]} 17:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53: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', '--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 0x7f23a6adac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23807c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c4d70>, '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 0x23c5b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c5fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:53:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:53:21 INFO - Using env: {'DISPLAY': ':0', 17:53:21 INFO - 'HOME': '/home/cltbld', 17:53:21 INFO - 'LANG': 'en_US.UTF-8', 17:53:21 INFO - 'LANGUAGE': 'en_US:en', 17:53:21 INFO - 'LOGNAME': 'cltbld', 17:53:21 INFO - 'MAIL': '/var/mail/cltbld', 17:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:21 INFO - 'MOZ_NO_REMOTE': '1', 17:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:21 INFO - 'NO_EM_RESTART': '1', 17:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:53:21 INFO - 'PWD': '/builds/slave/test-pgo', 17:53:21 INFO - 'SHELL': '/bin/bash', 17:53:21 INFO - 'SHLVL': '1', 17:53:21 INFO - 'TERM': 'linux', 17:53:21 INFO - 'TMOUT': '86400', 17:53:21 INFO - 'USER': 'cltbld', 17:53:21 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 17:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:21 INFO - '_': '/tools/buildbot/bin/python'} 17:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:53:22 INFO - Cleaning up... 17:53:22 INFO - Return code: 0 17:53:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:22 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 0x7f23a6adac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23807c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c4d70>, '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 0x23c5b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c5fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:53:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:53:22 INFO - Using env: {'DISPLAY': ':0', 17:53:22 INFO - 'HOME': '/home/cltbld', 17:53:22 INFO - 'LANG': 'en_US.UTF-8', 17:53:22 INFO - 'LANGUAGE': 'en_US:en', 17:53:22 INFO - 'LOGNAME': 'cltbld', 17:53:22 INFO - 'MAIL': '/var/mail/cltbld', 17:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:22 INFO - 'MOZ_NO_REMOTE': '1', 17:53:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:22 INFO - 'NO_EM_RESTART': '1', 17:53:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:53:22 INFO - 'PWD': '/builds/slave/test-pgo', 17:53:22 INFO - 'SHELL': '/bin/bash', 17:53:22 INFO - 'SHLVL': '1', 17:53:22 INFO - 'TERM': 'linux', 17:53:22 INFO - 'TMOUT': '86400', 17:53:22 INFO - 'USER': 'cltbld', 17:53:22 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 17:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:22 INFO - '_': '/tools/buildbot/bin/python'} 17:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:22 INFO - Downloading/unpacking psutil>=0.7.1 17:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:24 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:53:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:53:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:53:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:53:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:53:24 INFO - Installing collected packages: psutil 17:53:24 INFO - Running setup.py install for psutil 17:53:24 INFO - building 'psutil._psutil_linux' extension 17:53:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:53:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:53:25 INFO - building 'psutil._psutil_posix' extension 17:53:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:53:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:53:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:53:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:53:26 INFO - Successfully installed psutil 17:53:26 INFO - Cleaning up... 17:53:26 INFO - Return code: 0 17:53:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:26 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 0x7f23a6adac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23807c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c4d70>, '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 0x23c5b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c5fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:53:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:53:26 INFO - Using env: {'DISPLAY': ':0', 17:53:26 INFO - 'HOME': '/home/cltbld', 17:53:26 INFO - 'LANG': 'en_US.UTF-8', 17:53:26 INFO - 'LANGUAGE': 'en_US:en', 17:53:26 INFO - 'LOGNAME': 'cltbld', 17:53:26 INFO - 'MAIL': '/var/mail/cltbld', 17:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:26 INFO - 'MOZ_NO_REMOTE': '1', 17:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:26 INFO - 'NO_EM_RESTART': '1', 17:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:53:26 INFO - 'PWD': '/builds/slave/test-pgo', 17:53:26 INFO - 'SHELL': '/bin/bash', 17:53:26 INFO - 'SHLVL': '1', 17:53:26 INFO - 'TERM': 'linux', 17:53:26 INFO - 'TMOUT': '86400', 17:53:26 INFO - 'USER': 'cltbld', 17:53:26 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 17:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:26 INFO - '_': '/tools/buildbot/bin/python'} 17:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:53:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:53:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:53:28 INFO - Installing collected packages: mozsystemmonitor 17:53:28 INFO - Running setup.py install for mozsystemmonitor 17:53:28 INFO - Successfully installed mozsystemmonitor 17:53:28 INFO - Cleaning up... 17:53:28 INFO - Return code: 0 17:53:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:28 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 0x7f23a6adac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23807c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c4d70>, '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 0x23c5b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c5fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:53:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:53:28 INFO - Using env: {'DISPLAY': ':0', 17:53:28 INFO - 'HOME': '/home/cltbld', 17:53:28 INFO - 'LANG': 'en_US.UTF-8', 17:53:28 INFO - 'LANGUAGE': 'en_US:en', 17:53:28 INFO - 'LOGNAME': 'cltbld', 17:53:28 INFO - 'MAIL': '/var/mail/cltbld', 17:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:28 INFO - 'MOZ_NO_REMOTE': '1', 17:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:28 INFO - 'NO_EM_RESTART': '1', 17:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:53:28 INFO - 'PWD': '/builds/slave/test-pgo', 17:53:28 INFO - 'SHELL': '/bin/bash', 17:53:28 INFO - 'SHLVL': '1', 17:53:28 INFO - 'TERM': 'linux', 17:53:28 INFO - 'TMOUT': '86400', 17:53:28 INFO - 'USER': 'cltbld', 17:53:28 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 17:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:28 INFO - '_': '/tools/buildbot/bin/python'} 17:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:28 INFO - Downloading/unpacking blobuploader==1.2.4 17:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:30 INFO - Downloading blobuploader-1.2.4.tar.gz 17:53:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:53:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:53:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:53:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:53:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:30 INFO - Downloading docopt-0.6.1.tar.gz 17:53:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:53:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:53:30 INFO - Installing collected packages: blobuploader, requests, docopt 17:53:30 INFO - Running setup.py install for blobuploader 17:53:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:53:30 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:53:30 INFO - Running setup.py install for requests 17:53:31 INFO - Running setup.py install for docopt 17:53:31 INFO - Successfully installed blobuploader requests docopt 17:53:31 INFO - Cleaning up... 17:53:31 INFO - Return code: 0 17:53:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:31 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 0x7f23a6adac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23807c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c4d70>, '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 0x23c5b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c5fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:53:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:53:31 INFO - Using env: {'DISPLAY': ':0', 17:53:31 INFO - 'HOME': '/home/cltbld', 17:53:31 INFO - 'LANG': 'en_US.UTF-8', 17:53:31 INFO - 'LANGUAGE': 'en_US:en', 17:53:31 INFO - 'LOGNAME': 'cltbld', 17:53:31 INFO - 'MAIL': '/var/mail/cltbld', 17:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:31 INFO - 'MOZ_NO_REMOTE': '1', 17:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:31 INFO - 'NO_EM_RESTART': '1', 17:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:53:31 INFO - 'PWD': '/builds/slave/test-pgo', 17:53:31 INFO - 'SHELL': '/bin/bash', 17:53:31 INFO - 'SHLVL': '1', 17:53:31 INFO - 'TERM': 'linux', 17:53:31 INFO - 'TMOUT': '86400', 17:53:31 INFO - 'USER': 'cltbld', 17:53:31 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 17:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:31 INFO - '_': '/tools/buildbot/bin/python'} 17:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:53:31 INFO - Running setup.py (path:/tmp/pip-T68N2G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:53:31 INFO - Running setup.py (path:/tmp/pip-eEBxOv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:53:31 INFO - Running setup.py (path:/tmp/pip-AiuVKg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:53:31 INFO - Running setup.py (path:/tmp/pip-HR5og8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:53:31 INFO - Running setup.py (path:/tmp/pip-jabRqm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:53:31 INFO - Running setup.py (path:/tmp/pip-yAnQtj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:53:32 INFO - Running setup.py (path:/tmp/pip-wvIur6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:53:32 INFO - Running setup.py (path:/tmp/pip-cX0LlV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:53:32 INFO - Running setup.py (path:/tmp/pip-x4QWBI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:53:32 INFO - Running setup.py (path:/tmp/pip-IQZOUU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:53:32 INFO - Running setup.py (path:/tmp/pip-WAok7L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:53:32 INFO - Running setup.py (path:/tmp/pip-ixZmz9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:53:32 INFO - Running setup.py (path:/tmp/pip-MPRbVa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:53:32 INFO - Running setup.py (path:/tmp/pip-Fv_gU1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:53:32 INFO - Running setup.py (path:/tmp/pip-PBoWNK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:53:32 INFO - Running setup.py (path:/tmp/pip-ko6hcu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:53:32 INFO - Running setup.py (path:/tmp/pip-BHx7Aw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:53:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:53:32 INFO - Running setup.py install for manifestparser 17:53:32 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:53:32 INFO - Running setup.py install for mozcrash 17:53:33 INFO - Running setup.py install for mozdebug 17:53:33 INFO - Running setup.py install for mozdevice 17:53:33 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:53:33 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:53:33 INFO - Running setup.py install for mozfile 17:53:33 INFO - Running setup.py install for mozhttpd 17:53:33 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:53:33 INFO - Running setup.py install for mozinfo 17:53:33 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:53:33 INFO - Running setup.py install for mozInstall 17:53:33 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:53:33 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:53:33 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:53:33 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:53:33 INFO - Running setup.py install for mozleak 17:53:33 INFO - Running setup.py install for mozlog 17:53:33 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:53:33 INFO - Running setup.py install for moznetwork 17:53:33 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:53:33 INFO - Running setup.py install for mozprocess 17:53:34 INFO - Running setup.py install for mozprofile 17:53:34 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:53:34 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:53:34 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:53:34 INFO - Running setup.py install for mozrunner 17:53:34 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:53:34 INFO - Running setup.py install for mozscreenshot 17:53:34 INFO - Running setup.py install for moztest 17:53:34 INFO - Running setup.py install for mozversion 17:53:34 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:53:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:53:34 INFO - Cleaning up... 17:53:34 INFO - Return code: 0 17:53:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:34 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 0x7f23a6adac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23807c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c4d70>, '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 0x23c5b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c5fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:53:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:53:34 INFO - Using env: {'DISPLAY': ':0', 17:53:34 INFO - 'HOME': '/home/cltbld', 17:53:34 INFO - 'LANG': 'en_US.UTF-8', 17:53:34 INFO - 'LANGUAGE': 'en_US:en', 17:53:34 INFO - 'LOGNAME': 'cltbld', 17:53:34 INFO - 'MAIL': '/var/mail/cltbld', 17:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:34 INFO - 'MOZ_NO_REMOTE': '1', 17:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:34 INFO - 'NO_EM_RESTART': '1', 17:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:53:34 INFO - 'PWD': '/builds/slave/test-pgo', 17:53:34 INFO - 'SHELL': '/bin/bash', 17:53:34 INFO - 'SHLVL': '1', 17:53:34 INFO - 'TERM': 'linux', 17:53:34 INFO - 'TMOUT': '86400', 17:53:34 INFO - 'USER': 'cltbld', 17:53:34 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 17:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:34 INFO - '_': '/tools/buildbot/bin/python'} 17:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:53:34 INFO - Running setup.py (path:/tmp/pip-onaY0N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 17:53:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:53:34 INFO - Running setup.py (path:/tmp/pip-SKL4sZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:53:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:53:34 INFO - Running setup.py (path:/tmp/pip-1eQ2yJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:53:35 INFO - Running setup.py (path:/tmp/pip-IqSVNY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:53:35 INFO - Running setup.py (path:/tmp/pip-nwn0ku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:53:35 INFO - Running setup.py (path:/tmp/pip-ExQFCT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:53:35 INFO - Running setup.py (path:/tmp/pip-xQUnDw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:53:35 INFO - Running setup.py (path:/tmp/pip-lp_xFN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:53:35 INFO - Running setup.py (path:/tmp/pip-aUV9UK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:53:35 INFO - Running setup.py (path:/tmp/pip-Zx2z48-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:53:35 INFO - Running setup.py (path:/tmp/pip-25iXV3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:53:35 INFO - Running setup.py (path:/tmp/pip-0qGsw4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:53:35 INFO - Running setup.py (path:/tmp/pip-uvSSeF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:53:35 INFO - Running setup.py (path:/tmp/pip-Na_IIE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:53:35 INFO - Running setup.py (path:/tmp/pip-U8rAfL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:53:35 INFO - Running setup.py (path:/tmp/pip-pyCwUr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 17:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:53:35 INFO - Running setup.py (path:/tmp/pip-iEKTGM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 17:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:53:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:37 INFO - Downloading blessings-1.5.1.tar.gz 17:53:37 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 17:53:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:53:37 INFO - Installing collected packages: blessings 17:53:37 INFO - Running setup.py install for blessings 17:53:37 INFO - Successfully installed blessings 17:53:37 INFO - Cleaning up... 17:53:37 INFO - Return code: 0 17:53:37 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:53:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:53:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:53:38 INFO - Reading from file tmpfile_stdout 17:53:38 INFO - Current package versions: 17:53:38 INFO - argparse == 1.2.1 17:53:38 INFO - blessings == 1.5.1 17:53:38 INFO - blobuploader == 1.2.4 17:53:38 INFO - docopt == 0.6.1 17:53:38 INFO - manifestparser == 1.1 17:53:38 INFO - mozInstall == 1.12 17:53:38 INFO - mozcrash == 0.16 17:53:38 INFO - mozdebug == 0.1 17:53:38 INFO - mozdevice == 0.47 17:53:38 INFO - mozfile == 1.2 17:53:38 INFO - mozhttpd == 0.7 17:53:38 INFO - mozinfo == 0.9 17:53:38 INFO - mozleak == 0.1 17:53:38 INFO - mozlog == 3.0 17:53:38 INFO - moznetwork == 0.27 17:53:38 INFO - mozprocess == 0.22 17:53:38 INFO - mozprofile == 0.27 17:53:38 INFO - mozrunner == 6.11 17:53:38 INFO - mozscreenshot == 0.1 17:53:38 INFO - mozsystemmonitor == 0.0 17:53:38 INFO - moztest == 0.7 17:53:38 INFO - mozversion == 1.4 17:53:38 INFO - psutil == 3.1.1 17:53:38 INFO - requests == 1.2.3 17:53:38 INFO - wsgiref == 0.1.2 17:53:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:38 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 0x7f23a6adac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23807c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c4d70>, '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 0x23c5b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c5fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:38 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 17:53:38 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 17:53:38 INFO - Using env: {'DISPLAY': ':0', 17:53:38 INFO - 'HOME': '/home/cltbld', 17:53:38 INFO - 'LANG': 'en_US.UTF-8', 17:53:38 INFO - 'LANGUAGE': 'en_US:en', 17:53:38 INFO - 'LOGNAME': 'cltbld', 17:53:38 INFO - 'MAIL': '/var/mail/cltbld', 17:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:38 INFO - 'MOZ_NO_REMOTE': '1', 17:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:38 INFO - 'NO_EM_RESTART': '1', 17:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:53:38 INFO - 'PWD': '/builds/slave/test-pgo', 17:53:38 INFO - 'SHELL': '/bin/bash', 17:53:38 INFO - 'SHLVL': '1', 17:53:38 INFO - 'TERM': 'linux', 17:53:38 INFO - 'TMOUT': '86400', 17:53:38 INFO - 'USER': 'cltbld', 17:53:38 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 17:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:38 INFO - '_': '/tools/buildbot/bin/python'} 17:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:38 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)) 17:53:38 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)) 17:53:38 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)) 17:53:38 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)) 17:53:38 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)) 17:53:38 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)) 17:53:38 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)) 17:53:38 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)) 17:53:38 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)) 17:53:38 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)) 17:53:38 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)) 17:53:38 INFO - Cleaning up... 17:53:38 INFO - Return code: 0 17:53:38 INFO - Running post-action listener: _resource_record_post_action 17:53:38 INFO - Running post-action listener: _start_resource_monitoring 17:53:38 INFO - Starting resource monitoring. 17:53:38 INFO - ##### 17:53:38 INFO - ##### Running install step. 17:53:38 INFO - ##### 17:53:38 INFO - Running pre-action listener: _resource_record_pre_action 17:53:38 INFO - Running main action method: install 17:53:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:53:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:53:38 INFO - Reading from file tmpfile_stdout 17:53:38 INFO - Detecting whether we're running mozinstall >=1.0... 17:53:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:53:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:53:38 INFO - Reading from file tmpfile_stdout 17:53:38 INFO - Output received: 17:53:38 INFO - Usage: mozinstall [options] installer 17:53:38 INFO - Options: 17:53:38 INFO - -h, --help show this help message and exit 17:53:38 INFO - -d DEST, --destination=DEST 17:53:38 INFO - Directory to install application into. [default: 17:53:38 INFO - "/builds/slave/test-pgo"] 17:53:38 INFO - --app=APP Application being installed. [default: firefox] 17:53:38 INFO - mkdir: /builds/slave/test-pgo/build/application 17:53:38 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'] 17:53:38 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 17:53:53 INFO - Reading from file tmpfile_stdout 17:53:53 INFO - Output received: 17:53:53 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:53:53 INFO - Running post-action listener: _resource_record_post_action 17:53:53 INFO - ##### 17:53:53 INFO - ##### Running run-tests step. 17:53:53 INFO - ##### 17:53:53 INFO - Running pre-action listener: _resource_record_pre_action 17:53:53 INFO - Running main action method: run_tests 17:53:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:53:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:53:53 INFO - Python 2.7.3 17:53:53 INFO - Return code: 0 17:53:53 INFO - grabbing minidump binary from tooltool 17:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:53 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 0x23c4d70>, '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 0x23c5b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c5fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:53:53 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 17:53:53 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 17:53:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:53:53 INFO - Return code: 0 17:53:53 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:53:53 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:53:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:53:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:53:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:53:53 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/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 17:53:53 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/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 17:53:53 INFO - Using env: {'DISPLAY': ':0', 17:53:53 INFO - 'HOME': '/home/cltbld', 17:53:53 INFO - 'LANG': 'en_US.UTF-8', 17:53:53 INFO - 'LANGUAGE': 'en_US:en', 17:53:53 INFO - 'LOGNAME': 'cltbld', 17:53:53 INFO - 'MAIL': '/var/mail/cltbld', 17:53:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:53:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:53 INFO - 'MOZ_NO_REMOTE': '1', 17:53:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:53 INFO - 'NO_EM_RESTART': '1', 17:53:53 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:53:53 INFO - 'PWD': '/builds/slave/test-pgo', 17:53:53 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:53:53 INFO - 'SHELL': '/bin/bash', 17:53:53 INFO - 'SHLVL': '1', 17:53:53 INFO - 'TERM': 'linux', 17:53:53 INFO - 'TMOUT': '86400', 17:53:53 INFO - 'USER': 'cltbld', 17:53:53 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221', 17:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:53 INFO - '_': '/tools/buildbot/bin/python'} 17:53:53 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/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 17:53:54 INFO - mozversion INFO | application_buildid: 20151119163036 17:53:54 INFO - mozversion INFO | application_changeset: 7683624ba8265f0ea4ebb3aad1745cd978d6b57d 17:53:54 INFO - mozversion INFO | application_display_name: Nightly 17:53:54 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:53:54 INFO - mozversion INFO | application_name: Firefox 17:53:54 INFO - mozversion INFO | application_remotingname: firefox 17:53:54 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 17:53:54 INFO - mozversion INFO | application_vendor: Mozilla 17:53:54 INFO - mozversion INFO | application_version: 45.0a1 17:53:54 INFO - mozversion INFO | platform_buildid: 20151119163036 17:53:54 INFO - mozversion INFO | platform_changeset: 7683624ba8265f0ea4ebb3aad1745cd978d6b57d 17:53:54 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 17:53:54 INFO - mozversion INFO | platform_version: 45.0a1 17:53:54 INFO - 2015-11-19 17:53:54,183 DEBUG : using testdate: 1447984434 17:53:54 INFO - 2015-11-19 17:53:54,183 DEBUG : actual date: 1447984434 17:53:54 INFO - 2015-11-19 17:53:54,191 INFO : starting webserver on 'localhost:51937' 17:53:54 INFO - 2015-11-19 17:53:54,192 INFO : Starting test suite talos-linux64-ix-011 17:53:54 INFO - 2015-11-19 17:53:54,192 INFO : Starting test dromaeo_css 17:53:54 INFO - 2015-11-19 17:53:54,192 DEBUG : operating with platform_type : linux_ 17:53:54 INFO - 2015-11-19 17:53:54,192 INFO : Initialising browser for dromaeo_css test... 17:53:54 INFO - 2015-11-19 17:53:54,223 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ9fhkg/profile http://localhost:51937/getInfo.html 17:53:59 INFO - 2015-11-19 17:53:59,671 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:53:59 INFO - 2015-11-19 17:53:59,671 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:53:59 INFO - 2015-11-19 17:53:59,671 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:53:59 INFO - 2015-11-19 17:53:59,672 DEBUG : BROWSER_OUTPUT: __metrics 17:53:59 INFO - 2015-11-19 17:53:59,756 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:54:01 INFO - 2015-11-19 17:54:01,093 INFO : Browser initialized. 17:54:01 INFO - 2015-11-19 17:54:01,094 INFO : Running cycle 1/1 for dromaeo_css test... 17:54:01 INFO - 2015-11-19 17:54:01,094 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ9fhkg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:54:12 INFO - 2015-11-19 17:54:12,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 139718656 17:54:12 INFO - 2015-11-19 17:54:12,751 DEBUG : BROWSER_OUTPUT: 17:55:03 INFO - 2015-11-19 17:55:03,799 DEBUG : BROWSER_OUTPUT: 1447984503796 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] 17:57:14 INFO - 2015-11-19 17:57:14,027 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51937/tests/dromaeo/cssquery-ext.html) 17:57:15 INFO - 2015-11-19 17:57:15,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 248832000 17:57:15 INFO - 2015-11-19 17:57:15,116 DEBUG : BROWSER_OUTPUT: 18:00:17 INFO - 2015-11-19 18:00:17,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/dromaeo/cssquery-ext.html (next: http://localhost:51937/tests/dromaeo/cssquery-jquery.html) 18:00:17 INFO - 2015-11-19 18:00:17,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 221462528 18:00:17 INFO - 2015-11-19 18:00:17,933 DEBUG : BROWSER_OUTPUT: 18:03:19 INFO - 2015-11-19 18:03:19,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51937/tests/dromaeo/cssquery-mootools.html) 18:03:20 INFO - 2015-11-19 18:03:20,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 215617536 18:03:20 INFO - 2015-11-19 18:03:20,356 DEBUG : BROWSER_OUTPUT: 18:06:22 INFO - 2015-11-19 18:06:22,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51937/tests/dromaeo/cssquery-prototype.html) 18:06:22 INFO - 2015-11-19 18:06:22,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 200376320 18:06:22 INFO - 2015-11-19 18:06:22,773 DEBUG : BROWSER_OUTPUT: 18:09:25 INFO - 2015-11-19 18:09:25,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51937/tests/dromaeo/cssquery-yui.html) 18:09:25 INFO - 2015-11-19 18:09:25,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 203505664 18:09:25 INFO - 2015-11-19 18:09:25,851 DEBUG : BROWSER_OUTPUT: 18:12:28 INFO - 2015-11-19 18:12:28,289 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/dromaeo/cssquery-yui.html (next: http://localhost:51937/tests/dromaeo/cssquery-dojo.html) 18:12:28 INFO - 2015-11-19 18:12:28,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 254660608 18:12:28 INFO - 2015-11-19 18:12:28,547 DEBUG : BROWSER_OUTPUT: 18:12:28 INFO - 2015-11-19 18:12:28,547 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:12:28 INFO - 2015-11-19 18:12:28,548 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:12:28 INFO - 2015-11-19 18:12:28,548 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:12:28 INFO - 2015-11-19 18:12:28,548 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:12:28 INFO - 2015-11-19 18:12:28,548 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3195.8881439149627;3300.966990330096;3330.3172849565835;3333.833308334583;3350.8492117854694;5325.627206095575;5452.127659574468;5457.017736807373;5514.117741161415;5542.362628297747;5472.534834539059;5495.917561236574;5590.161475778625;5593.720313984305;5619.5785316101255;4889.850885042012;4951.455339912607;4962.478939711333;4974.1543937530705;5036.06832735945;5013.222950442669;5169.638125331228;5180;5188.584913206953;5206.557442617363;4899.853004409838;4985.476524964899;5092.668976516515;5099.235114732801;5179.585633149339;4861.440934292566;4980.825671101494;4992.675476094042;4995.100881841267;5011.649184557083;4955.231939049417;4985.95294988053;5034.395872495287;5036.697798132123;5078.4413714491375;5154.252633368178;5240.056789777838;5290.206469029637;5400.621956463049;5411.540019098342;5991.910121348184;6010.8497287567725;6011.278646562397;6014.1580178775;6015.0676645120075;6037.245344331958;6041.6072955258205;6050.54620903434;6058.102027000105;6058.524249031716;5317.096093664087;5436.483534064258;5448.128299472105;5489.643173193809;5652.943470565283;6019.247594050744;6022.789202377896;6030.993293384619;6037.619702437997;6040.214772079602;5859;5861.3552509223955;5861.677607731531;5862.267216597926;5872.207252020922;5651.547876169897;5767.250257466502;5850.8537286567325;5906.438888305604;5954.047352423591;5839.766409343663;5883.294004719461;5896.7936122235515;5901.881962360814;5920.615160014585;5894.646321220741;5897.056470964625;5902.996490596609;5903.852403689856;5907.084401917709;4396.934045989313;4456.3538286948215;4501.6848820582245;4501.842435514741;4545.795439205178;3976.264391087658;3980.522337319482;3986;3986.1005711546495;4020.8793736187963;5549.19536667181;5568.638038527482;5574.832755017356;5586.944130558642;5617.38208797032;5730.598858079894;5813.418658134237;5857.414258574108;5862.94137058624;5872.823815285548;5416.187571864252;5420.105682562333;5516.641418307797;5618.6628802272;5636.0418728815375;5072.974635126875;5132.743362831843;5153.665011774223;5162.767675454614;5200.24596433515;6167.5682702210415;6177.320494745574;6183.907241391383;6192.907106393318;6194.287656919422;5642.971785141048;5716.942365662366;5779.393163717918;5836.387179346108;5957.582969192115;6042.063480160582;6090.573659843769;6100.633961962297;6103.298120716175;6117.694115294128;5766.394528574439;5825.213596164633;5828.795992140254;5831.446012628963;5831.562632802472;5775.711214439345;5895.94104058954;5896.469317761251;5902.5277977762535;5999.550033747573;5833.591648584558;5848.4151584842875;5854.590178687451;5855.3266374367495;5872;5827.59206855516;5845.620034697731;5847.94152058474;5854.151148083589;5859.150423188699;5457.890842183055;5551.056320425618;5555.194496798023;5560.165975103767;5671.716414179192;5813.593048486566;5887.146363777314;5903.291605007426;5948.196993405835;5953.523718102628;5678.68767217807;5728.369879313355;5734.05388110957;5736.368999409978;5792 18:12:28 INFO - 2015-11-19 18:12:28,549 DEBUG : BROWSER_OUTPUT: |1;ext.html;565.8726786473042;605.2041565341578;612.3050337866522;613.4999975020359;621.9657918814469;28712.56931146032;29833.850830745843;29835;29846.40307193855;29919.55120673189;31577.842110789414;39640.60359396405;40088;40187;40313.39529907054;8676.566171691422;8810;8811.471311721318;8816.691415800447;8822.294216462667;7764.495307805003;7962.721304754335;8604.440711353773;8725;8735.257503112243;10498.737531561696;10614.416207108607;10626.893731062668;10634.521446534924;10750.301230419998;10104.69685909424;10276.74308142295;10328.535215915303;10328.58685652573;10351.741206469898;7666;7918.4457088003865;10165.440900750456;10396.48017599117;10686.51910664022;38479.61520384816;38905.41641875374;38938.415923760884;38993.41509877354;39111.41332880009;3287.6054873415105;3299.224682199681;3318.303156337172;3407.863685452579;3467.7225821934185;29855.701442985726;29913.401731965456;29955.25111872199;30053.248668783235;30967.22581935447;3946.3685810270217;3966.5240171179644;3986.222686576119;3989.900252493682;4146.709730318879;273539;275204;275327;275356;276390;55841.1623825643;57170;58051.709741451865;58459.415405846245;58467.415325846196;63353.36646633567;64162;64199.679001604694;64456;64523;14242.501512447221;14378.640533986525;14396.712065758626;14402.639934001525;14415.207163606103;11500.769984600262;11507.712307192387;11539.942300288612;11573.305601663928;11624.302541847515;19334.419967401;19816.20735170577;19840.50398740014;19890.60218795616;19923.10346034432;7631.236876312324;7822.726204582812;7950.562719050507;7955.443118981616;7965.721199757981;963.9662611808693;968.5835090910836;978.7797745507204;1043.1915265669015;1080.9676758695427;28342;28512.42975140527;28534.28664283368;28675.28311792222;28950.565741513896;1036.896310368957;1040.5161599856103;1043.8486419469286;1079.5735684404774;1156.8611766588062;13219.471221151238;13380.130291531019;13511.662208444672;13544.796828047587;13585.184888906697;285709;288774;289921;290167;290262;50153;50387.496125038284;50434.74782626063;50461.747691261306;50496.747516262185;1366.924819134957;1372.4235820955223;1378.1730961423066;1378.8345398552037;1392.735380277744;24953.376165596004;26109.347266318495;26146.084887029625;26571.601425979014;26598;42801;43182.352264715424;43414.34878476762;43563;43628.34557481704;292849;296387;296822;296857;297672;29745.405091898472;30110.69889301079;30288.394232115676;30375.848120759256;30397.048383709975;38639.22721545609;39247.2150556993;39716.602833971294;39759.204815902944;40058.79970600245;34811.65188348084;36093;36380.81809590935;36408.63591364052;37335.43996840104;36255.45616815697;36348.27303453969;36392.636073638925;36688.449673255454;36895.262094758495;34954.12614684653;36005.27989440249;36189.63810361863;36199.63800361963;36224.27551448903;29981.400371992873;32744.18139546435;33286;33286.833565832014;33393.66606333906;24558.280920335405;25096.37259068465;25181.544854315238;25316.367090822878;25352.239432817045 18:12:28 INFO - 2015-11-19 18:12:28,549 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.6737767565002;354.31793796940883;354.6453546453548;354.6790154909806;356.54006331831937;14219.786703199461;14391;16418.507444776646;16850.915745421273;17675.116244187804;15113.622159446018;16457.588560285967;16474.588135296624;16510.752338714898;17391.652166956654;5324.334458192726;5458;5459.781608735646;5463.2078348639625;5465.043617366965;3996.100877302613;4104.610062044101;5396.541293990015;5449.01917654822;5762.56780741444;5855.707214639272;5887.35239123696;5899.970500147493;5902.380250073745;5913.970430147843;5724.255846739918;5840.3575606683235;5884.823455296348;5885.323187833411;5896.351401345849;5086.084504789136;5090.643654944155;5096.210087436453;5109.795608175668;5111.182210846247;19972;20257.189712411488;20354.28759993408;21246.600543913053;21251.574968500543;2184.421128400975;2233.1179184222306;2288.279192054514;2394.389430695179;2660.813743037988;12752.2986235757;13127.934360328232;13132.343382830915;13149.53976610814;13177.472901083946;1818.1454716283326;1837.6784062789093;1843.1337271482382;1856.3966710819038;1865.2072869030608;57165;59409.405905941254;59983.40016599822;60129.6993515034;60258;9213.631454741735;9217.44695318283;9221.585028673726;9237.12247336502;9276;11866.525338986516;11902;11916.404179791149;11938.044956403466;11943.343116128697;7359.448041396917;7379.704811807467;7449.5902725350625;7493.063367079115;7543.886841697379;7427.962860185665;7441.776746697607;7459;7475.215102414277;7517.736879209201;5649.435056494318;5669.886602268014;5680.943190568124;5700;5725.227094342211;1576.6350474288568;1613.3062783003422;1623.9106849123411;1643;1647.5469245957458;904.1771987491351;958.9041095890494;964.6912987843823;997.5162046407487;1020.3673722292078;16136.273867675984;16616.25226864794;16799.6640067198;17244.396446124327;17260.309587616353;875.4484674654926;907.0611916666219;981.9410835349902;983.5328219095873;990.5047476261869;8983.955080224558;9193.908060919306;9360.95319523398;9363.485008324471;9849.162821160282;391778;395829;397481;397542;514786;73185.6340718293;75627.24372756202;76111.23888761041;77760.22239777642;78051.60974195093;1146.845175901276;1148.6037317125579;1179.8584169899666;1197.3354788092518;1216.6410908781932;15028.17345046033;15049.54851354461;15054.247287635793;15279.923600381928;15543.300551474984;32843.671563284064;32853.57915943843;32897.83551082229;33209.33581328408;33314;43665;44053;45576;46579.53420465752;47265.291020635406;8671.176238257356;8710.782230444289;8773.868391973998;8815.162559556831;8909.688160914337;10378.844317335095;10435.791284174122;10514.211434142622;10534.157267418741;14482;13823.308834558433;13965;14017.789733153806;14224.573262802132;14361.85105191603;13722.862771372158;13895.58313250604;13897.791533126809;14216.502422415166;14378.640533986734;10675.733106672395;13471.326433678081;13666.86333136656;13923.443062277396;14420.85579144195;8622.741317760478;8798.296136309207;8936.955315223382;8983.955080224558;8993.190612844875;9245.491497967676;9352.438853668802;13396.732065358834;13891.583252502442;13901 18:12:28 INFO - 2015-11-19 18:12:28,552 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1332.873377029182;1492.4179569967714;1551.7749926260697;1662.6425318556508;1771.5039788859117;6897.310268973107;7519.360854327382;7677.270659287373;7698.6150692465435;7703.576303303316;7583.924160758391;7676.347510461617;7677.846443071149;7681.193474685161;7711.961440192791;1982.33591746765;2019.7273368095266;2021.6967454881813;2273.4771002669436;2293.529826385587;2053.856230063896;2280.703508543887;2330.3009097270838;2330.8951097200584;2330.9417264568438;2263.818894488437;2290.038183962731;2290.0839664134314;2316.339843144704;2317.316391664463;2009.8794072355706;2047.9078441470022;2253.188852013282;2277.4420267034598;2279.726432828055;2051.507638166829;2053.4455696961736;2055.3731112010832;2255.650374192003;2299.8850057497225;7727.536347819148;7849.332806711436;7880.408969327266;7884.881726774103;7892.644830982619;4737.218358970766;4842.225243960949;4842.927356089662;4844.394450693663;4846.7576621169155;3239.724623407013;3278.2951665392056;3287.2439338951935;3291;3311.4701647736247;1032.4012072997643;1043.5512729526301;1060.777236780277;1982.7224188613607;2011.7183594296664;10840.891591084068;10946.671599852018;10969.670909872637;10970.616028438966;10981.890181098166;4241.215375155606;4310.4611923509565;4359.433273674465;4376.759278239664;4393.758343291086;9004.41471304363;9017.413868098552;9028.909710902939;9031.412958157698;9033.232175265044;4831.130396528659;4832.516748325139;4868.634852386085;4871.707697538159;4874.780634871439;4415.050764085737;4480.462344518679;4482.394876691605;4487.5288094749585;4487.730736155841;3503.667151620592;3521.700655444316;3572.28554289138;3588.102974256436;3613.9277214455565;1089.6349722842779;1096.4791723931069;1106.5241945963153;1107.7507560798756;1115.4757264085868;987.8024395121005;1002.4937406609761;1002.8646132772128;1071.769569542552;1222.5904322052213;7359.264073592598;7442.218567050381;7455.627218639046;7465.178830328659;7465.776026719207;486.5013361304691;487.1863987141482;497.4354108087347;498.61606562946326;499.2112462309542;5513.8345849624575;5582.358028826656;5605.383407825136;5647.717614119278;5653.265075540236;9181.495017773954;9275.953620231856;9362.812743745088;9407.29445291606;9407.764805879771;9182.95408522953;9288.90711092894;9309.581068851918;9665.081817227352;9690.612375505041;7434.702611895572;7444.441666875006;7456.3662088721985;7539.208383119803;7547.547147171077;7213.062301900719;7218.927810722035;7254.854902901807;7373.668184931798;7449.81375465596;8299.751007469786;8424.915750842658;8485.57572121379;8501.277391421798;8553.486790792573;8533.530655813742;8805.075467075865;8808.91191088081;8853.778655533662;8894.955525222333;6674.933250667431;6737.191537015589;6747.359000894907;6750.594964302158;6759.797206083826;7217.458690598121;7246.456515761444;7268.491205615767;7281.745138920112;7398.186199517941;7118.8932166018585;7216.386607138242;7225.6387180641805;7322.524035937647;7328.303811137934;6806.944923536859;7016.298370162943;7040;7092.282918369875;7109.928900710926;7033.894491582528;7067.681954312171;7068;7077.186123595647;7077.964610176916;6348.206474190726;6459.580127291711;6466.4503517201565;6478.384553467413;6483.675816209076;6530.542861999615;6548.443382312556;6558.344165583403;6560.409563139149;6561.40947314744 18:12:28 INFO - 2015-11-19 18:12:28,553 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.53840354302207;332.6174898866303;337.45501015859395;339.75198105383055;347.4302144483048;5966.79116230932;6066.332703402622;6080.361562035989;6086.573939824214;6130.6015109017935;5897.262842144732;6015.037593984964;6025.698715064251;6027.578069535134;6029.819105426834;4640.234361330385;4640.767961601923;4646.697964632288;4647.976760116195;4647.976760116195;4426.86719398417;4511.233090374644;4521.615662668677;4624.052069325797;4653.650976176783;4570.314452832068;4589.265717485203;4597.4483062032605;4623.260278355464;4626.676132670715;4553.931691024637;4573.542645735433;4574.565416285448;4580.610648094916;4597.747123908183;4007.198560287925;4013.6989725770686;4027.335489644205;4049.088954985134;4064.126212864219;5559.049301749863;5631.267935168443;5663.8584035399035;5665.093585026417;5666.320041594994;5385.946140538623;5387.24578559002;5392.40683524812;5393.2449457076045;5393.4876186762585;6020.608660437058;6277.2153480814895;6280.623162610258;6293.244810622755;6353.428191462791;4351.912961740747;4369.300911854088;4494.955050449486;4502.459704835441;4510.977445112753;6618.371254730793;6619.040239165294;6636.502262330345;6643.169603799525;6659.500537459709;4588.059447813191;4588.6099681526775;4594.333821595917;4594.816207351735;4597.448306203277;4357.520672725997;4471.955280447154;4494.10117976406;4650.697704649255;4651.418572678415;5264.263003179558;5269.578433725293;5273.551748101378;5275.261463395128;5281.260623512711;6442.967785161044;6458.903116453257;6472.35276472349;6477.902831457532;6480.449161821204;1573.842615738417;1598.3606557377143;1600.191903088956;1600.463844612068;1600.6318546734317;1053.2995557954027;1058.1270451877233;1059.2955684469896;1066.802641511323;1086.6631344283298;6262.624242545462;6270.2789179244055;6274.215723034621;6274.717637706314;6279.623222606659;6635.10426092481;6649.335066493409;6655.667216639149;6667;6668.966655166693;5998.3701711320555;6173.351798061229;6174.845628859314;6179.3202747697715;6183.505319574423;3591.1560783215923;3618.6743193112748;3626.5829429615405;3629.455581662719;3631.4371272452813;6890.069840571458;6904.689288982008;6907.792766217021;6911.101556797584;6915.550489218184;6619.834504137339;6794.8301292467095;6795.762148324785;6798.76204332846;6800.319968003259;6891.586504809828;6892.310768923067;6892.345227203407;6893.4140598048725;6900.447964162855;6423.100765892872;6570.77002304917;6596.70314835824;6636.170478690164;6641.468682505485;6631.801045968628;6651.900221496779;6659.4006539411685;6664.7000884959325;6671.5997040177745;6914.654267286716;6938.27148149437;6953.68708408133;6957.095577574883;6957.686904089227;4355.978220108879;4500;4504.256797628485;4586.128635559233;4587.243104887656;6654;6656.667166641745;6657.201135863727;6659.234188068241;6659.267480577036;6480.708368123352;6483.994980777987;6484.578502397329;6486.513511486563;6489.7404103835315;6323.747050117944;6429.357064293533;6433.485321174388;6502.284748677547;6510.251321098134;6313.936860631335;6313.936860631335;6317.778877739441;6325.96837015812;6337;6522.836929076811;6537.967310163419;6540.37866402691;6545.509086818603;6546.607203567801;6218.81343559694;6357.396047375492;6359.936400636119;6362.713677884599;6368.834596237301 18:12:28 INFO - 2015-11-19 18:12:28,554 DEBUG : BROWSER_OUTPUT: |5;yui.html;762.3558093411066;778.3306356533382;796.1998191817224;798.5208874675192;799.4843326054698;11222.775544489105;11423.600173993902;11452;11504.367259800707;11561.884381156207;12163.695907602292;12201.572944946929;12231.449584768685;12231.571894983677;12239.143259971806;676.1142902797327;680.0886811672358;686.3273991488344;792.065362871811;810.266708628692;816.9387295952797;827.2596026556229;828.2297463359074;828.3704384667666;828.5774255129897;856.9957150214241;869.1916517638593;869.4913475616772;869.9521526316082;870.0472982084639;693.6150436507736;710.7796583059217;842.9409941304111;865.6364326982651;867.3104881619128;635.5963962883555;636.462189449914;636.9745210191587;638.0652344315554;639.028676411856;12279.877201227962;12454.315012674298;12462.563810266687;12464;12467.189632673848;12007.879921200763;12051.337176455292;12353.567625133077;12489.18820276679;13162.61792511782;9689.563969621313;9873;10013.89986100137;10131.848022279672;10132.94933525335;3451.2924850405607;3522.4716292556063;3533.628968958248;3571.964280357215;3650.470681751131;44721.32918006233;44928.77535612334;45153.096938061055;45299.547004529864;45414.54585454169;9709.36889102206;9719.85420218683;9744.074312940402;9786.657466988763;9824.312298139062;19634.50913727168;19651.31220407279;19790.901045494968;19800;19809.603807923762;6772.356626120511;6808.319168083152;6895.172579290417;6895.586264824126;7024.086868707035;4076.5515793262716;4152.647025002909;4164.5210800757695;4173.457450531411;4220.683448741295;3095.4737694591972;3102.286474110967;3113.315070684446;3115.3613509230554;3119.5320701894443;548.8682716148096;560.1905246918164;563.155267099351;570.5749216833485;577.6822747488949;639.1403562208822;661.1999480628493;681.1825809029185;681.8295426143465;685.1914740606034;8081.6363263653275;8245.175482451827;8332.583370831435;8336;8497.610513739472;552.6628756458557;650.0768908150437;668.6656671664168;671.2984930747381;675.6790524500921;3869.28418242626;3963.980180099081;3984.6812255019527;4053.1931836279687;4221.345691417835;53925.460745392826;54932.72533637306;55258.447415526134;56038;56638.71680641653;49821.25268120909;49904.50095499071;50353.49646503561;50434;50691;44459.55540444619;44555.77722111368;44651.55348446474;44813.103737925056;45450.54549454463;7943.642536086006;7945.960270198843;8088.63601137962;8159.061707903667;8269.751907442786;33820.492692610125;34131;34237.486437703956;34709.826450867586;35127.64872351244;41917.161656767305;42892.571074288855;43269.567304327815;43826.342604860314;44190.33714494221;10868.402237876993;11099.667009989713;11161.49773260189;11211.943940280573;11476.823535862555;11574.537018519164;11665.35840528745;11862.881371186522;12530.874691252971;12706.936465317614;10842.24104312722;11125.388103654377;11403.372814495282;11532.884671153517;11666.76666466683;10758.677239682822;10950.780984380428;11213.775724485628;11282.774344513227;11586.76826463483;10746.408947507962;10878.45607719595;10972.286801357886;11206;11339;9545.281849267198;9829.4102353859;9843.94593841439;9944.751381215527;10053.145482634058;8860.512671803113;9125.680601178927;9150.58822353009;9207.447553146832;9840.133809143304 18:12:28 INFO - 2015-11-19 18:12:28,554 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:12:28 INFO - 2015-11-19 18:12:28,554 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:12:28 INFO - 2015-11-19 18:12:28,554 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,881 18:12:28 INFO - 2015-11-19 18:12:28,554 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:12:28 INFO - 2015-11-19 18:12:28,555 DEBUG : BROWSER_OUTPUT: __startTimestamp1447985548541__endTimestamp 18:12:28 INFO - 2015-11-19 18:12:28,555 DEBUG : BROWSER_OUTPUT: 18:12:28 INFO - 2015-11-19 18:12:28,555 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:12:28 INFO - 2015-11-19 18:12:28,555 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:12:28 INFO - 2015-11-19 18:12:28,555 DEBUG : BROWSER_OUTPUT: 18:12:28 INFO - 2015-11-19 18:12:28,555 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5485.18 Median:5678.69 stddev:621.61 (10.9%) stddev-sans-first:597.01 18:12:28 INFO - 2015-11-19 18:12:28,555 DEBUG : BROWSER_OUTPUT: Values: 3195.9 3301.0 3330.3 3333.8 3350.8 5325.6 5452.1 5457.0 5514.1 5542.4 5472.5 5495.9 5590.2 5593.7 5619.6 4889.9 4951.5 4962.5 4974.2 5036.1 5013.2 5169.6 5180.0 5188.6 5206.6 4899.9 4985.5 5092.7 5099.2 5179.6 4861.4 4980.8 4992.7 4995.1 5011.6 4955.2 4986.0 5034.4 5036.7 5078.4 5154.3 5240.1 5290.2 5400.6 5411.5 5991.9 6010.8 6011.3 6014.2 6015.1 6037.2 6041.6 6050.5 6058.1 6058.5 5317.1 5436.5 5448.1 5489.6 5652.9 6019.2 6022.8 6031.0 6037.6 6040.2 5859.0 5861.4 5861.7 5862.3 5872.2 5651.5 5767.3 5850.9 5906.4 5954.0 5839.8 5883.3 5896.8 5901.9 5920.6 5894.6 5897.1 5903.0 5903.9 5907.1 4396.9 4456.4 4501.7 4501.8 4545.8 3976.3 3980.5 3986.0 3986.1 4020.9 5549.2 5568.6 5574.8 5586.9 5617.4 5730.6 5813.4 5857.4 5862.9 5872.8 5416.2 5420.1 5516.6 5618.7 5636.0 5073.0 5132.7 5153.7 5162.8 5200.2 6167.6 6177.3 6183.9 6192.9 6194.3 5643.0 5716.9 5779.4 5836.4 5957.6 6042.1 6090.6 6100.6 6103.3 6117.7 5766.4 5825.2 5828.8 5831.4 5831.6 5775.7 5895.9 5896.5 5902.5 5999.6 5833.6 5848.4 5854.6 5855.3 5872.0 5827.6 5845.6 5847.9 5854.2 5859.2 5457.9 5551.1 5555.2 5560.2 5671.7 5813.6 5887.1 5903.3 5948.2 5953.5 5678.7 5728.4 5734.1 5736.4 5792.0 18:12:28 INFO - 2015-11-19 18:12:28,555 DEBUG : BROWSER_OUTPUT: 18:12:28 INFO - 2015-11-19 18:12:28,556 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45254.60 Median:31272.53 stddev:74905.21 (239.5%) stddev-sans-first:75040.19 18:12:28 INFO - 2015-11-19 18:12:28,557 DEBUG : BROWSER_OUTPUT: Values: 565.9 605.2 612.3 613.5 622.0 28712.6 29833.9 29835.0 29846.4 29919.6 31577.8 39640.6 40088.0 40187.0 40313.4 8676.6 8810.0 8811.5 8816.7 8822.3 7764.5 7962.7 8604.4 8725.0 8735.3 10498.7 10614.4 10626.9 10634.5 10750.3 10104.7 10276.7 10328.5 10328.6 10351.7 7666.0 7918.4 10165.4 10396.5 10686.5 38479.6 38905.4 38938.4 38993.4 39111.4 3287.6 3299.2 3318.3 3407.9 3467.7 29855.7 29913.4 29955.3 30053.2 30967.2 3946.4 3966.5 3986.2 3989.9 4146.7 273539.0 275204.0 275327.0 275356.0 276390.0 55841.2 57170.0 58051.7 58459.4 58467.4 63353.4 64162.0 64199.7 64456.0 64523.0 14242.5 14378.6 14396.7 14402.6 14415.2 11500.8 11507.7 11539.9 11573.3 11624.3 19334.4 19816.2 19840.5 19890.6 19923.1 7631.2 7822.7 7950.6 7955.4 7965.7 964.0 968.6 978.8 1043.2 1081.0 28342.0 28512.4 28534.3 28675.3 28950.6 1036.9 1040.5 1043.8 1079.6 1156.9 13219.5 13380.1 13511.7 13544.8 13585.2 285709.0 288774.0 289921.0 290167.0 290262.0 50153.0 50387.5 50434.7 50461.7 50496.7 1366.9 1372.4 1378.2 1378.8 1392.7 24953.4 26109.3 26146.1 26571.6 26598.0 42801.0 43182.4 43414.3 43563.0 43628.3 292849.0 296387.0 296822.0 296857.0 297672.0 29745.4 30110.7 30288.4 30375.8 30397.0 38639.2 39247.2 39716.6 39759.2 40058.8 34811.7 36093.0 36380.8 36408.6 37335.4 36255.5 36348.3 36392.6 36688.4 36895.3 34954.1 36005.3 36189.6 36199.6 36224.3 29981.4 32744.2 33286.0 33286.8 33393.7 24558.3 25096.4 25181.5 25316.4 25352.2 18:12:28 INFO - 2015-11-19 18:12:28,557 DEBUG : BROWSER_OUTPUT: 18:12:28 INFO - 2015-11-19 18:12:28,557 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25034.19 Median:396655.00 stddev:69198.69 (17.4%) stddev-sans-first:69367.99 18:12:28 INFO - 2015-11-19 18:12:28,558 DEBUG : BROWSER_OUTPUT: Values: 352.7 354.3 354.6 354.7 356.5 14219.8 14391.0 16418.5 16850.9 17675.1 15113.6 16457.6 16474.6 16510.8 17391.7 5324.3 5458.0 5459.8 5463.2 5465.0 3996.1 4104.6 5396.5 5449.0 5762.6 5855.7 5887.4 5900.0 5902.4 5914.0 5724.3 5840.4 5884.8 5885.3 5896.4 5086.1 5090.6 5096.2 5109.8 5111.2 19972.0 20257.2 20354.3 21246.6 21251.6 2184.4 2233.1 2288.3 2394.4 2660.8 12752.3 13127.9 13132.3 13149.5 13177.5 1818.1 1837.7 1843.1 1856.4 1865.2 57165.0 59409.4 59983.4 60129.7 60258.0 9213.6 9217.4 9221.6 9237.1 9276.0 11866.5 11902.0 11916.4 11938.0 11943.3 7359.4 7379.7 7449.6 7493.1 7543.9 7428.0 7441.8 7459.0 7475.2 7517.7 5649.4 5669.9 5680.9 5700.0 5725.2 1576.6 1613.3 1623.9 1643.0 1647.5 904.2 958.9 964.7 997.5 1020.4 16136.3 16616.3 16799.7 17244.4 17260.3 875.4 907.1 981.9 983.5 990.5 8984.0 9193.9 9361.0 9363.5 9849.2 391778.0 395829.0 397481.0 397542.0 514786.0 73185.6 75627.2 76111.2 77760.2 78051.6 1146.8 1148.6 1179.9 1197.3 1216.6 15028.2 15049.5 15054.2 15279.9 15543.3 32843.7 32853.6 32897.8 33209.3 33314.0 43665.0 44053.0 45576.0 46579.5 47265.3 8671.2 8710.8 8773.9 8815.2 8909.7 10378.8 10435.8 10514.2 10534.2 14482.0 13823.3 13965.0 14017.8 14224.6 14361.9 13722.9 13895.6 13897.8 14216.5 14378.6 10675.7 13471.3 13666.9 13923.4 14420.9 8622.7 8798.3 8937.0 8984.0 8993.2 9245.5 9352.4 13396.7 13891.6 13901.0 18:12:28 INFO - 2015-11-19 18:12:28,558 DEBUG : BROWSER_OUTPUT: 18:12:28 INFO - 2015-11-19 18:12:28,559 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5474.73 Median:6463.02 stddev:2867.72 (44.4%) stddev-sans-first:2858.86 18:12:28 INFO - 2015-11-19 18:12:28,559 DEBUG : BROWSER_OUTPUT: Values: 1332.9 1492.4 1551.8 1662.6 1771.5 6897.3 7519.4 7677.3 7698.6 7703.6 7583.9 7676.3 7677.8 7681.2 7712.0 1982.3 2019.7 2021.7 2273.5 2293.5 2053.9 2280.7 2330.3 2330.9 2330.9 2263.8 2290.0 2290.1 2316.3 2317.3 2009.9 2047.9 2253.2 2277.4 2279.7 2051.5 2053.4 2055.4 2255.7 2299.9 7727.5 7849.3 7880.4 7884.9 7892.6 4737.2 4842.2 4842.9 4844.4 4846.8 3239.7 3278.3 3287.2 3291.0 3311.5 1032.4 1043.6 1060.8 1982.7 2011.7 10840.9 10946.7 10969.7 10970.6 10981.9 4241.2 4310.5 4359.4 4376.8 4393.8 9004.4 9017.4 9028.9 9031.4 9033.2 4831.1 4832.5 4868.6 4871.7 4874.8 4415.1 4480.5 4482.4 4487.5 4487.7 3503.7 3521.7 3572.3 3588.1 3613.9 1089.6 1096.5 1106.5 1107.8 1115.5 987.8 1002.5 1002.9 1071.8 1222.6 7359.3 7442.2 7455.6 7465.2 7465.8 486.5 487.2 497.4 498.6 499.2 5513.8 5582.4 5605.4 5647.7 5653.3 9181.5 9276.0 9362.8 9407.3 9407.8 9183.0 9288.9 9309.6 9665.1 9690.6 7434.7 7444.4 7456.4 7539.2 7547.5 7213.1 7218.9 7254.9 7373.7 7449.8 8299.8 8424.9 8485.6 8501.3 8553.5 8533.5 8805.1 8808.9 8853.8 8895.0 6674.9 6737.2 6747.4 6750.6 6759.8 7217.5 7246.5 7268.5 7281.7 7398.2 7118.9 7216.4 7225.6 7322.5 7328.3 6806.9 7016.3 7040.0 7092.3 7109.9 7033.9 7067.7 7068.0 7077.2 7078.0 6348.2 6459.6 6466.5 6478.4 6483.7 6530.5 6548.4 6558.3 6560.4 6561.4 18:12:28 INFO - 2015-11-19 18:12:28,559 DEBUG : BROWSER_OUTPUT: 18:12:28 INFO - 2015-11-19 18:12:28,559 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5371.72 Median:6108.59 stddev:1632.66 (26.7%) stddev-sans-first:1592.75 18:12:28 INFO - 2015-11-19 18:12:28,559 DEBUG : BROWSER_OUTPUT: Values: 328.5 332.6 337.5 339.8 347.4 5966.8 6066.3 6080.4 6086.6 6130.6 5897.3 6015.0 6025.7 6027.6 6029.8 4640.2 4640.8 4646.7 4648.0 4648.0 4426.9 4511.2 4521.6 4624.1 4653.7 4570.3 4589.3 4597.4 4623.3 4626.7 4553.9 4573.5 4574.6 4580.6 4597.7 4007.2 4013.7 4027.3 4049.1 4064.1 5559.0 5631.3 5663.9 5665.1 5666.3 5385.9 5387.2 5392.4 5393.2 5393.5 6020.6 6277.2 6280.6 6293.2 6353.4 4351.9 4369.3 4495.0 4502.5 4511.0 6618.4 6619.0 6636.5 6643.2 6659.5 4588.1 4588.6 4594.3 4594.8 4597.4 4357.5 4472.0 4494.1 4650.7 4651.4 5264.3 5269.6 5273.6 5275.3 5281.3 6443.0 6458.9 6472.4 6477.9 6480.4 1573.8 1598.4 1600.2 1600.5 1600.6 1053.3 1058.1 1059.3 1066.8 1086.7 6262.6 6270.3 6274.2 6274.7 6279.6 6635.1 6649.3 6655.7 6667.0 6669.0 5998.4 6173.4 6174.8 6179.3 6183.5 3591.2 3618.7 3626.6 3629.5 3631.4 6890.1 6904.7 6907.8 6911.1 6915.6 6619.8 6794.8 6795.8 6798.8 6800.3 6891.6 6892.3 6892.3 6893.4 6900.4 6423.1 6570.8 6596.7 6636.2 6641.5 6631.8 6651.9 6659.4 6664.7 6671.6 6914.7 6938.3 6953.7 6957.1 6957.7 4356.0 4500.0 4504.3 4586.1 4587.2 6654.0 6656.7 6657.2 6659.2 6659.3 6480.7 6484.0 6484.6 6486.5 6489.7 6323.7 6429.4 6433.5 6502.3 6510.3 6313.9 6313.9 6317.8 6326.0 6337.0 6522.8 6538.0 6540.4 6545.5 6546.6 6218.8 6357.4 6359.9 6362.7 6368.8 18:12:28 INFO - 2015-11-19 18:12:28,559 DEBUG : BROWSER_OUTPUT: 18:12:28 INFO - 2015-11-19 18:12:28,560 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13374.56 Median:45226.32 stddev:15395.00 (34.0%) stddev-sans-first:15409.06 18:12:28 INFO - 2015-11-19 18:12:28,560 DEBUG : BROWSER_OUTPUT: Values: 762.4 778.3 796.2 798.5 799.5 11222.8 11423.6 11452.0 11504.4 11561.9 12163.7 12201.6 12231.4 12231.6 12239.1 676.1 680.1 686.3 792.1 810.3 816.9 827.3 828.2 828.4 828.6 857.0 869.2 869.5 870.0 870.0 693.6 710.8 842.9 865.6 867.3 635.6 636.5 637.0 638.1 639.0 12279.9 12454.3 12462.6 12464.0 12467.2 12007.9 12051.3 12353.6 12489.2 13162.6 9689.6 9873.0 10013.9 10131.8 10132.9 3451.3 3522.5 3533.6 3572.0 3650.5 44721.3 44928.8 45153.1 45299.5 45414.5 9709.4 9719.9 9744.1 9786.7 9824.3 19634.5 19651.3 19790.9 19800.0 19809.6 6772.4 6808.3 6895.2 6895.6 7024.1 4076.6 4152.6 4164.5 4173.5 4220.7 3095.5 3102.3 3113.3 3115.4 3119.5 548.9 560.2 563.2 570.6 577.7 639.1 661.2 681.2 681.8 685.2 8081.6 8245.2 8332.6 8336.0 8497.6 552.7 650.1 668.7 671.3 675.7 3869.3 3964.0 3984.7 4053.2 4221.3 53925.5 54932.7 55258.4 56038.0 56638.7 49821.3 49904.5 50353.5 50434.0 50691.0 44459.6 44555.8 44651.6 44813.1 45450.5 7943.6 7946.0 8088.6 8159.1 8269.8 33820.5 34131.0 34237.5 34709.8 35127.6 41917.2 42892.6 43269.6 43826.3 44190.3 10868.4 11099.7 11161.5 11211.9 11476.8 11574.5 11665.4 11862.9 12530.9 12706.9 10842.2 11125.4 11403.4 11532.9 11666.8 10758.7 10950.8 11213.8 11282.8 11586.8 10746.4 10878.5 10972.3 11206.0 11339.0 9545.3 9829.4 9843.9 9944.8 10053.1 8860.5 9125.7 9150.6 9207.4 9840.1 18:12:28 INFO - 2015-11-19 18:12:28,561 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:12:28 INFO - 2015-11-19 18:12:28,561 DEBUG : BROWSER_OUTPUT: 18:12:29 INFO - 2015-11-19 18:12:29,273 INFO : Browser exited with error code: 0 18:12:29 INFO - 2015-11-19 18:12:29,292 INFO : Completed test dromaeo_css (00:18:35) 18:12:29 INFO - 2015-11-19 18:12:29,292 INFO : Starting test kraken 18:12:29 INFO - 2015-11-19 18:12:29,292 DEBUG : operating with platform_type : linux_ 18:12:29 INFO - 2015-11-19 18:12:29,292 INFO : Initialising browser for kraken test... 18:12:29 INFO - 2015-11-19 18:12:29,298 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvUdVCw/profile http://localhost:51937/getInfo.html 18:12:33 INFO - 2015-11-19 18:12:33,403 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:12:33 INFO - 2015-11-19 18:12:33,403 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:12:33 INFO - 2015-11-19 18:12:33,403 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:12:33 INFO - 2015-11-19 18:12:33,403 DEBUG : BROWSER_OUTPUT: __metrics 18:12:33 INFO - 2015-11-19 18:12:33,568 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:12:34 INFO - 2015-11-19 18:12:34,868 INFO : Browser initialized. 18:12:34 INFO - 2015-11-19 18:12:34,869 INFO : Running cycle 1/1 for kraken test... 18:12:34 INFO - 2015-11-19 18:12:34,869 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvUdVCw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:12:46 INFO - 2015-11-19 18:12:46,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 142069760 18:12:46 INFO - 2015-11-19 18:12:46,695 DEBUG : BROWSER_OUTPUT: 18:12:49 INFO - 2015-11-19 18:12:49,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51937/tests/kraken/driver.html?testName=audio-beat-detection) 18:12:49 INFO - 2015-11-19 18:12:49,751 DEBUG : BROWSER_OUTPUT: RSS: Main: 176812032 18:12:49 INFO - 2015-11-19 18:12:49,752 DEBUG : BROWSER_OUTPUT: 18:12:52 INFO - 2015-11-19 18:12:52,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51937/tests/kraken/driver.html?testName=audio-dft) 18:12:52 INFO - 2015-11-19 18:12:52,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 165212160 18:12:52 INFO - 2015-11-19 18:12:52,922 DEBUG : BROWSER_OUTPUT: 18:12:55 INFO - 2015-11-19 18:12:55,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51937/tests/kraken/driver.html?testName=audio-fft) 18:12:56 INFO - 2015-11-19 18:12:56,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 151949312 18:12:56 INFO - 2015-11-19 18:12:56,332 DEBUG : BROWSER_OUTPUT: 18:12:58 INFO - 2015-11-19 18:12:58,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51937/tests/kraken/driver.html?testName=audio-oscillator) 18:12:58 INFO - 2015-11-19 18:12:58,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 154255360 18:12:58 INFO - 2015-11-19 18:12:58,886 DEBUG : BROWSER_OUTPUT: 18:13:01 INFO - 2015-11-19 18:13:01,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51937/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:13:01 INFO - 2015-11-19 18:13:01,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 155574272 18:13:01 INFO - 2015-11-19 18:13:01,611 DEBUG : BROWSER_OUTPUT: 18:13:04 INFO - 2015-11-19 18:13:04,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51937/tests/kraken/driver.html?testName=imaging-darkroom) 18:13:05 INFO - 2015-11-19 18:13:05,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 155774976 18:13:05 INFO - 2015-11-19 18:13:05,067 DEBUG : BROWSER_OUTPUT: 18:13:08 INFO - 2015-11-19 18:13:08,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51937/tests/kraken/driver.html?testName=imaging-desaturate) 18:13:09 INFO - 2015-11-19 18:13:09,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 157757440 18:13:09 INFO - 2015-11-19 18:13:09,040 DEBUG : BROWSER_OUTPUT: 18:13:11 INFO - 2015-11-19 18:13:11,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51937/tests/kraken/driver.html?testName=json-parse-financial) 18:13:12 INFO - 2015-11-19 18:13:12,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 158339072 18:13:12 INFO - 2015-11-19 18:13:12,357 DEBUG : BROWSER_OUTPUT: 18:13:13 INFO - 2015-11-19 18:13:13,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51937/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:13:14 INFO - 2015-11-19 18:13:14,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 168443904 18:13:14 INFO - 2015-11-19 18:13:14,506 DEBUG : BROWSER_OUTPUT: 18:13:16 INFO - 2015-11-19 18:13:16,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51937/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:13:16 INFO - 2015-11-19 18:13:16,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 165642240 18:13:16 INFO - 2015-11-19 18:13:16,905 DEBUG : BROWSER_OUTPUT: 18:13:18 INFO - 2015-11-19 18:13:18,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51937/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:13:19 INFO - 2015-11-19 18:13:19,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 172638208 18:13:19 INFO - 2015-11-19 18:13:19,538 DEBUG : BROWSER_OUTPUT: 18:13:22 INFO - 2015-11-19 18:13:22,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:13:22 INFO - 2015-11-19 18:13:22,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 177025024 18:13:22 INFO - 2015-11-19 18:13:22,736 DEBUG : BROWSER_OUTPUT: 18:13:25 INFO - 2015-11-19 18:13:25,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:13:25 INFO - 2015-11-19 18:13:25,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 176107520 18:13:25 INFO - 2015-11-19 18:13:25,864 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51937/tests/kraken/driver.html?testName=ai-astar) 18:13:27 INFO - 2015-11-19 18:13:27,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 235487232 18:13:27 INFO - 2015-11-19 18:13:27,788 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,789 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:13:27 INFO - 2015-11-19 18:13:27,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:13:27 INFO - 2015-11-19 18:13:27,790 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:13:27 INFO - 2015-11-19 18:13:27,790 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:13:27 INFO - 2015-11-19 18:13:27,790 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;105;109;112;111;100;109;102;110 18:13:27 INFO - 2015-11-19 18:13:27,790 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;124;160;161;124;153;145;124;176;125 18:13:27 INFO - 2015-11-19 18:13:27,791 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;159;160;159;159;161;160;165;160;160 18:13:27 INFO - 2015-11-19 18:13:27,792 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;84;92;72;72;71;95;94;71 18:13:27 INFO - 2015-11-19 18:13:27,792 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;131;91;90;91;135;91;91;137 18:13:27 INFO - 2015-11-19 18:13:27,792 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;112;109;109;117;110;110;110;109;109;109 18:13:27 INFO - 2015-11-19 18:13:27,793 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;144;146;146;146;146;146;145 18:13:27 INFO - 2015-11-19 18:13:27,793 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;96;96;95;95;95 18:13:27 INFO - 2015-11-19 18:13:27,793 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;61;62;64;61;62;65;70;61;60 18:13:27 INFO - 2015-11-19 18:13:27,793 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;68;69;69;68;68;68 18:13:27 INFO - 2015-11-19 18:13:27,794 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;86;86;85;92;85;84;85;88;86 18:13:27 INFO - 2015-11-19 18:13:27,794 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;120;132;116;125;120;125;125;117;127 18:13:27 INFO - 2015-11-19 18:13:27,794 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;158;148;150;150;139;149;148;151;145 18:13:27 INFO - 2015-11-19 18:13:27,794 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;67;68;66;66;66;67;82;66 18:13:27 INFO - 2015-11-19 18:13:27,794 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:13:27 INFO - 2015-11-19 18:13:27,795 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:13:27 INFO - 2015-11-19 18:13:27,795 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,918 18:13:27 INFO - 2015-11-19 18:13:27,795 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:13:27 INFO - 2015-11-19 18:13:27,795 DEBUG : BROWSER_OUTPUT: __startTimestamp1447985607788__endTimestamp 18:13:27 INFO - 2015-11-19 18:13:27,796 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,799 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:13:27 INFO - 2015-11-19 18:13:27,799 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:13:27 INFO - 2015-11-19 18:13:27,799 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,799 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.70 Median:109.50 stddev:4.06 (3.7%) stddev-sans-first:4.30 18:13:27 INFO - 2015-11-19 18:13:27,799 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 105.0 109.0 112.0 111.0 100.0 109.0 102.0 110.0 18:13:27 INFO - 2015-11-19 18:13:27,799 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,800 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.40 Median:152.50 stddev:19.07 (12.5%) stddev-sans-first:20.03 18:13:27 INFO - 2015-11-19 18:13:27,800 DEBUG : BROWSER_OUTPUT: Values: 152.0 124.0 160.0 161.0 124.0 153.0 145.0 124.0 176.0 125.0 18:13:27 INFO - 2015-11-19 18:13:27,800 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,800 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:1.78 (1.1%) stddev-sans-first:1.87 18:13:27 INFO - 2015-11-19 18:13:27,800 DEBUG : BROWSER_OUTPUT: Values: 161.0 159.0 160.0 159.0 159.0 161.0 160.0 165.0 160.0 160.0 18:13:27 INFO - 2015-11-19 18:13:27,800 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,800 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.70 Median:79.00 stddev:10.38 (13.1%) stddev-sans-first:10.81 18:13:27 INFO - 2015-11-19 18:13:27,800 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 84.0 92.0 72.0 72.0 71.0 95.0 94.0 71.0 18:13:27 INFO - 2015-11-19 18:13:27,800 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,801 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.80 Median:91.00 stddev:21.12 (23.2%) stddev-sans-first:21.89 18:13:27 INFO - 2015-11-19 18:13:27,801 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 131.0 91.0 90.0 91.0 135.0 91.0 91.0 137.0 18:13:27 INFO - 2015-11-19 18:13:27,801 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,801 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.00 stddev:2.50 (2.3%) stddev-sans-first:2.59 18:13:27 INFO - 2015-11-19 18:13:27,801 DEBUG : BROWSER_OUTPUT: Values: 112.0 109.0 109.0 117.0 110.0 110.0 110.0 109.0 109.0 109.0 18:13:27 INFO - 2015-11-19 18:13:27,801 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,801 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 18:13:27 INFO - 2015-11-19 18:13:27,801 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 144.0 146.0 146.0 146.0 146.0 146.0 145.0 18:13:27 INFO - 2015-11-19 18:13:27,801 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,802 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:13:27 INFO - 2015-11-19 18:13:27,802 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 18:13:27 INFO - 2015-11-19 18:13:27,802 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,802 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.80 Median:62.00 stddev:2.94 (4.7%) stddev-sans-first:3.10 18:13:27 INFO - 2015-11-19 18:13:27,802 DEBUG : BROWSER_OUTPUT: Values: 62.0 61.0 62.0 64.0 61.0 62.0 65.0 70.0 61.0 60.0 18:13:27 INFO - 2015-11-19 18:13:27,802 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,802 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 18:13:27 INFO - 2015-11-19 18:13:27,803 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 68.0 69.0 69.0 68.0 68.0 68.0 18:13:27 INFO - 2015-11-19 18:13:27,803 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,803 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.00 stddev:2.88 (3.4%) stddev-sans-first:2.40 18:13:27 INFO - 2015-11-19 18:13:27,803 DEBUG : BROWSER_OUTPUT: Values: 92.0 86.0 86.0 85.0 92.0 85.0 84.0 85.0 88.0 86.0 18:13:27 INFO - 2015-11-19 18:13:27,803 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,803 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:125.00 stddev:5.33 (4.3%) stddev-sans-first:5.15 18:13:27 INFO - 2015-11-19 18:13:27,803 DEBUG : BROWSER_OUTPUT: Values: 116.0 120.0 132.0 116.0 125.0 120.0 125.0 125.0 117.0 127.0 18:13:27 INFO - 2015-11-19 18:13:27,803 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,803 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:149.50 stddev:5.49 (3.7%) stddev-sans-first:5.05 18:13:27 INFO - 2015-11-19 18:13:27,803 DEBUG : BROWSER_OUTPUT: Values: 140.0 158.0 148.0 150.0 150.0 139.0 149.0 148.0 151.0 145.0 18:13:27 INFO - 2015-11-19 18:13:27,804 DEBUG : BROWSER_OUTPUT: 18:13:27 INFO - 2015-11-19 18:13:27,804 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.00 stddev:4.93 (7.4%) stddev-sans-first:5.21 18:13:27 INFO - 2015-11-19 18:13:27,804 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 67.0 68.0 66.0 66.0 66.0 67.0 82.0 66.0 18:13:27 INFO - 2015-11-19 18:13:27,804 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:13:27 INFO - 2015-11-19 18:13:27,804 DEBUG : BROWSER_OUTPUT: 18:13:28 INFO - 2015-11-19 18:13:28,709 INFO : Browser exited with error code: 0 18:13:28 INFO - 2015-11-19 18:13:28,757 INFO : Completed test kraken (00:00:59) 18:13:28 INFO - 2015-11-19 18:13:28,757 INFO : Starting test v8_7 18:13:28 INFO - 2015-11-19 18:13:28,757 DEBUG : operating with platform_type : linux_ 18:13:28 INFO - 2015-11-19 18:13:28,757 INFO : Initialising browser for v8_7 test... 18:13:28 INFO - 2015-11-19 18:13:28,763 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIAQi_B/profile http://localhost:51937/getInfo.html 18:13:32 INFO - 2015-11-19 18:13:32,667 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:13:32 INFO - 2015-11-19 18:13:32,668 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:13:32 INFO - 2015-11-19 18:13:32,668 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:13:32 INFO - 2015-11-19 18:13:32,668 DEBUG : BROWSER_OUTPUT: __metrics 18:13:32 INFO - 2015-11-19 18:13:32,825 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:13:34 INFO - 2015-11-19 18:13:34,183 INFO : Browser initialized. 18:13:34 INFO - 2015-11-19 18:13:34,183 INFO : Running cycle 1/1 for v8_7 test... 18:13:34 INFO - 2015-11-19 18:13:34,184 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIAQi_B/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:13:45 INFO - 2015-11-19 18:13:45,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 141705216 18:13:45 INFO - 2015-11-19 18:13:45,859 DEBUG : BROWSER_OUTPUT: 18:14:07 INFO - 2015-11-19 18:14:07,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51937/tests/v8_7/run.html (next: http://localhost:51937/tests/v8_7/run.html) 18:14:07 INFO - 2015-11-19 18:14:07,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 578805760 18:14:07 INFO - 2015-11-19 18:14:07,469 DEBUG : BROWSER_OUTPUT: 18:14:07 INFO - 2015-11-19 18:14:07,471 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:14:07 INFO - 2015-11-19 18:14:07,471 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:14:07 INFO - 2015-11-19 18:14:07,471 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:14:07 INFO - 2015-11-19 18:14:07,471 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:14:07 INFO - 2015-11-19 18:14:07,471 DEBUG : BROWSER_OUTPUT: |0;Richards;163.1321370309951 18:14:07 INFO - 2015-11-19 18:14:07,472 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;195.04583577140627 18:14:07 INFO - 2015-11-19 18:14:07,472 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.143997718848 18:14:07 INFO - 2015-11-19 18:14:07,472 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5065.656565656565 18:14:07 INFO - 2015-11-19 18:14:07,472 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1104.9723756906078 18:14:07 INFO - 2015-11-19 18:14:07,472 DEBUG : BROWSER_OUTPUT: |5;Earley;789.4321766561515 18:14:07 INFO - 2015-11-19 18:14:07,473 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 18:14:07 INFO - 2015-11-19 18:14:07,473 DEBUG : BROWSER_OUTPUT: |7;RegExp;27216.216216216217 18:14:07 INFO - 2015-11-19 18:14:07,473 DEBUG : BROWSER_OUTPUT: |8;Splay;653.1678641410842 18:14:07 INFO - 2015-11-19 18:14:07,473 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4873.78640776699 18:14:07 INFO - 2015-11-19 18:14:07,474 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:14:07 INFO - 2015-11-19 18:14:07,474 DEBUG : BROWSER_OUTPUT: __startTimestamp1447985647470__endTimestamp 18:14:07 INFO - 2015-11-19 18:14:07,474 DEBUG : BROWSER_OUTPUT: 18:14:07 INFO - 2015-11-19 18:14:07,474 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:14:07 INFO - 2015-11-19 18:14:07,475 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:14:07 INFO - 2015-11-19 18:14:07,475 DEBUG : BROWSER_OUTPUT: 18:14:07 INFO - 2015-11-19 18:14:07,475 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.13 Median:163.13 stddev:0.00 (0.0%) 18:14:07 INFO - 2015-11-19 18:14:07,475 DEBUG : BROWSER_OUTPUT: Values: 163.1 18:14:07 INFO - 2015-11-19 18:14:07,476 DEBUG : BROWSER_OUTPUT: 18:14:07 INFO - 2015-11-19 18:14:07,476 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:195.05 Median:195.05 stddev:0.00 (0.0%) 18:14:07 INFO - 2015-11-19 18:14:07,476 DEBUG : BROWSER_OUTPUT: Values: 195.0 18:14:07 INFO - 2015-11-19 18:14:07,476 DEBUG : BROWSER_OUTPUT: 18:14:07 INFO - 2015-11-19 18:14:07,476 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.14 Median:285.14 stddev:0.00 (0.0%) 18:14:07 INFO - 2015-11-19 18:14:07,477 DEBUG : BROWSER_OUTPUT: Values: 285.1 18:14:07 INFO - 2015-11-19 18:14:07,477 DEBUG : BROWSER_OUTPUT: 18:14:07 INFO - 2015-11-19 18:14:07,477 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5065.66 Median:5065.66 stddev:0.00 (0.0%) 18:14:07 INFO - 2015-11-19 18:14:07,477 DEBUG : BROWSER_OUTPUT: Values: 5065.7 18:14:07 INFO - 2015-11-19 18:14:07,478 DEBUG : BROWSER_OUTPUT: 18:14:07 INFO - 2015-11-19 18:14:07,478 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1104.97 Median:1104.97 stddev:0.00 (0.0%) 18:14:07 INFO - 2015-11-19 18:14:07,478 DEBUG : BROWSER_OUTPUT: Values: 1105.0 18:14:07 INFO - 2015-11-19 18:14:07,479 DEBUG : BROWSER_OUTPUT: 18:14:07 INFO - 2015-11-19 18:14:07,479 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.43 Median:789.43 stddev:0.00 (0.0%) 18:14:07 INFO - 2015-11-19 18:14:07,479 DEBUG : BROWSER_OUTPUT: Values: 789.4 18:14:07 INFO - 2015-11-19 18:14:07,479 DEBUG : BROWSER_OUTPUT: 18:14:07 INFO - 2015-11-19 18:14:07,480 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 18:14:07 INFO - 2015-11-19 18:14:07,480 DEBUG : BROWSER_OUTPUT: Values: 12231.7 18:14:07 INFO - 2015-11-19 18:14:07,480 DEBUG : BROWSER_OUTPUT: 18:14:07 INFO - 2015-11-19 18:14:07,480 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27216.22 Median:27216.22 stddev:0.00 (0.0%) 18:14:07 INFO - 2015-11-19 18:14:07,481 DEBUG : BROWSER_OUTPUT: Values: 27216.2 18:14:07 INFO - 2015-11-19 18:14:07,481 DEBUG : BROWSER_OUTPUT: 18:14:07 INFO - 2015-11-19 18:14:07,481 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:653.17 Median:653.17 stddev:0.00 (0.0%) 18:14:07 INFO - 2015-11-19 18:14:07,481 DEBUG : BROWSER_OUTPUT: Values: 653.2 18:14:07 INFO - 2015-11-19 18:14:07,481 DEBUG : BROWSER_OUTPUT: 18:14:07 INFO - 2015-11-19 18:14:07,481 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4873.79 Median:4873.79 stddev:0.00 (0.0%) 18:14:07 INFO - 2015-11-19 18:14:07,481 DEBUG : BROWSER_OUTPUT: Values: 4873.8 18:14:07 INFO - 2015-11-19 18:14:07,481 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:14:07 INFO - 2015-11-19 18:14:07,482 DEBUG : BROWSER_OUTPUT: 18:14:08 INFO - 2015-11-19 18:14:08,257 INFO : Browser exited with error code: 0 18:14:08 INFO - 2015-11-19 18:14:08,274 INFO : Completed test v8_7 (00:00:39) 18:14:08 INFO - 2015-11-19 18:14:08,529 INFO : Completed test suite (00:20:14) 18:14:08 INFO - 2015-11-19 18:14:08,530 DEBUG : Working with test: dromaeo_css 18:14:08 INFO - 2015-11-19 18:14:08,530 DEBUG : Generating results file: dromaeo_css 18:14:08 INFO - 2015-11-19 18:14:08,531 DEBUG : Working with test: kraken 18:14:08 INFO - 2015-11-19 18:14:08,531 DEBUG : Generating results file: kraken 18:14:08 INFO - 2015-11-19 18:14:08,531 INFO : javascript benchmark 18:14:08 INFO - 2015-11-19 18:14:08,531 DEBUG : Working with test: v8_7 18:14:08 INFO - 2015-11-19 18:14:08,532 DEBUG : Generating results file: v8_7 18:14:08 INFO - 2015-11-19 18:14:08,532 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:14:08 INFO - 2015-11-19 18:14:08,661 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 18:14:08 INFO - 2015-11-19 18:14:08,661 DEBUG : process_Request line: dromaeo_css 6959.03 graph.html#tests=[[72,63,35]] 18:14:08 INFO - 2015-11-19 18:14:08,661 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:14:08 INFO - 2015-11-19 18:14:08,787 DEBUG : process_Request line: kraken 1504.00 graph.html#tests=[[232,63,35]] 18:14:08 INFO - 2015-11-19 18:14:08,787 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:14:08 INFO - 2015-11-19 18:14:08,826 DEBUG : process_Request line: v8_7 20734.00 graph.html#tests=[[230,63,35]] 18:14:08 INFO - 2015-11-19 18:14:08,827 INFO : javascript benchmark 18:14:08 INFO - 2015-11-19 18:14:08,831 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3195.8881439149627, 3300.966990330096, 3330.3172849565835, 3333.833308334583, 3350.8492117854694, 5325.627206095575, 5452.127659574468, 5457.017736807373, 5514.117741161415, 5542.362628297747, 5472.534834539059, 5495.917561236574, 5590.161475778625, 5593.720313984305, 5619.5785316101255, 4889.850885042012, 4951.455339912607, 4962.478939711333, 4974.1543937530705, 5036.06832735945, 5013.222950442669, 5169.638125331228, 5180.0, 5188.584913206953, 5206.557442617363, 4899.853004409838, 4985.476524964899, 5092.668976516515, 5099.235114732801, 5179.585633149339, 4861.440934292566, 4980.825671101494, 4992.675476094042, 4995.100881841267, 5011.649184557083, 4955.231939049417, 4985.95294988053, 5034.395872495287, 5036.697798132123, 5078.4413714491375, 5154.252633368178, 5240.056789777838, 5290.206469029637, 5400.621956463049, 5411.540019098342, 5991.910121348184, 6010.8497287567725, 6011.278646562397, 6014.1580178775, 6015.0676645120075, 6037.245344331958, 6041.6072955258205, 6050.54620903434, 6058.102027000105, 6058.524249031716, 5317.096093664087, 5436.483534064258, 5448.128299472105, 5489.643173193809, 5652.943470565283, 6019.247594050744, 6022.789202377896, 6030.993293384619, 6037.619702437997, 6040.214772079602, 5859.0, 5861.3552509223955, 5861.677607731531, 5862.267216597926, 5872.207252020922, 5651.547876169897, 5767.250257466502, 5850.8537286567325, 5906.438888305604, 5954.047352423591, 5839.766409343663, 5883.294004719461, 5896.7936122235515, 5901.881962360814, 5920.615160014585, 5894.646321220741, 5897.056470964625, 5902.996490596609, 5903.852403689856, 5907.084401917709, 4396.934045989313, 4456.3538286948215, 4501.6848820582245, 4501.842435514741, 4545.795439205178, 3976.264391087658, 3980.522337319482, 3986.0, 3986.1005711546495, 4020.8793736187963, 5549.19536667181, 5568.638038527482, 5574.832755017356, 5586.944130558642, 5617.38208797032, 5730.598858079894, 5813.418658134237, 5857.414258574108, 5862.94137058624, 5872.823815285548, 5416.187571864252, 5420.105682562333, 5516.641418307797, 5618.6628802272, 5636.0418728815375, 5072.974635126875, 5132.743362831843, 5153.665011774223, 5162.767675454614, 5200.24596433515, 6167.5682702210415, 6177.320494745574, 6183.907241391383, 6192.907106393318, 6194.287656919422, 5642.971785141048, 5716.942365662366, 5779.393163717918, 5836.387179346108, 5957.582969192115, 6042.063480160582, 6090.573659843769, 6100.633961962297, 6103.298120716175, 6117.694115294128, 5766.394528574439, 5825.213596164633, 5828.795992140254, 5831.446012628963, 5831.562632802472, 5775.711214439345, 5895.94104058954, 5896.469317761251, 5902.5277977762535, 5999.550033747573, 5833.591648584558, 5848.4151584842875, 5854.590178687451, 5855.3266374367495, 5872.0, 5827.59206855516, 5845.620034697731, 5847.94152058474, 5854.151148083589, 5859.150423188699, 5457.890842183055, 5551.056320425618, 5555.194496798023, 5560.165975103767, 5671.716414179192, 5813.593048486566, 5887.146363777314, 5903.291605007426, 5948.196993405835, 5953.523718102628, 5678.68767217807, 5728.369879313355, 5734.05388110957, 5736.368999409978, 5792.0], "unit": "ms", "name": "dojo.html", "value": 5444.1159302815595}, {"lowerIsBetter": false, "replicates": [565.8726786473042, 605.2041565341578, 612.3050337866522, 613.4999975020359, 621.9657918814469, 28712.56931146032, 29833.850830745843, 29835.0, 29846.40307193855, 29919.55120673189, 31577.842110789414, 39640.60359396405, 40088.0, 40187.0, 40313.39529907054, 8676.566171691422, 8810.0, 8811.471311721318, 8816.691415800447, 8822.294216462667, 7764.495307805003, 7962.721304754335, 8604.440711353773, 8725.0, 8735.257503112243, 10498.737531561696, 10614.416207108607, 10626.893731062668, 10634.521446534924, 10750.301230419998, 10104.69685909424, 10276.74308142295, 10328.535215915303, 10328.58685652573, 10351.741206469898, 7666.0, 7918.4457088003865, 10165.440900750456, 10396.48017599117, 10686.51910664022, 38479.61520384816, 38905.41641875374, 38938.415923760884, 38993.41509877354, 39111.41332880009, 3287.6054873415105, 3299.224682199681, 3318.303156337172, 3407.863685452579, 3467.7225821934185, 29855.701442985726, 29913.401731965456, 29955.25111872199, 30053.248668783235, 30967.22581935447, 3946.3685810270217, 3966.5240171179644, 3986.222686576119, 3989.900252493682, 4146.709730318879, 273539.0, 275204.0, 275327.0, 275356.0, 276390.0, 55841.1623825643, 57170.0, 58051.709741451865, 58459.415405846245, 58467.415325846196, 63353.36646633567, 64162.0, 64199.679001604694, 64456.0, 64523.0, 14242.501512447221, 14378.640533986525, 14396.712065758626, 14402.639934001525, 14415.207163606103, 11500.769984600262, 11507.712307192387, 11539.942300288612, 11573.305601663928, 11624.302541847515, 19334.419967401, 19816.20735170577, 19840.50398740014, 19890.60218795616, 19923.10346034432, 7631.236876312324, 7822.726204582812, 7950.562719050507, 7955.443118981616, 7965.721199757981, 963.9662611808693, 968.5835090910836, 978.7797745507204, 1043.1915265669015, 1080.9676758695427, 28342.0, 28512.42975140527, 28534.28664283368, 28675.28311792222, 28950.565741513896, 1036.896310368957, 1040.5161599856103, 1043.8486419469286, 1079.5735684404774, 1156.8611766588062, 13219.471221151238, 13380.130291531019, 13511.662208444672, 13544.796828047587, 13585.184888906697, 285709.0, 288774.0, 289921.0, 290167.0, 290262.0, 50153.0, 50387.496125038284, 50434.74782626063, 50461.747691261306, 50496.747516262185, 1366.924819134957, 1372.4235820955223, 1378.1730961423066, 1378.8345398552037, 1392.735380277744, 24953.376165596004, 26109.347266318495, 26146.084887029625, 26571.601425979014, 26598.0, 42801.0, 43182.352264715424, 43414.34878476762, 43563.0, 43628.34557481704, 292849.0, 296387.0, 296822.0, 296857.0, 297672.0, 29745.405091898472, 30110.69889301079, 30288.394232115676, 30375.848120759256, 30397.048383709975, 38639.22721545609, 39247.2150556993, 39716.602833971294, 39759.204815902944, 40058.79970600245, 34811.65188348084, 36093.0, 36380.81809590935, 36408.63591364052, 37335.43996840104, 36255.45616815697, 36348.27303453969, 36392.636073638925, 36688.449673255454, 36895.262094758495, 34954.12614684653, 36005.27989440249, 36189.63810361863, 36199.63800361963, 36224.27551448903, 29981.400371992873, 32744.18139546435, 33286.0, 33286.833565832014, 33393.66606333906, 24558.280920335405, 25096.37259068465, 25181.544854315238, 25316.367090822878, 25352.239432817045], "unit": "ms", "name": "ext.html", "value": 18290.533896951278}, {"lowerIsBetter": false, "replicates": [352.6737767565002, 354.31793796940883, 354.6453546453548, 354.6790154909806, 356.54006331831937, 14219.786703199461, 14391.0, 16418.507444776646, 16850.915745421273, 17675.116244187804, 15113.622159446018, 16457.588560285967, 16474.588135296624, 16510.752338714898, 17391.652166956654, 5324.334458192726, 5458.0, 5459.781608735646, 5463.2078348639625, 5465.043617366965, 3996.100877302613, 4104.610062044101, 5396.541293990015, 5449.01917654822, 5762.56780741444, 5855.707214639272, 5887.35239123696, 5899.970500147493, 5902.380250073745, 5913.970430147843, 5724.255846739918, 5840.3575606683235, 5884.823455296348, 5885.323187833411, 5896.351401345849, 5086.084504789136, 5090.643654944155, 5096.210087436453, 5109.795608175668, 5111.182210846247, 19972.0, 20257.189712411488, 20354.28759993408, 21246.600543913053, 21251.574968500543, 2184.421128400975, 2233.1179184222306, 2288.279192054514, 2394.389430695179, 2660.813743037988, 12752.2986235757, 13127.934360328232, 13132.343382830915, 13149.53976610814, 13177.472901083946, 1818.1454716283326, 1837.6784062789093, 1843.1337271482382, 1856.3966710819038, 1865.2072869030608, 57165.0, 59409.405905941254, 59983.40016599822, 60129.6993515034, 60258.0, 9213.631454741735, 9217.44695318283, 9221.585028673726, 9237.12247336502, 9276.0, 11866.525338986516, 11902.0, 11916.404179791149, 11938.044956403466, 11943.343116128697, 7359.448041396917, 7379.704811807467, 7449.5902725350625, 7493.063367079115, 7543.886841697379, 7427.962860185665, 7441.776746697607, 7459.0, 7475.215102414277, 7517.736879209201, 5649.435056494318, 5669.886602268014, 5680.943190568124, 5700.0, 5725.227094342211, 1576.6350474288568, 1613.3062783003422, 1623.9106849123411, 1643.0, 1647.5469245957458, 904.1771987491351, 958.9041095890494, 964.6912987843823, 997.5162046407487, 1020.3673722292078, 16136.273867675984, 16616.25226864794, 16799.6640067198, 17244.396446124327, 17260.309587616353, 875.4484674654926, 907.0611916666219, 981.9410835349902, 983.5328219095873, 990.5047476261869, 8983.955080224558, 9193.908060919306, 9360.95319523398, 9363.485008324471, 9849.162821160282, 391778.0, 395829.0, 397481.0, 397542.0, 514786.0, 73185.6340718293, 75627.24372756202, 76111.23888761041, 77760.22239777642, 78051.60974195093, 1146.845175901276, 1148.6037317125579, 1179.8584169899666, 1197.3354788092518, 1216.6410908781932, 15028.17345046033, 15049.54851354461, 15054.247287635793, 15279.923600381928, 15543.300551474984, 32843.671563284064, 32853.57915943843, 32897.83551082229, 33209.33581328408, 33314.0, 43665.0, 44053.0, 45576.0, 46579.53420465752, 47265.291020635406, 8671.176238257356, 8710.782230444289, 8773.868391973998, 8815.162559556831, 8909.688160914337, 10378.844317335095, 10435.791284174122, 10514.211434142622, 10534.157267418741, 14482.0, 13823.308834558433, 13965.0, 14017.789733153806, 14224.573262802132, 14361.85105191603, 13722.862771372158, 13895.58313250604, 13897.791533126809, 14216.502422415166, 14378.640533986734, 10675.733106672395, 13471.326433678081, 13666.86333136656, 13923.443062277396, 14420.85579144195, 8622.741317760478, 8798.296136309207, 8936.955315223382, 8983.955080224558, 8993.190612844875, 9245.491497967676, 9352.438853668802, 13396.732065358834, 13891.583252502442, 13901.0], "unit": "ms", "name": "jquery.html", "value": 8667.70010814954}, {"lowerIsBetter": false, "replicates": [1332.873377029182, 1492.4179569967714, 1551.7749926260697, 1662.6425318556508, 1771.5039788859117, 6897.310268973107, 7519.360854327382, 7677.270659287373, 7698.6150692465435, 7703.576303303316, 7583.924160758391, 7676.347510461617, 7677.846443071149, 7681.193474685161, 7711.961440192791, 1982.33591746765, 2019.7273368095266, 2021.6967454881813, 2273.4771002669436, 2293.529826385587, 2053.856230063896, 2280.703508543887, 2330.3009097270838, 2330.8951097200584, 2330.9417264568438, 2263.818894488437, 2290.038183962731, 2290.0839664134314, 2316.339843144704, 2317.316391664463, 2009.8794072355706, 2047.9078441470022, 2253.188852013282, 2277.4420267034598, 2279.726432828055, 2051.507638166829, 2053.4455696961736, 2055.3731112010832, 2255.650374192003, 2299.8850057497225, 7727.536347819148, 7849.332806711436, 7880.408969327266, 7884.881726774103, 7892.644830982619, 4737.218358970766, 4842.225243960949, 4842.927356089662, 4844.394450693663, 4846.7576621169155, 3239.724623407013, 3278.2951665392056, 3287.2439338951935, 3291.0, 3311.4701647736247, 1032.4012072997643, 1043.5512729526301, 1060.777236780277, 1982.7224188613607, 2011.7183594296664, 10840.891591084068, 10946.671599852018, 10969.670909872637, 10970.616028438966, 10981.890181098166, 4241.215375155606, 4310.4611923509565, 4359.433273674465, 4376.759278239664, 4393.758343291086, 9004.41471304363, 9017.413868098552, 9028.909710902939, 9031.412958157698, 9033.232175265044, 4831.130396528659, 4832.516748325139, 4868.634852386085, 4871.707697538159, 4874.780634871439, 4415.050764085737, 4480.462344518679, 4482.394876691605, 4487.5288094749585, 4487.730736155841, 3503.667151620592, 3521.700655444316, 3572.28554289138, 3588.102974256436, 3613.9277214455565, 1089.6349722842779, 1096.4791723931069, 1106.5241945963153, 1107.7507560798756, 1115.4757264085868, 987.8024395121005, 1002.4937406609761, 1002.8646132772128, 1071.769569542552, 1222.5904322052213, 7359.264073592598, 7442.218567050381, 7455.627218639046, 7465.178830328659, 7465.776026719207, 486.5013361304691, 487.1863987141482, 497.4354108087347, 498.61606562946326, 499.2112462309542, 5513.8345849624575, 5582.358028826656, 5605.383407825136, 5647.717614119278, 5653.265075540236, 9181.495017773954, 9275.953620231856, 9362.812743745088, 9407.29445291606, 9407.764805879771, 9182.95408522953, 9288.90711092894, 9309.581068851918, 9665.081817227352, 9690.612375505041, 7434.702611895572, 7444.441666875006, 7456.3662088721985, 7539.208383119803, 7547.547147171077, 7213.062301900719, 7218.927810722035, 7254.854902901807, 7373.668184931798, 7449.81375465596, 8299.751007469786, 8424.915750842658, 8485.57572121379, 8501.277391421798, 8553.486790792573, 8533.530655813742, 8805.075467075865, 8808.91191088081, 8853.778655533662, 8894.955525222333, 6674.933250667431, 6737.191537015589, 6747.359000894907, 6750.594964302158, 6759.797206083826, 7217.458690598121, 7246.456515761444, 7268.491205615767, 7281.745138920112, 7398.186199517941, 7118.8932166018585, 7216.386607138242, 7225.6387180641805, 7322.524035937647, 7328.303811137934, 6806.944923536859, 7016.298370162943, 7040.0, 7092.282918369875, 7109.928900710926, 7033.894491582528, 7067.681954312171, 7068.0, 7077.186123595647, 7077.964610176916, 6348.206474190726, 6459.580127291711, 6466.4503517201565, 6478.384553467413, 6483.675816209076, 6530.542861999615, 6548.443382312556, 6558.344165583403, 6560.409563139149, 6561.40947314744], "unit": "ms", "name": "mootools.html", "value": 4420.362438679566}, {"lowerIsBetter": false, "replicates": [328.53840354302207, 332.6174898866303, 337.45501015859395, 339.75198105383055, 347.4302144483048, 5966.79116230932, 6066.332703402622, 6080.361562035989, 6086.573939824214, 6130.6015109017935, 5897.262842144732, 6015.037593984964, 6025.698715064251, 6027.578069535134, 6029.819105426834, 4640.234361330385, 4640.767961601923, 4646.697964632288, 4647.976760116195, 4647.976760116195, 4426.86719398417, 4511.233090374644, 4521.615662668677, 4624.052069325797, 4653.650976176783, 4570.314452832068, 4589.265717485203, 4597.4483062032605, 4623.260278355464, 4626.676132670715, 4553.931691024637, 4573.542645735433, 4574.565416285448, 4580.610648094916, 4597.747123908183, 4007.198560287925, 4013.6989725770686, 4027.335489644205, 4049.088954985134, 4064.126212864219, 5559.049301749863, 5631.267935168443, 5663.8584035399035, 5665.093585026417, 5666.320041594994, 5385.946140538623, 5387.24578559002, 5392.40683524812, 5393.2449457076045, 5393.4876186762585, 6020.608660437058, 6277.2153480814895, 6280.623162610258, 6293.244810622755, 6353.428191462791, 4351.912961740747, 4369.300911854088, 4494.955050449486, 4502.459704835441, 4510.977445112753, 6618.371254730793, 6619.040239165294, 6636.502262330345, 6643.169603799525, 6659.500537459709, 4588.059447813191, 4588.6099681526775, 4594.333821595917, 4594.816207351735, 4597.448306203277, 4357.520672725997, 4471.955280447154, 4494.10117976406, 4650.697704649255, 4651.418572678415, 5264.263003179558, 5269.578433725293, 5273.551748101378, 5275.261463395128, 5281.260623512711, 6442.967785161044, 6458.903116453257, 6472.35276472349, 6477.902831457532, 6480.449161821204, 1573.842615738417, 1598.3606557377143, 1600.191903088956, 1600.463844612068, 1600.6318546734317, 1053.2995557954027, 1058.1270451877233, 1059.2955684469896, 1066.802641511323, 1086.6631344283298, 6262.624242545462, 6270.2789179244055, 6274.215723034621, 6274.717637706314, 6279.623222606659, 6635.10426092481, 6649.335066493409, 6655.667216639149, 6667.0, 6668.966655166693, 5998.3701711320555, 6173.351798061229, 6174.845628859314, 6179.3202747697715, 6183.505319574423, 3591.1560783215923, 3618.6743193112748, 3626.5829429615405, 3629.455581662719, 3631.4371272452813, 6890.069840571458, 6904.689288982008, 6907.792766217021, 6911.101556797584, 6915.550489218184, 6619.834504137339, 6794.8301292467095, 6795.762148324785, 6798.76204332846, 6800.319968003259, 6891.586504809828, 6892.310768923067, 6892.345227203407, 6893.4140598048725, 6900.447964162855, 6423.100765892872, 6570.77002304917, 6596.70314835824, 6636.170478690164, 6641.468682505485, 6631.801045968628, 6651.900221496779, 6659.4006539411685, 6664.7000884959325, 6671.5997040177745, 6914.654267286716, 6938.27148149437, 6953.68708408133, 6957.095577574883, 6957.686904089227, 4355.978220108879, 4500.0, 4504.256797628485, 4586.128635559233, 4587.243104887656, 6654.0, 6656.667166641745, 6657.201135863727, 6659.234188068241, 6659.267480577036, 6480.708368123352, 6483.994980777987, 6484.578502397329, 6486.513511486563, 6489.7404103835315, 6323.747050117944, 6429.357064293533, 6433.485321174388, 6502.284748677547, 6510.251321098134, 6313.936860631335, 6313.936860631335, 6317.778877739441, 6325.96837015812, 6337.0, 6522.836929076811, 6537.967310163419, 6540.37866402691, 6545.509086818603, 6546.607203567801, 6218.81343559694, 6357.396047375492, 6359.936400636119, 6362.713677884599, 6368.834596237301], "unit": "ms", "name": "prototype.html", "value": 4837.408169715142}, {"lowerIsBetter": false, "replicates": [762.3558093411066, 778.3306356533382, 796.1998191817224, 798.5208874675192, 799.4843326054698, 11222.775544489105, 11423.600173993902, 11452.0, 11504.367259800707, 11561.884381156207, 12163.695907602292, 12201.572944946929, 12231.449584768685, 12231.571894983677, 12239.143259971806, 676.1142902797327, 680.0886811672358, 686.3273991488344, 792.065362871811, 810.266708628692, 816.9387295952797, 827.2596026556229, 828.2297463359074, 828.3704384667666, 828.5774255129897, 856.9957150214241, 869.1916517638593, 869.4913475616772, 869.9521526316082, 870.0472982084639, 693.6150436507736, 710.7796583059217, 842.9409941304111, 865.6364326982651, 867.3104881619128, 635.5963962883555, 636.462189449914, 636.9745210191587, 638.0652344315554, 639.028676411856, 12279.877201227962, 12454.315012674298, 12462.563810266687, 12464.0, 12467.189632673848, 12007.879921200763, 12051.337176455292, 12353.567625133077, 12489.18820276679, 13162.61792511782, 9689.563969621313, 9873.0, 10013.89986100137, 10131.848022279672, 10132.94933525335, 3451.2924850405607, 3522.4716292556063, 3533.628968958248, 3571.964280357215, 3650.470681751131, 44721.32918006233, 44928.77535612334, 45153.096938061055, 45299.547004529864, 45414.54585454169, 9709.36889102206, 9719.85420218683, 9744.074312940402, 9786.657466988763, 9824.312298139062, 19634.50913727168, 19651.31220407279, 19790.901045494968, 19800.0, 19809.603807923762, 6772.356626120511, 6808.319168083152, 6895.172579290417, 6895.586264824126, 7024.086868707035, 4076.5515793262716, 4152.647025002909, 4164.5210800757695, 4173.457450531411, 4220.683448741295, 3095.4737694591972, 3102.286474110967, 3113.315070684446, 3115.3613509230554, 3119.5320701894443, 548.8682716148096, 560.1905246918164, 563.155267099351, 570.5749216833485, 577.6822747488949, 639.1403562208822, 661.1999480628493, 681.1825809029185, 681.8295426143465, 685.1914740606034, 8081.6363263653275, 8245.175482451827, 8332.583370831435, 8336.0, 8497.610513739472, 552.6628756458557, 650.0768908150437, 668.6656671664168, 671.2984930747381, 675.6790524500921, 3869.28418242626, 3963.980180099081, 3984.6812255019527, 4053.1931836279687, 4221.345691417835, 53925.460745392826, 54932.72533637306, 55258.447415526134, 56038.0, 56638.71680641653, 49821.25268120909, 49904.50095499071, 50353.49646503561, 50434.0, 50691.0, 44459.55540444619, 44555.77722111368, 44651.55348446474, 44813.103737925056, 45450.54549454463, 7943.642536086006, 7945.960270198843, 8088.63601137962, 8159.061707903667, 8269.751907442786, 33820.492692610125, 34131.0, 34237.486437703956, 34709.826450867586, 35127.64872351244, 41917.161656767305, 42892.571074288855, 43269.567304327815, 43826.342604860314, 44190.33714494221, 10868.402237876993, 11099.667009989713, 11161.49773260189, 11211.943940280573, 11476.823535862555, 11574.537018519164, 11665.35840528745, 11862.881371186522, 12530.874691252971, 12706.936465317614, 10842.24104312722, 11125.388103654377, 11403.372814495282, 11532.884671153517, 11666.76666466683, 10758.677239682822, 10950.780984380428, 11213.775724485628, 11282.774344513227, 11586.76826463483, 10746.408947507962, 10878.45607719595, 10972.286801357886, 11206.0, 11339.0, 9545.281849267198, 9829.4102353859, 9843.94593841439, 9944.751381215527, 10053.145482634058, 8860.512671803113, 9125.680601178927, 9150.58822353009, 9207.447553146832, 9840.133809143304], "unit": "ms", "name": "yui.html", "value": 6153.528832061377}], "name": "dromaeo_css", "value": 6959.0246501884485}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 105.0, 109.0, 112.0, 111.0, 100.0, 109.0, 102.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 160.0, 161.0, 124.0, 153.0, 145.0, 124.0, 176.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 160.0, 159.0, 159.0, 161.0, 160.0, 165.0, 160.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 84.0, 92.0, 72.0, 72.0, 71.0, 95.0, 94.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 131.0, 91.0, 90.0, 91.0, 135.0, 91.0, 91.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 103.8}, {"lowerIsBetter": true, "replicates": [112.0, 109.0, 109.0, 117.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 144.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 62.0, 64.0, 61.0, 62.0, 65.0, 70.0, 61.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 62.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [92.0, 86.0, 86.0, 85.0, 92.0, 85.0, 84.0, 85.0, 88.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [116.0, 120.0, 132.0, 116.0, 125.0, 120.0, 125.0, 125.0, 117.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [140.0, 158.0, 148.0, 150.0, 150.0, 139.0, 149.0, 148.0, 151.0, 145.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 68.0, 66.0, 66.0, 66.0, 67.0, 82.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1503.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.1321370309951], "unit": "score", "name": "Richards", "value": 216.40126}, {"lowerIsBetter": false, "replicates": [195.04583577140627], "unit": "score", "name": "DeltaBlue", "value": 338.986986}, {"lowerIsBetter": false, "replicates": [285.143997718848], "unit": "score", "name": "Encrypt", "value": 933.4967669999996}, {"lowerIsBetter": false, "replicates": [5065.656565656565], "unit": "score", "name": "Decrypt", "value": 52.54619940179463}, {"lowerIsBetter": false, "replicates": [1104.9723756906078], "unit": "score", "name": "RayTrace", "value": 669.6900450000003}, {"lowerIsBetter": false, "replicates": [789.4321766561515], "unit": "score", "name": "Earley", "value": 844.2308531468531}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [27216.216216216217], "unit": "score", "name": "RegExp", "value": 33.472140019860944}, {"lowerIsBetter": false, "replicates": [653.1678641410842], "unit": "score", "name": "Splay", "value": 124.76272099999996}, {"lowerIsBetter": false, "replicates": [4873.78640776699], "unit": "score", "name": "NavierStokes", "value": 304.48605577689233}], "name": "v8_7", "value": 20734.00168500603}]} 18:14:08 INFO - RETURN: dromaeo_css: 6959.03 18:14:08 INFO - RETURN: kraken: 1504.00 18:14:08 INFO - RETURN: v8_7: 20734.00 18:14:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20734.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1504.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6959.03"}}} 18:14:08 INFO - Return code: 0 18:14:08 INFO - # TBPL SUCCESS # 18:14:08 INFO - Running post-action listener: _resource_record_post_action 18:14:08 INFO - Running post-run listener: _resource_record_post_run 18:14:10 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 10260480; Write bytes: 466423808; Read time: 3792; Write time: 515808 18:14:10 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 99876864; Read time: 228; Write time: 55568 18:14:10 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 8003584; Write bytes: 359170048; Read time: 3036; Write time: 429024 18:14:10 INFO - Running post-run listener: _upload_blobber_files 18:14:10 INFO - Blob upload gear active. 18:14:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:14:10 INFO - Copying logs to upload dir... 18:14:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1293.226498 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2015-11-19 18:14:09.981563) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 18:14:09.985618) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009972 build_url: 'https://queue.taskcluster.net/v1/task/e13_CEDcSae77WuTv5Fo9Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 18:14:10.040788) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:14:10.041185) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1447982487.543261-1811330221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:14:10.097112) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 18:14:10.097540) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 18:14:10.097929) ========= ========= Total master_lag: 0.22 =========