builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1448542195.16 results: success (0) buildid: 20151126034441 builduid: 8e85369ba5064a1ca56cf25922437bda revision: 414d106b2e20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.158181) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.160712) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.161105) ========= 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=a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006754 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.182399) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.182740) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.196818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.197210) ========= 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=a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.247170) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.247508) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.247905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.248238) ========= 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=a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 04:49:55-- 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-26 04:49:55 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197089 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.458209) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.458622) ========= 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=a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019995 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:55.509540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 04:49:55.510007) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 414d106b2e20 --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/b2g-inbound --rev 414d106b2e20 --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=a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 04:49:55,528 Setting DEBUG logging. 2015-11-26 04:49:55,529 attempt 1/10 2015-11-26 04:49:55,529 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/414d106b2e20?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 04:49:56,288 unpacking tar archive at: b2g-inbound-414d106b2e20/testing/mozharness/ program finished with exit code 0 elapsedTime=1.053420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 04:49:56.576494) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:56.576834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:56.586694) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:56.587153) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 04:49:56.587602) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-26 04:49:56.587890) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:49:56 INFO - MultiFileLogger online at 20151126 04:49:56 in /builds/slave/test-pgo 04:49:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 04:49:56 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:49:56 INFO - {'append_to_log': False, 04:49:56 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:49:56 INFO - 'blob_upload_branch': 'B2G-Inbound', 04:49:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:49:56 INFO - 'branch': 'B2G-Inbound', 04:49:56 INFO - 'buildbot_json_path': 'buildprops.json', 04:49:56 INFO - 'config_files': ('talos/linux_config.py',), 04:49:56 INFO - 'default_actions': ('clobber', 04:49:56 INFO - 'read-buildbot-config', 04:49:56 INFO - 'download-and-extract', 04:49:56 INFO - 'populate-webroot', 04:49:56 INFO - 'create-virtualenv', 04:49:56 INFO - 'install', 04:49:56 INFO - 'run-tests'), 04:49:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:49:56 INFO - 'download_minidump_stackwalk': True, 04:49:56 INFO - 'download_symbols': 'ondemand', 04:49:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:49:56 INFO - 'tooltool.py': '/tools/tooltool.py', 04:49:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:49:56 INFO - '/tools/misc-python/virtualenv.py')}, 04:49:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:49:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:49:56 INFO - 'installer_path': 'installer.exe', 04:49:56 INFO - 'log_level': 'info', 04:49:56 INFO - 'log_name': 'talos', 04:49:56 INFO - 'log_to_console': True, 04:49:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:49:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:49:56 INFO - 'opt_config_files': (), 04:49:56 INFO - 'pip_index': False, 04:49:56 INFO - 'sps_profile': False, 04:49:56 INFO - 'sps_profile_interval': 0, 04:49:56 INFO - 'suite': 'dromaeojs', 04:49:56 INFO - 'system_bits': '64', 04:49:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:49:56 INFO - 'title': 'talos-linux64-ix-033', 04:49:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:49:56 INFO - 'use_talos_json': True, 04:49:56 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:49:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:49:56 INFO - 'work_dir': 'build'} 04:49:56 INFO - ##### 04:49:56 INFO - ##### Running clobber step. 04:49:56 INFO - ##### 04:49:56 INFO - Running pre-action listener: _resource_record_pre_action 04:49:56 INFO - Running main action method: clobber 04:49:56 INFO - rmtree: /builds/slave/test-pgo/build 04:49:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:49:57 INFO - Running post-action listener: _resource_record_post_action 04:49:57 INFO - ##### 04:49:57 INFO - ##### Running read-buildbot-config step. 04:49:57 INFO - ##### 04:49:57 INFO - Running pre-action listener: _resource_record_pre_action 04:49:57 INFO - Running main action method: read_buildbot_config 04:49:57 INFO - Using buildbot properties: 04:49:57 INFO - { 04:49:57 INFO - "properties": { 04:49:57 INFO - "buildnumber": 1009, 04:49:57 INFO - "product": "firefox", 04:49:57 INFO - "script_repo_revision": "production", 04:49:57 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:49:57 INFO - "repository": "", 04:49:57 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 04:49:57 INFO - "buildid": "20151126034441", 04:49:57 INFO - "slavename": "talos-linux64-ix-033", 04:49:57 INFO - "pgo_build": "True", 04:49:57 INFO - "basedir": "/builds/slave/test-pgo", 04:49:57 INFO - "project": "", 04:49:57 INFO - "platform": "ubuntu64_hw", 04:49:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:49:57 INFO - "slavebuilddir": "test", 04:49:57 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 04:49:57 INFO - "branch": "b2g-inbound", 04:49:57 INFO - "repo_path": "integration/b2g-inbound", 04:49:57 INFO - "stage_platform": "linux64-pgo", 04:49:57 INFO - "builduid": "8e85369ba5064a1ca56cf25922437bda", 04:49:57 INFO - "revision": "414d106b2e20" 04:49:57 INFO - }, 04:49:57 INFO - "sourcestamp": { 04:49:57 INFO - "repository": "", 04:49:57 INFO - "hasPatch": false, 04:49:57 INFO - "project": "", 04:49:57 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 04:49:57 INFO - "changes": [ 04:49:57 INFO - { 04:49:57 INFO - "category": null, 04:49:57 INFO - "files": [ 04:49:57 INFO - { 04:49:57 INFO - "url": null, 04:49:57 INFO - "name": "https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:49:57 INFO - } 04:49:57 INFO - ], 04:49:57 INFO - "repository": "", 04:49:57 INFO - "rev": "414d106b2e20", 04:49:57 INFO - "who": "sendchange", 04:49:57 INFO - "when": 1448542146, 04:49:57 INFO - "number": 6710616, 04:49:57 INFO - "comments": "", 04:49:57 INFO - "project": "", 04:49:57 INFO - "at": "Thu 26 Nov 2015 04:49:06", 04:49:57 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 04:49:57 INFO - "revlink": "", 04:49:57 INFO - "properties": [ 04:49:57 INFO - [ 04:49:57 INFO - "buildid", 04:49:57 INFO - "20151126034441", 04:49:57 INFO - "Change" 04:49:57 INFO - ], 04:49:57 INFO - [ 04:49:57 INFO - "builduid", 04:49:57 INFO - "8e85369ba5064a1ca56cf25922437bda", 04:49:57 INFO - "Change" 04:49:57 INFO - ], 04:49:57 INFO - [ 04:49:57 INFO - "pgo_build", 04:49:57 INFO - "True", 04:49:57 INFO - "Change" 04:49:57 INFO - ] 04:49:57 INFO - ], 04:49:57 INFO - "revision": "414d106b2e20" 04:49:57 INFO - } 04:49:57 INFO - ], 04:49:57 INFO - "revision": "414d106b2e20" 04:49:57 INFO - } 04:49:57 INFO - } 04:49:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:49:57 INFO - Running post-action listener: _resource_record_post_action 04:49:57 INFO - ##### 04:49:57 INFO - ##### Running download-and-extract step. 04:49:57 INFO - ##### 04:49:57 INFO - Running pre-action listener: _resource_record_pre_action 04:49:57 INFO - Running main action method: download_and_extract 04:49:57 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:57 INFO - https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:49:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/test_packages.json 04:49:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/test_packages.json 04:49:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:49:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:50:01 INFO - Downloaded 1302 bytes. 04:50:01 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:50:01 INFO - Using the following test package requirements: 04:50:01 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:50:01 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:50:01 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:01 INFO - u'jsshell-linux-x86_64.zip'], 04:50:01 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:50:01 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:50:01 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:50:01 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:50:01 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:50:01 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:50:01 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:50:01 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:01 INFO - https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:50:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:50:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:50:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/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 04:50:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/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 04:50:05 INFO - Downloaded 22753801 bytes. 04:50:05 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 04:50:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:50:05 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 04:50:07 INFO - Return code: 0 04:50:07 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 04:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:07 INFO - https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:50:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:50:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:50:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/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 04:50:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/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 04:50:08 INFO - Downloaded 22753801 bytes. 04:50:08 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 04:50:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:50:08 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 04:50:10 INFO - Return code: 0 04:50:10 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')]} 04:50:10 INFO - https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:50:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/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 04:50:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/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 04:50:11 INFO - Downloaded 11131717 bytes. 04:50:11 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 04:50:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:11 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 04:50:11 INFO - Return code: 0 04:50: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')]} 04:50:11 INFO - https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:50:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:50:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:50:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/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 04:50:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/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 04:50:12 INFO - Downloaded 58391303 bytes. 04:50:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:50:12 INFO - mkdir: /builds/slave/test-pgo/properties 04:50:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:50:12 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:50:12 INFO - Contents: 04:50:12 INFO - build_url:https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:50:12 INFO - Running post-action listener: _resource_record_post_action 04:50:12 INFO - Running post-action listener: set_extra_try_arguments 04:50:12 INFO - ##### 04:50:12 INFO - ##### Running populate-webroot step. 04:50:12 INFO - ##### 04:50:12 INFO - Running pre-action listener: _resource_record_pre_action 04:50:12 INFO - Running main action method: populate_webroot 04:50:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:50:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:50:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:50:12 INFO - '../fennec_ids.txt'], 04:50:12 INFO - 'tests': ['tcheck2']}, 04:50:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:50:12 INFO - '--tppagecycles', 04:50:12 INFO - '7'], 04:50:12 INFO - 'tests': ['tsvgm']}}, 04:50:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:50:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:50:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:50:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:50:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:50:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:50:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:50:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:12 INFO - 'talos_options': ['--e10s'], 04:50:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:50:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:12 INFO - 'tests': ['damp', 'tps']}, 04:50:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:12 INFO - 'talos_options': ['--e10s'], 04:50:12 INFO - 'tests': ['damp', 'tps']}, 04:50:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:50:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:50:12 INFO - 'other': {'tests': ['a11yr', 04:50:12 INFO - 'ts_paint', 04:50:12 INFO - 'tpaint', 04:50:12 INFO - 'sessionrestore', 04:50:12 INFO - 'sessionrestore_no_auto_restore']}, 04:50:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:50:12 INFO - 'tests': ['a11yr', 04:50:12 INFO - 'ts_paint', 04:50:12 INFO - 'tpaint', 04:50:12 INFO - 'sessionrestore', 04:50:12 INFO - 'sessionrestore_no_auto_restore']}, 04:50:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:50:12 INFO - 'tests': ['a11yr', 04:50:12 INFO - 'ts_paint', 04:50:12 INFO - 'tpaint', 04:50:12 INFO - 'sessionrestore', 04:50:12 INFO - 'sessionrestore_no_auto_restore']}, 04:50:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:50:12 INFO - 'tests': ['a11yr', 04:50:12 INFO - 'ts_paint', 04:50:12 INFO - 'tpaint', 04:50:12 INFO - 'sessionrestore', 04:50:12 INFO - 'sessionrestore_no_auto_restore']}, 04:50:12 INFO - 'other_l64': {'tests': ['a11yr', 04:50:12 INFO - 'ts_paint', 04:50:12 INFO - 'tpaint', 04:50:12 INFO - 'sessionrestore', 04:50:12 INFO - 'sessionrestore_no_auto_restore']}, 04:50:12 INFO - 'other_nol64': {'tests': ['a11yr', 04:50:12 INFO - 'ts_paint', 04:50:12 INFO - 'tpaint', 04:50:12 INFO - 'sessionrestore', 04:50:12 INFO - 'sessionrestore_no_auto_restore']}, 04:50:12 INFO - 'svgr': {'tests': ['tsvgx', 04:50:12 INFO - 'tsvgr_opacity', 04:50:12 INFO - 'tart', 04:50:12 INFO - 'tscrollx', 04:50:12 INFO - 'cart']}, 04:50:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:50:12 INFO - 'tests': ['tsvgx', 04:50:12 INFO - 'tsvgr_opacity', 04:50:12 INFO - 'tart', 04:50:12 INFO - 'tscrollx', 04:50:12 INFO - 'cart']}, 04:50:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:12 INFO - 'tests': ['tp5o']}, 04:50:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:12 INFO - 'talos_options': ['--e10s'], 04:50:12 INFO - 'tests': ['tp5o']}, 04:50:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:12 INFO - 'talos_options': ['--xperf_path', 04:50:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:50:12 INFO - 'tests': ['tp5n']}, 04:50:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:12 INFO - 'talos_options': ['--e10s', 04:50:12 INFO - '--xperf_path', 04:50:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:50:12 INFO - 'tests': ['tp5n']}}, 04:50:12 INFO - 'talos.zip': {'path': '', 04:50:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:50:12 INFO - Running post-action listener: _resource_record_post_action 04:50:12 INFO - ##### 04:50:12 INFO - ##### Running create-virtualenv step. 04:50:12 INFO - ##### 04:50:12 INFO - Running pre-action listener: _resource_record_pre_action 04:50:12 INFO - Running main action method: create_virtualenv 04:50:12 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:50:12 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 04:50:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:50:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:50:12 INFO - Using real prefix '/usr' 04:50:12 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:50:13 INFO - Installing distribute.............................................................................................................................................................................................done. 04:50:15 INFO - Installing pip.................done. 04:50:15 INFO - Return code: 0 04:50:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:50: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')]} 04:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:15 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 0x2847030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a747d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03640>, '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 0x2b04540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b049d0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', '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 04:50:15 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 04:50:15 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 04:50:15 INFO - Using env: {'DISPLAY': ':0', 04:50:15 INFO - 'HOME': '/home/cltbld', 04:50:15 INFO - 'LANG': 'en_US.UTF-8', 04:50:15 INFO - 'LANGUAGE': 'en_US:en', 04:50:15 INFO - 'LOGNAME': 'cltbld', 04:50:15 INFO - 'MAIL': '/var/mail/cltbld', 04:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:15 INFO - 'MOZ_NO_REMOTE': '1', 04:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:15 INFO - 'NO_EM_RESTART': '1', 04:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:15 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:15 INFO - 'SHELL': '/bin/bash', 04:50:15 INFO - 'SHLVL': '1', 04:50:15 INFO - 'TERM': 'linux', 04:50:15 INFO - 'TMOUT': '86400', 04:50:15 INFO - 'USER': 'cltbld', 04:50:15 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', 04:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:15 INFO - '_': '/tools/buildbot/bin/python'} 04:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:15 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 04:50:15 INFO - Cleaning up... 04:50:15 INFO - Return code: 0 04:50:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:50: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')]} 04:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:15 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 0x2847030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a747d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03640>, '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 0x2b04540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b049d0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', '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 04:50:15 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 04:50:15 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 04:50:15 INFO - Using env: {'DISPLAY': ':0', 04:50:15 INFO - 'HOME': '/home/cltbld', 04:50:15 INFO - 'LANG': 'en_US.UTF-8', 04:50:15 INFO - 'LANGUAGE': 'en_US:en', 04:50:15 INFO - 'LOGNAME': 'cltbld', 04:50:15 INFO - 'MAIL': '/var/mail/cltbld', 04:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:15 INFO - 'MOZ_NO_REMOTE': '1', 04:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:15 INFO - 'NO_EM_RESTART': '1', 04:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:15 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:15 INFO - 'SHELL': '/bin/bash', 04:50:15 INFO - 'SHLVL': '1', 04:50:15 INFO - 'TERM': 'linux', 04:50:15 INFO - 'TMOUT': '86400', 04:50:15 INFO - 'USER': 'cltbld', 04:50:15 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', 04:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:15 INFO - '_': '/tools/buildbot/bin/python'} 04:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:15 INFO - Downloading/unpacking psutil>=0.7.1 04:50:15 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 04:50:15 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 04:50:15 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 04:50:15 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 04:50:15 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 04:50:15 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 04:50:17 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:50:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:50:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:50:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:50:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:50:17 INFO - Installing collected packages: psutil 04:50:17 INFO - Running setup.py install for psutil 04:50:17 INFO - building 'psutil._psutil_linux' extension 04:50:17 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 04:50:17 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 04:50:17 INFO - building 'psutil._psutil_posix' extension 04:50:17 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 04:50:17 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 04:50:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:50:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:50:17 INFO - Successfully installed psutil 04:50:17 INFO - Cleaning up... 04:50:17 INFO - Return code: 0 04:50:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x2847030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a747d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03640>, '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 0x2b04540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b049d0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', '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 04:50:17 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 04:50:17 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 04:50:17 INFO - Using env: {'DISPLAY': ':0', 04:50:17 INFO - 'HOME': '/home/cltbld', 04:50:17 INFO - 'LANG': 'en_US.UTF-8', 04:50:17 INFO - 'LANGUAGE': 'en_US:en', 04:50:17 INFO - 'LOGNAME': 'cltbld', 04:50:17 INFO - 'MAIL': '/var/mail/cltbld', 04:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:17 INFO - 'MOZ_NO_REMOTE': '1', 04:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:17 INFO - 'NO_EM_RESTART': '1', 04:50:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:17 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:17 INFO - 'SHELL': '/bin/bash', 04:50:17 INFO - 'SHLVL': '1', 04:50:17 INFO - 'TERM': 'linux', 04:50:17 INFO - 'TMOUT': '86400', 04:50:17 INFO - 'USER': 'cltbld', 04:50:17 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', 04:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:17 INFO - '_': '/tools/buildbot/bin/python'} 04:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:50:18 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 04:50:18 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 04:50:18 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 04:50:18 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 04:50:18 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 04:50:18 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 04:50:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:50:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:50:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:50:19 INFO - Installing collected packages: mozsystemmonitor 04:50:19 INFO - Running setup.py install for mozsystemmonitor 04:50:20 INFO - Successfully installed mozsystemmonitor 04:50:20 INFO - Cleaning up... 04:50:20 INFO - Return code: 0 04:50:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:50:20 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')]} 04:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:20 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')]} 04:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:20 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 0x2847030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a747d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03640>, '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 0x2b04540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b049d0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', '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 04:50:20 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 04:50:20 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 04:50:20 INFO - Using env: {'DISPLAY': ':0', 04:50:20 INFO - 'HOME': '/home/cltbld', 04:50:20 INFO - 'LANG': 'en_US.UTF-8', 04:50:20 INFO - 'LANGUAGE': 'en_US:en', 04:50:20 INFO - 'LOGNAME': 'cltbld', 04:50:20 INFO - 'MAIL': '/var/mail/cltbld', 04:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:20 INFO - 'MOZ_NO_REMOTE': '1', 04:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:20 INFO - 'NO_EM_RESTART': '1', 04:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:20 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:20 INFO - 'SHELL': '/bin/bash', 04:50:20 INFO - 'SHLVL': '1', 04:50:20 INFO - 'TERM': 'linux', 04:50:20 INFO - 'TMOUT': '86400', 04:50:20 INFO - 'USER': 'cltbld', 04:50:20 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', 04:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:20 INFO - '_': '/tools/buildbot/bin/python'} 04:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:20 INFO - Downloading/unpacking blobuploader==1.2.4 04:50:20 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 04:50:20 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 04:50:20 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 04:50:20 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 04:50:20 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 04:50:20 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 04:50:21 INFO - Downloading blobuploader-1.2.4.tar.gz 04:50:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:50:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:50:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:50:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:50:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:22 INFO - Downloading docopt-0.6.1.tar.gz 04:50:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:50:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:50:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:50:22 INFO - Running setup.py install for blobuploader 04:50:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:50:22 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:50:22 INFO - Running setup.py install for requests 04:50:23 INFO - Running setup.py install for docopt 04:50:23 INFO - Successfully installed blobuploader requests docopt 04:50:23 INFO - Cleaning up... 04:50:23 INFO - Return code: 0 04:50:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:50:23 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')]} 04:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:23 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')]} 04:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:23 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 0x2847030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a747d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03640>, '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 0x2b04540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b049d0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', '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 04:50:23 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 04:50:23 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 04:50:23 INFO - Using env: {'DISPLAY': ':0', 04:50:23 INFO - 'HOME': '/home/cltbld', 04:50:23 INFO - 'LANG': 'en_US.UTF-8', 04:50:23 INFO - 'LANGUAGE': 'en_US:en', 04:50:23 INFO - 'LOGNAME': 'cltbld', 04:50:23 INFO - 'MAIL': '/var/mail/cltbld', 04:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:23 INFO - 'MOZ_NO_REMOTE': '1', 04:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:23 INFO - 'NO_EM_RESTART': '1', 04:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:23 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:23 INFO - 'SHELL': '/bin/bash', 04:50:23 INFO - 'SHLVL': '1', 04:50:23 INFO - 'TERM': 'linux', 04:50:23 INFO - 'TMOUT': '86400', 04:50:23 INFO - 'USER': 'cltbld', 04:50:23 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', 04:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:23 INFO - '_': '/tools/buildbot/bin/python'} 04:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:50:23 INFO - Running setup.py (path:/tmp/pip-z9pIJO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:50:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:50:23 INFO - Running setup.py (path:/tmp/pip-c0HzMp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:50:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:50:23 INFO - Running setup.py (path:/tmp/pip-7hBNex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:50:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:50:23 INFO - Running setup.py (path:/tmp/pip-sGiOp4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:50:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:50:23 INFO - Running setup.py (path:/tmp/pip-t8mPAe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:50:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:50:23 INFO - Running setup.py (path:/tmp/pip-M6YYLv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:50:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:50:23 INFO - Running setup.py (path:/tmp/pip-ojLBxF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:50:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:50:23 INFO - Running setup.py (path:/tmp/pip-ArbPSe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:50:24 INFO - Running setup.py (path:/tmp/pip-eYh1qv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:50:24 INFO - Running setup.py (path:/tmp/pip-frPjcZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:50:24 INFO - Running setup.py (path:/tmp/pip-XTtHyQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:50:24 INFO - Running setup.py (path:/tmp/pip-pYjnP9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:50:24 INFO - Running setup.py (path:/tmp/pip-xsHaOB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:50:24 INFO - Running setup.py (path:/tmp/pip-9QE4lx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:50:24 INFO - Running setup.py (path:/tmp/pip-1IAJfG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:50:24 INFO - Running setup.py (path:/tmp/pip-Mm5LIN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:50:24 INFO - Running setup.py (path:/tmp/pip-D4eUo8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:50:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:50:24 INFO - Running setup.py install for manifestparser 04:50:24 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:50:24 INFO - Running setup.py install for mozcrash 04:50:24 INFO - Running setup.py install for mozdebug 04:50:24 INFO - Running setup.py install for mozdevice 04:50:25 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:50:25 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:50:25 INFO - Running setup.py install for mozfile 04:50:25 INFO - Running setup.py install for mozhttpd 04:50:25 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:50:25 INFO - Running setup.py install for mozinfo 04:50:25 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:50:25 INFO - Running setup.py install for mozInstall 04:50:25 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:50:25 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:50:25 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:50:25 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:50:25 INFO - Running setup.py install for mozleak 04:50:25 INFO - Running setup.py install for mozlog 04:50:25 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:50:25 INFO - Running setup.py install for moznetwork 04:50:25 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:50:25 INFO - Running setup.py install for mozprocess 04:50:25 INFO - Running setup.py install for mozprofile 04:50:26 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:50:26 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:50:26 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:50:26 INFO - Running setup.py install for mozrunner 04:50:26 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:50:26 INFO - Running setup.py install for mozscreenshot 04:50:26 INFO - Running setup.py install for moztest 04:50:26 INFO - Running setup.py install for mozversion 04:50:26 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:50:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:50:26 INFO - Cleaning up... 04:50:26 INFO - Return code: 0 04:50:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:50: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')]} 04:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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', '-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 0x2847030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a747d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03640>, '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 0x2b04540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b049d0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', '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 04:50:26 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 04:50:26 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 04:50:26 INFO - Using env: {'DISPLAY': ':0', 04:50:26 INFO - 'HOME': '/home/cltbld', 04:50:26 INFO - 'LANG': 'en_US.UTF-8', 04:50:26 INFO - 'LANGUAGE': 'en_US:en', 04:50:26 INFO - 'LOGNAME': 'cltbld', 04:50:26 INFO - 'MAIL': '/var/mail/cltbld', 04:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:26 INFO - 'MOZ_NO_REMOTE': '1', 04:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:26 INFO - 'NO_EM_RESTART': '1', 04:50:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:26 INFO - 'SHELL': '/bin/bash', 04:50:26 INFO - 'SHLVL': '1', 04:50:26 INFO - 'TERM': 'linux', 04:50:26 INFO - 'TMOUT': '86400', 04:50:26 INFO - 'USER': 'cltbld', 04:50:26 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', 04:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:26 INFO - '_': '/tools/buildbot/bin/python'} 04:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:50:26 INFO - Running setup.py (path:/tmp/pip-QrLq0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:50:26 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)) 04:50:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:50:26 INFO - Running setup.py (path:/tmp/pip-McrEkl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:50:26 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)) 04:50:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:50:26 INFO - Running setup.py (path:/tmp/pip-gNqBKb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:50:26 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)) 04:50:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:50:26 INFO - Running setup.py (path:/tmp/pip-rx6YwW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:50:26 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)) 04:50:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:50:26 INFO - Running setup.py (path:/tmp/pip-DhPJeF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:50:27 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)) 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:50:27 INFO - Running setup.py (path:/tmp/pip-zz8P4V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:50:27 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)) 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:50:27 INFO - Running setup.py (path:/tmp/pip-GKKyMc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:50:27 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)) 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:50:27 INFO - Running setup.py (path:/tmp/pip-UxJZJg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:50:27 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)) 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:50:27 INFO - Running setup.py (path:/tmp/pip-3sXzAo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:50:27 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)) 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:50:27 INFO - Running setup.py (path:/tmp/pip-e63dG6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:50:27 INFO - Running setup.py (path:/tmp/pip-fRGUEz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:50:27 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)) 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:50:27 INFO - Running setup.py (path:/tmp/pip-Fqi0AX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:50:27 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)) 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:50:27 INFO - Running setup.py (path:/tmp/pip-sFTZt3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:50:27 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)) 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:50:27 INFO - Running setup.py (path:/tmp/pip-SmGdoi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:50:27 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)) 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:50:27 INFO - Running setup.py (path:/tmp/pip-DNv7Jg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:50:27 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)) 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:50:27 INFO - Running setup.py (path:/tmp/pip-FJakpi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:50:27 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)) 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:50:27 INFO - Running setup.py (path:/tmp/pip-35_Hpf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:50:27 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)) 04:50:27 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)) 04:50:27 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)) 04:50:27 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)) 04:50:27 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)) 04:50:27 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)) 04:50:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:50:27 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 04:50:27 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 04:50:27 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 04:50:27 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 04:50:27 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 04:50:27 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 04:50:29 INFO - Downloading blessings-1.5.1.tar.gz 04:50:29 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 04:50:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:50:29 INFO - Installing collected packages: blessings 04:50:29 INFO - Running setup.py install for blessings 04:50:29 INFO - Successfully installed blessings 04:50:29 INFO - Cleaning up... 04:50:29 INFO - Return code: 0 04:50:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:50:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:50:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:50:30 INFO - Reading from file tmpfile_stdout 04:50:30 INFO - Current package versions: 04:50:30 INFO - argparse == 1.2.1 04:50:30 INFO - blessings == 1.5.1 04:50:30 INFO - blobuploader == 1.2.4 04:50:30 INFO - docopt == 0.6.1 04:50:30 INFO - manifestparser == 1.1 04:50:30 INFO - mozInstall == 1.12 04:50:30 INFO - mozcrash == 0.16 04:50:30 INFO - mozdebug == 0.1 04:50:30 INFO - mozdevice == 0.47 04:50:30 INFO - mozfile == 1.2 04:50:30 INFO - mozhttpd == 0.7 04:50:30 INFO - mozinfo == 0.9 04:50:30 INFO - mozleak == 0.1 04:50:30 INFO - mozlog == 3.1 04:50:30 INFO - moznetwork == 0.27 04:50:30 INFO - mozprocess == 0.22 04:50:30 INFO - mozprofile == 0.27 04:50:30 INFO - mozrunner == 6.11 04:50:30 INFO - mozscreenshot == 0.1 04:50:30 INFO - mozsystemmonitor == 0.0 04:50:30 INFO - moztest == 0.7 04:50:30 INFO - mozversion == 1.4 04:50:30 INFO - psutil == 3.1.1 04:50:30 INFO - requests == 1.2.3 04:50:30 INFO - wsgiref == 0.1.2 04:50:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:30 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 0x2847030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a747d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03640>, '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 0x2b04540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b049d0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', '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 04:50:30 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 04:50:30 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 04:50:30 INFO - Using env: {'DISPLAY': ':0', 04:50:30 INFO - 'HOME': '/home/cltbld', 04:50:30 INFO - 'LANG': 'en_US.UTF-8', 04:50:30 INFO - 'LANGUAGE': 'en_US:en', 04:50:30 INFO - 'LOGNAME': 'cltbld', 04:50:30 INFO - 'MAIL': '/var/mail/cltbld', 04:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:30 INFO - 'MOZ_NO_REMOTE': '1', 04:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:30 INFO - 'NO_EM_RESTART': '1', 04:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:30 INFO - 'SHELL': '/bin/bash', 04:50:30 INFO - 'SHLVL': '1', 04:50:30 INFO - 'TERM': 'linux', 04:50:30 INFO - 'TMOUT': '86400', 04:50:30 INFO - 'USER': 'cltbld', 04:50:30 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', 04:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:30 INFO - '_': '/tools/buildbot/bin/python'} 04:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:30 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)) 04:50:30 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)) 04:50:30 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)) 04:50:30 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)) 04:50:30 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)) 04:50:30 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)) 04:50:30 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)) 04:50:30 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)) 04:50:30 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)) 04:50:30 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)) 04:50:30 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)) 04:50:30 INFO - Cleaning up... 04:50:30 INFO - Return code: 0 04:50:30 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:30 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2847030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a747d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03640>, '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 0x2b04540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b049d0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', '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 04:50:30 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', 'jsonschema'] in /builds/slave/test-pgo/build 04:50:30 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 jsonschema 04:50:30 INFO - Using env: {'DISPLAY': ':0', 04:50:30 INFO - 'HOME': '/home/cltbld', 04:50:30 INFO - 'LANG': 'en_US.UTF-8', 04:50:30 INFO - 'LANGUAGE': 'en_US:en', 04:50:30 INFO - 'LOGNAME': 'cltbld', 04:50:30 INFO - 'MAIL': '/var/mail/cltbld', 04:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:30 INFO - 'MOZ_NO_REMOTE': '1', 04:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:30 INFO - 'NO_EM_RESTART': '1', 04:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:30 INFO - 'SHELL': '/bin/bash', 04:50:30 INFO - 'SHLVL': '1', 04:50:30 INFO - 'TERM': 'linux', 04:50:30 INFO - 'TMOUT': '86400', 04:50:30 INFO - 'USER': 'cltbld', 04:50:30 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', 04:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:30 INFO - '_': '/tools/buildbot/bin/python'} 04:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:30 INFO - Downloading/unpacking jsonschema 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:50:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:50:32 INFO - Downloading/unpacking functools32 (from jsonschema) 04:50:32 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 04:50:32 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 04:50:32 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 04:50:32 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 04:50:32 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 04:50:32 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 04:50:32 INFO - Downloading functools32-3.2.3-2.tar.gz 04:50:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:50:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:50:32 INFO - warning: no files found matching '*.txt' 04:50:32 INFO - no previously-included directories found matching 'build' 04:50:32 INFO - no previously-included directories found matching 'dist' 04:50:32 INFO - no previously-included directories found matching '.git*' 04:50:32 INFO - Installing collected packages: jsonschema, functools32 04:50:32 INFO - Running setup.py install for functools32 04:50:32 INFO - warning: no files found matching '*.txt' 04:50:32 INFO - no previously-included directories found matching 'build' 04:50:32 INFO - no previously-included directories found matching 'dist' 04:50:32 INFO - no previously-included directories found matching '.git*' 04:50:32 INFO - Successfully installed jsonschema functools32 04:50:32 INFO - Cleaning up... 04:50:32 INFO - Return code: 0 04:50:32 INFO - Running post-action listener: _resource_record_post_action 04:50:32 INFO - Running post-action listener: _start_resource_monitoring 04:50:32 INFO - Starting resource monitoring. 04:50:32 INFO - ##### 04:50:32 INFO - ##### Running install step. 04:50:32 INFO - ##### 04:50:32 INFO - Running pre-action listener: _resource_record_pre_action 04:50:32 INFO - Running main action method: install 04:50:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:50:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:50:32 INFO - Reading from file tmpfile_stdout 04:50:32 INFO - Detecting whether we're running mozinstall >=1.0... 04:50:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:50:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:50:32 INFO - Reading from file tmpfile_stdout 04:50:32 INFO - Output received: 04:50:32 INFO - Usage: mozinstall [options] installer 04:50:32 INFO - Options: 04:50:32 INFO - -h, --help show this help message and exit 04:50:32 INFO - -d DEST, --destination=DEST 04:50:32 INFO - Directory to install application into. [default: 04:50:32 INFO - "/builds/slave/test-pgo"] 04:50:32 INFO - --app=APP Application being installed. [default: firefox] 04:50:32 INFO - mkdir: /builds/slave/test-pgo/build/application 04:50:32 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'] 04:50:32 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 04:50:47 INFO - Reading from file tmpfile_stdout 04:50:47 INFO - Output received: 04:50:47 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:50:47 INFO - Running post-action listener: _resource_record_post_action 04:50:47 INFO - ##### 04:50:47 INFO - ##### Running run-tests step. 04:50:47 INFO - ##### 04:50:47 INFO - Running pre-action listener: _resource_record_pre_action 04:50:47 INFO - Running main action method: run_tests 04:50:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:50:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:50:47 INFO - Python 2.7.3 04:50:47 INFO - Return code: 0 04:50:47 INFO - grabbing minidump binary from tooltool 04:50:47 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')]} 04:50:47 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 0x2b03640>, '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 0x2b04540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b049d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:50:47 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 04:50:47 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 04:50:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:50:47 INFO - Return code: 0 04:50:47 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:50:47 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:50:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:50:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:50:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:50:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:50:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 04:50:47 INFO - Using env: {'DISPLAY': ':0', 04:50:47 INFO - 'HOME': '/home/cltbld', 04:50:47 INFO - 'LANG': 'en_US.UTF-8', 04:50:47 INFO - 'LANGUAGE': 'en_US:en', 04:50:47 INFO - 'LOGNAME': 'cltbld', 04:50:47 INFO - 'MAIL': '/var/mail/cltbld', 04:50:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:50:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:47 INFO - 'MOZ_NO_REMOTE': '1', 04:50:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:47 INFO - 'NO_EM_RESTART': '1', 04:50:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:47 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:50:47 INFO - 'SHELL': '/bin/bash', 04:50:47 INFO - 'SHLVL': '1', 04:50:47 INFO - 'TERM': 'linux', 04:50:47 INFO - 'TMOUT': '86400', 04:50:47 INFO - 'USER': 'cltbld', 04:50:47 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011', 04:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:47 INFO - '_': '/tools/buildbot/bin/python'} 04:50:47 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 04:50:47 INFO - mozversion INFO | application_buildid: 20151126034441 04:50:47 INFO - mozversion INFO | application_changeset: 414d106b2e2008ab80cbb33fa374c4d9e4f9f734 04:50:47 INFO - mozversion INFO | application_display_name: Nightly 04:50:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:50:47 INFO - mozversion INFO | application_name: Firefox 04:50:47 INFO - mozversion INFO | application_remotingname: firefox 04:50:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:50:47 INFO - mozversion INFO | application_vendor: Mozilla 04:50:47 INFO - mozversion INFO | application_version: 45.0a1 04:50:47 INFO - mozversion INFO | platform_buildid: 20151126034441 04:50:47 INFO - mozversion INFO | platform_changeset: 414d106b2e2008ab80cbb33fa374c4d9e4f9f734 04:50:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:50:47 INFO - mozversion INFO | platform_version: 45.0a1 04:50:47 INFO - 2015-11-26 04:50:47,838 DEBUG : using testdate: 1448542247 04:50:47 INFO - 2015-11-26 04:50:47,838 DEBUG : actual date: 1448542247 04:50:47 INFO - 2015-11-26 04:50:47,847 INFO : starting webserver on 'localhost:40681' 04:50:47 INFO - 2015-11-26 04:50:47,848 INFO : Starting test suite talos-linux64-ix-033 04:50:47 INFO - 2015-11-26 04:50:47,848 INFO : Starting test dromaeo_css 04:50:47 INFO - 2015-11-26 04:50:47,848 DEBUG : operating with platform_type : linux_ 04:50:47 INFO - 2015-11-26 04:50:47,849 INFO : Initialising browser for dromaeo_css test... 04:50:47 INFO - 2015-11-26 04:50:47,863 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwyknxg/profile http://localhost:40681/getInfo.html 04:50:52 INFO - 2015-11-26 04:50:52,931 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:50:52 INFO - 2015-11-26 04:50:52,931 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:50:52 INFO - 2015-11-26 04:50:52,931 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:50:52 INFO - 2015-11-26 04:50:52,932 DEBUG : BROWSER_OUTPUT: __metrics 04:50:53 INFO - 2015-11-26 04:50:53,034 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:54 INFO - 2015-11-26 04:50:54,784 INFO : Browser initialized. 04:50:54 INFO - 2015-11-26 04:50:54,784 INFO : Running cycle 1/1 for dromaeo_css test... 04:50:54 INFO - 2015-11-26 04:50:54,785 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwyknxg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:51:06 INFO - 2015-11-26 04:51:06,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 138612736 04:51:06 INFO - 2015-11-26 04:51:06,553 DEBUG : BROWSER_OUTPUT: 04:51:57 INFO - 2015-11-26 04:51:57,291 DEBUG : BROWSER_OUTPUT: 1448542317287 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] 04:54:07 INFO - 2015-11-26 04:54:07,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40681/tests/dromaeo/cssquery-ext.html) 04:54:08 INFO - 2015-11-26 04:54:08,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 273080320 04:54:08 INFO - 2015-11-26 04:54:08,616 DEBUG : BROWSER_OUTPUT: 04:57:11 INFO - 2015-11-26 04:57:11,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/dromaeo/cssquery-ext.html (next: http://localhost:40681/tests/dromaeo/cssquery-jquery.html) 04:57:11 INFO - 2015-11-26 04:57:11,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 221188096 04:57:11 INFO - 2015-11-26 04:57:11,738 DEBUG : BROWSER_OUTPUT: 05:00:13 INFO - 2015-11-26 05:00:13,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40681/tests/dromaeo/cssquery-mootools.html) 05:00:14 INFO - 2015-11-26 05:00:14,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 215752704 05:00:14 INFO - 2015-11-26 05:00:14,182 DEBUG : BROWSER_OUTPUT: 05:03:15 INFO - 2015-11-26 05:03:15,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40681/tests/dromaeo/cssquery-prototype.html) 05:03:16 INFO - 2015-11-26 05:03:16,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 200491008 05:03:16 INFO - 2015-11-26 05:03:16,548 DEBUG : BROWSER_OUTPUT: 05:06:18 INFO - 2015-11-26 05:06:18,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40681/tests/dromaeo/cssquery-yui.html) 05:06:19 INFO - 2015-11-26 05:06:19,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 202047488 05:06:19 INFO - 2015-11-26 05:06:19,506 DEBUG : BROWSER_OUTPUT: 05:09:21 INFO - 2015-11-26 05:09:21,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/dromaeo/cssquery-yui.html (next: http://localhost:40681/tests/dromaeo/cssquery-dojo.html) 05:09:22 INFO - 2015-11-26 05:09:22,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 248582144 05:09:22 INFO - 2015-11-26 05:09:22,203 DEBUG : BROWSER_OUTPUT: 05:09:22 INFO - 2015-11-26 05:09:22,204 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:09:22 INFO - 2015-11-26 05:09:22,204 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:09:22 INFO - 2015-11-26 05:09:22,204 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:09:22 INFO - 2015-11-26 05:09:22,205 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:09:22 INFO - 2015-11-26 05:09:22,206 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3188.601424821897;3271.8364081795903;3318.7676862619596;3322.318924620453;3333.9333213335735;5317.9202311965255;5437.13005919053;5461.208124821898;5481.890362192758;5525.668459892404;5405.81079662211;5433.945660543393;5467.753951072202;5470.972645136779;5535.280413546233;4942.703437793726;4967.627427942901;4997.575206107485;5027.597792176635;5062.114130027249;4825.300331451955;5048.621353398491;5077.187649976005;5099.617528685345;5146.3824341078935;4845.27320901864;4907.901841963158;4959;4980.501949805027;4983.750812459362;4963.677360971526;4986;5014.648974571782;5022.924656130161;5047.116754567973;4780.163471392492;4872.439669438025;4974.751262436864;4993.300937868701;5014.52362025607;5309.548688361494;5369.301990741218;5391.379991301012;5396.271503347037;5405.27028851104;5931.139984702238;5933.228680271537;5945.64326140433;5951.107333899907;5961.493273071794;5709.8287051388525;5879.706014699291;5917.289925208959;5959.344472108065;5990.610610310359;5498.45015498447;5523.917141242925;5524.1989911462615;5531.25328080708;5589.888202235973;5965.850853728604;5981.6710080945095;5982.282126144891;5987.042073268256;5994.910076348859;5692.686902220417;5709.857253568694;5783.797567085132;5813.069908814569;5824.359320474744;5871.266091738533;5898.941010589925;5903.144044113666;5909.527237820964;5910.231669882888;5832.329282132524;5837.620554663933;5876.7355469004;5885.499732522698;5897.764089436375;5718.542516598662;5837.824865254049;5877.4122587740885;5877.588568800143;5883.646981181143;4452.443444569429;4521.095780843844;4527.637788976874;4547.454305483363;4562.224421848294;4056.3915412687743;4062.106336605942;4065.1463192729857;4088.509378874495;4102.179564087194;5390.51485366319;5489.780408783684;5627.324721033502;5634.183043458757;5635.070213414822;5780.624259423208;5783.595148339576;5868.735906884115;5887.4701276884425;5907.852303692356;5611.98984182851;5634.070378387521;5662.235598194191;5663.943360566342;5665.830025099253;4942.9258561121615;5121.564667003272;5170.508801663836;5182.093133701663;5189.818356357509;6046.183765191643;6116.76924458105;6120.548409105651;6120.657843557623;6128.1698938163645;5901.380355062656;5949.702514874152;5953.047512397996;5954.672493012753;5986.521078313637;5859.296884373903;6001;6009.849753756016;6216;6216.285127210248;5593.272874526286;5737.5983681141915;5738.8278351649515;5741.052726300114;5791.449812267828;5841.269841269841;5889.322727886177;5896.823095307148;5916.792912248223;5931.377205393372;5620.4660557247;5726.914096288476;5734.3978882218435;5777.04678728022;5780;5752.9137062943255;5774.307083150049;5799.94200057994;5800.7099645018425;5853.590248682552;5625.184348269396;5652.886942261214;5653.660780353192;5656.971715141398;5658.377578466448;5732.942670573241;5748.252727145445;5787.884242315046;5822.534197264124;5848.385919478394;5471.261379713687;5529.115341545334;5591.916121258103;5616.354119276336;5655.1517272409465 05:09:22 INFO - 2015-11-26 05:09:22,206 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.7750022490779;594.586762200271;597.8953683105457;604.7067172421376;626.2422468812737;37268.25463490729;37706.43440348397;37774.62225377745;37794.62205377945;37848.43227351585;42654;43450.34824477635;43495.13009739811;43522.12955740891;43595.56404435963;7472;7640.5797681127515;7650.961745191266;8696.695615653454;8870.201681848632;10466.68599942003;10755.56977720894;10763.892361076407;10773.353598784099;10775.892241077607;10405.375677459338;10496.68509944703;10502.212334074937;10509.894901050968;10521.368717876952;7635.923640763577;7769.611519424063;7772.834074888756;10403.167746580293;10471.68584942453;10178;10372.79254414915;10379.377237365783;10380.429076400795;10382.169426445942;39819;39919.20161596752;40301.79849100765;40373;40380.798096009625;3170.524421336795;3303.8678452861855;3377.324535092991;4021.735885110318;4083.2650122977852;30116.54825177624;30212.54681179784;30229;30363.544546831814;30460.390792184033;3918.2163567286657;3946.2699400610977;3952;4076.9592304076878;4123.402106694512;271486;271780;272008.5598288043;272091;272386;57759.71120144372;57870;57883.131753023736;57892.13161802576;57980;52276;53478;65288.34711652918;66737.66631166813;66744.6662766683;15758.606034848992;15865.20673966297;15921.12433816128;15971.121588312755;15976.440824571084;11211.831822522505;11255;11271.436428178558;11274.267172633752;11569.363684997237;19429.708554371697;19786.60426791485;19812.60374792496;19817.20731170737;19856.90071549633;7593.202713715091;7643.694252229849;7725.8454830903065;7733.4973226740085;7800.336971357385;875.444093000949;910.7677542226689;918.536139249688;994.145367689775;1013.7516308504316;28496.862735294937;28693.28266793347;28783.856080719463;28972.855135724185;29263.707362926525;995.0546980368679;996.3025881882711;1072.7639919217759;1113.8663360396804;1145.1926391893694;14952.537150240998;15011.174385408907;15036;15054.32255548481;15129.848701512845;327128;331617;332532;333210;333949;44199.77900110479;44988;53312.73343633334;53612;55022.44977550254;1321.2732996851694;1324.8476425211225;1327.82074419954;1329.6875234319928;1349.1837438349658;28066;28215.858920705265;28965.565516516846;29152.27119322034;29348;41276;42372.36441453319;52661;53033.20450193327;53388.19917701315;256798;263016;263897;265143;265235;42718.35922461228;43516.347254791835;43928.56071439245;43933;44318.556814431446;46935.29597056115;47039.29441058455;47216.527834721215;48097.519024809306;48252.758736206095;39331.21337573175;39909.2018159641;43011.56988430201;43317.8439586455;44592;40283.3249188971;41660;41684.37473437961;42268.36597451102;43194;39201.6079839198;39387.60612393839;40048.39927401033;40074.59925400709;41749.79125104355;33685.49471757975;33882.98351049473;36600;37296.81351593225;37389.25221495609;26595;27176.1847144586;27377.452450951267;27410.453198135965;27526.449471010867 05:09:22 INFO - 2015-11-26 05:09:22,208 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.9521267022616;344.6742828027515;353.87437459701806;355.9608443071262;356.33543441481635;13782.241976691303;14125.71748565028;16629.58426039348;17057.82942170578;18081.7287740684;16065.116418596972;16199.91900040501;16373.672526549462;16470.67058658826;16487.752683709725;4605.838795642145;4779.187538118511;4779.378680771495;4783.880402989918;4793.90412191756;3794.298054859846;3893.922121557567;4763.4998325175875;5377.274068000828;5485.259489968863;5425.9728701356435;5458.344998600173;5460.699661518614;5477;5487.176923461493;5343;5921.171036054956;5939.55453340999;5942.435468630473;5944.613600115978;5262.315898933152;5283.101872681654;5287.312649355597;5292.629515933886;5293.920591191135;12853.614391568268;13165.539206127836;19134.904325478423;20066.799332006638;20068.799312006984;1922.4289989496017;1972.674508706076;1996.670549359354;2026.412340421276;2165.6968024476587;9390.5304734763;9571.760705982337;9763.951180244125;11033.337999720043;13069.346532673328;1724.7499112628725;1775.7336399540043;1842.3643842874321;1846.7229915512646;1899.3162461513843;59442.702786486225;59502.10746838801;60067.69966150185;62368.37631623671;62376.37623623751;9763;10024.599016039278;10054.69835904924;10056.748581285527;10070.395776253448;13289.269090199938;13293.534726284533;13297.867021329663;13302.201867887958;13303.534376296782;7512.849743005109;7530.924690753022;7563;7657.885131723028;7789.922100778919;7398.741044063539;7560.130584982688;7566.35685966699;7589.203133670995;7652.540847549165;4348.326009468537;4354.760488173181;4385.3641222022625;4405.801738921757;4416.381706561084;1706.215141035113;1744.624905645267;1753.7720096387388;1754.3247246089284;1787.7407775872425;835.5571547079936;872.358816270041;919.0625561926931;920.4339331311329;962.9888616952312;13201.60395188146;15357;15782.368705251662;15923.920380398024;15927.203639817963;879.3844308983737;893.7988952485639;909.2862103248918;929.7117893453051;990.4750482244422;9412.95293523528;10134.695959121238;10219;10232.130268927076;10286.845697314546;513816;522330;523352.6826561052;533706;536356;77165.61417192878;78946.21053789389;79233;79729;80134;1139.2537887683416;1154.6478324111226;1156.8206927926185;1160.715624671944;1166.2535976974743;14985.625359366102;15024.774628380364;15126.243687815786;15361.308741106453;15612.765808512655;34188.264669163545;34525.827370862986;34953;35381.46927796137;35565.28869422649;46771.76614116908;47062.05875882395;47521.52478475171;48156.27765583589;50508.747456262485;9065;9467.147956683932;9583.329166958247;9584.137427631547;9590;11092.556297748;14058.789118163031;16601.667966640358;16839.579010524834;17179;13679.94800779891;13879.722405552035;13918.304084795518;14155.858441415454;14301.356438960063;13447.327633618475;13766.724665506434;13814.447422103003;13889.097208681404;13918.51285205013;11134.665960021212;14267.571972840831;14628.561143165296;14794.926025370234;15343.539693809204;9365.719028429157;9377.718668439958;9481.525923703924;9489.95255023748;9503.19222866064;13946.58160255194;14001.5099471518;14111.858881411055;14116.858831411555;14257 05:09:22 INFO - 2015-11-26 05:09:22,209 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1316.1773891317926;1463.590194745471;1496.1546726099753;1634.7384418493043;1767.1076106566181;6354.332795056522;7210.098737657793;7406.259374062598;7409.073865766779;7411.703531858732;7116.074910261672;7267.636618169084;7288.854222915538;7293.854122917552;7316.817079573013;1985.4540001499558;2027.9290224842134;2179.2372669565684;2226.142934970036;2237.2281562860785;2240.4622890506325;2242.5963326601204;2247.910083596654;2249.156566287642;2250.493638931244;2173.282816670495;2218.9334319970426;2218.977810221901;2221.855579387343;2224.744154422238;1921.8750781199178;1949.1521188283143;2179.8365122615787;2212.7897849704254;2215.999999999984;2195.4182141732454;2209.5359974405396;2210.635245184543;2230.866148031107;2253;7180.425565954711;7258.346748792581;7267.091613548307;7275.454340924399;7282.417406607458;4493.550644935481;4558.817647294104;4576.633869290449;4598.2642777155825;4599.264117741179;2870.669872964615;2872.439874224527;2903.3177203357195;2914.5628155776803;2992.685767994351;929.5166513413055;946.9573869175834;950.6720181537358;960.2558017536395;977.9217662586976;9836.409815411098;9842.704718858446;9846.458444785534;9850.064243896819;9855.90144098557;4019.3569028955226;4075.083106301118;4126.09225970286;4129.525104612948;4134.131832315247;8544.61549230286;8550.315974722007;8574.871376929352;8592.312614990911;8593.871091933626;4572.81708731647;4593.563611456906;4599.425071866017;4600.3099535070005;4603.838865639686;4150.439690641785;4196.853110141131;4204.2432362175105;4205.705600607928;4207.137536804948;3537.964620353815;3572.6427357264065;3586.605473397924;3592.1199306170156;3600.4419315006216;1138.0497284767146;1146.2205700123995;1155.9364234967159;1175.5239128153112;1196.8803119688137;915.949622770754;923.0492592629603;923.7690577355661;958.7890664053897;1320.7886738122047;6850.862982740417;6870.416014638811;6943.6875340609795;6945.51381403307;6950.687219075154;501.15555289337584;506.4454422407458;508.0372693745332;510.5736709847319;511.33015749368445;5450.836474905759;5605.467480589337;5641.689707066069;5660.29246344207;5661.207430959669;8211.384146189059;8309.792255193668;8334.62494187751;8360.874586881202;8369.748907532783;8225.300849427866;8488.660453581911;8502.74491765248;8506.064332923374;8510.82978340442;6747.561408508432;6796.592204467748;6819.488538359643;6841.863162736718;6847.452203823583;6425.742970281136;6463.7737679181;6487.351264873475;6500.869982600227;6505.544611877123;7567.735129270449;7674.462787604814;7872.448928575174;7897.447178697436;7923.168067352845;7769.184235655175;7880.211978802074;7884.147225402141;7884.4086693497065;7892.802679933047;6639.966800165968;6644.235912869888;6736.831579210559;6743.325667433218;6752.561083529555;7036.19083805369;7074;7102.573845569075;7132.179799322937;7134.108236470442;6527.445167160845;6685.598864068172;6743.797686069426;6855.725770969106;6857.862842743217;5621.718914054362;6535.117759102651;6663.566868153554;6711.194656641234;6788.355106264897;6756.425703815231;6806.965965170142;6861.245263020964;6871.931280687129;6884.965575172092;6234.532410069353;6241.032639940817;6246.031865060922;6246.3753624637175;6265.686715664289;6139.26328840542;6179.969100154471;6209.813705588839;6210.285817131088;6216.44052035319 05:09:22 INFO - 2015-11-26 05:09:22,209 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.6117974890884;320.8604257148141;322.1316365082521;329.82519264789653;330.8610383638871;5856.267966504187;5857.297124345079;5869.677167755772;5945.8216253512355;5976.641401515912;5658.264425624673;5726.141078838176;5794.82615521535;5866.706664666771;5874.206982057421;4522.3668686383935;4525.321201819737;4545;4553.225951588238;4566.84016059438;4351.912961740763;4564.589186973171;4565.634749220055;4575.977120114395;4578.908421831561;4373.169097871394;4392.3631073494325;4444.866654000385;4447.911041779163;4459.732416055047;4461.7322960622305;4485.9551404485865;4488.281874900017;4499.820007199708;4500.032493014018;3945.6251656092627;3950.3679411294343;3952.3083460394314;3957.2679054375035;3968.8809335719975;5487.396386397493;5595.804146854841;5597.496225339698;5599.636023658449;5606.439356064402;5198.376194856603;5213.5829133669595;5216.843494695166;5219.42586315505;5226.686398816083;6220.533459990519;6227.813165605039;6231.189945307126;6231.563790534665;6233.625982441068;4341.348797680342;4357.085012147453;4358.0412309291905;4365.061511774984;4365.257906155961;6345.206849143857;6506.804795856132;6511.34886511345;6511.837204069889;6523.086767852505;4562.315652652129;4566.406367172246;4569.063342014879;4571.451425828922;4572.725636461823;4617.053504031665;4619.030003699261;4623.976880115578;4624.838130665411;4628.074385122922;5278.996990571779;5281.656692314988;5290.444503327095;5292.02097611943;5292.100342941709;6182.196314479089;6233.657148856856;6274.623522588659;6304.432601065926;6309.463695585927;1578.3213218316234;1593.0362130910864;1596.6008497875532;1597.209381356236;1597.4249270262696;1070.277562645227;1072.5816931396762;1072.6192201768415;1086.2070688397514;1093.0763504838399;6098.939010609926;6100.908486372708;6107.114468402056;6115.816525504242;6142.324344322121;6488.31872653374;6492.740290388331;6493.285738568754;6493.740250389931;6497.18785151856;5880.8235752927485;5947.9702601486715;6091.086337049478;6134.2332208473945;6164.876702466016;3503.474478828145;3521.401361768454;3524.9118772030906;3525.8060806655367;3531.3290474809705;6805.489588280899;6805.863882722318;6813;6814.284500127515;6818.897716534256;6511.38141876521;6673.666316684146;6686.832829179212;6687.465002799764;6688.063671086052;6796.52424330302;6797.66011699423;6799.524033317621;6812.4550035997;6821.249662537216;6522.21733391996;6524.1192439022025;6524.804255872332;6526.738930442729;6547.083408322934;6212.596181248205;6429.871402571829;6466.773662921775;6469.902951455826;6473.546851720523;6812.625305608239;6818.693158807766;6822.897656535255;6823.420009299067;6830.863382732218;4347.5652434756275;4376.781160942004;4378.846740364072;4381.6275616571675;4386.429764130643;6275.803468785888;6497.545171837926;6526.804195874131;6542;6542.803715888531;6371.23545174582;6375.872482550416;6378.585391949508;6379.4896408286295;6383.9361606383345;6322.557420980671;6364.427201551883;6374.458171055512;6377.4579160771855;6388.105665206967;6086.756529738938;6224.439800417984;6232.657203853832;6238.313785483684;6255.437010669061;6391.488680905423;6396.008618664115;6399.296077431572;6403.51973601991;6404.359564043559;6241.188645476059;6245.188125543832;6246.437820596168;6249.187605611241;6253.874922501615 05:09:22 INFO - 2015-11-26 05:09:22,213 DEBUG : BROWSER_OUTPUT: |5;yui.html;759.3431681595415;789.0767801672044;796.1441450440774;813.2477458351027;824.5753436979954;12679.619611411661;12903.096783225177;13104.672383190426;13110.541131060403;13178.406971686272;12303.876961230386;12314;13075.346232688375;13092.803607945889;13093.67265818355;691.5228492340269;696.6899729620295;820.3970081989733;837.8785076163983;837.9622916968751;824.7773101262655;826.7519744076783;833.8749187621845;834.0741776627938;835;872.3762509805488;874.4097734029536;874.5845723281454;875.5009644502636;879.278991227194;707.056080133023;717.4977515739004;858.6393714639867;866.618687777376;874.2699845628875;638.9808305750835;639.48840927258;639.9584027038228;641.9807405777834;644.3427703742203;12886.87113128866;13095.410706518229;13106.541271055563;13129.73740525184;13137;12065.819012714815;12230.877691223062;12389.566365177267;12474.875251247462;12924.159929604546;9750.707478775648;9911.752206194902;9930;10085.243606729451;10099.495025248709;3554.502369668223;3645.5260816094005;3648.8358023888723;3658.634136586347;3673.0633688409284;47786.522134778555;48449.78875528105;48794.75602621964;49702.254466183396;49730.7513462434;9244.210578569913;9774.26692998028;9984.750381240527;9989.700308990741;10007.49962501872;19028.904855475634;19092.71360929587;19103;19135.425937221906;19137.23451061942;7523.247675232543;7586.431017673586;7711.267429594292;7747.535147891144;7809.54367355451;3897.0841852164717;3943.171933893857;4022.0950286185375;4034.677225821927;4122.91754164915;3036.134701610075;3068.6931306869583;3073.4006868660845;3079.9538006929915;3084.151858238957;519.08640792206;538.9164679474687;543.7743336515381;552.34822908967;552.5966044787248;608.8112685067643;649.5518092516148;665.6172700697118;669.7521916890685;679.864027194563;8361.916380836235;8531.10423405546;8556.40105192643;8689.56552172389;8804.603792829337;468.9109069276827;615.0391478876113;650.8405440667067;663.3697986912453;686.4919959230134;3991.560928297885;4026.214888096793;4144.191882582867;4221.2401767681495;4311.827526898952;57893.42106578965;57945.420545794004;58688.413115868294;58775.11837322444;59326.40673593295;53400;53465.79205247697;53790;53938.73030634822;54091;46327.30509042367;46425.535744642795;46657.53342466532;46966.765166174635;47334.52665473301;8314.501129932223;8444.535550544779;8451.711600739049;8534.82930341402;8539.786505337168;33582;34679.479807802396;34905;35373.64626353807;37486.2502749938;45225.54774452213;45251.321230182235;45742.771286143354;46069.30896036629;46186.769066154455;10212.591496340063;10493.790124197321;10934.234603577992;11378.260413073123;11521.711957201138;12476.937615311865;12484.375781211085;12556.37218139071;12684.437518301227;13100.148490348098;10616.946915265684;10631.734206644587;10667.065808511761;10833.512491937725;11263.529259127765;11318.490667920129;11392.715182120513;11775.76448471043;11810.40947952616;11909.22590031645;11570.305781653127;11605.883941160819;11866.228695134789;12240.449179787109;12244.693882653006;9153.862692059758;9379.390339627902;9714.591384249103;10055.296129271173;10194.949025255122;8910.688125915822;9451.338406311492;9576.042395760369;9602.66390676323;9627.133557979816 05:09:22 INFO - 2015-11-26 05:09:22,213 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:09:22 INFO - 2015-11-26 05:09:22,213 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:09:22 INFO - 2015-11-26 05:09:22,213 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1062 05:09:22 INFO - 2015-11-26 05:09:22,213 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:09:22 INFO - 2015-11-26 05:09:22,214 DEBUG : BROWSER_OUTPUT: __startTimestamp1448543362203__endTimestamp 05:09:22 INFO - 2015-11-26 05:09:22,214 DEBUG : BROWSER_OUTPUT: 05:09:22 INFO - 2015-11-26 05:09:22,214 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:09:22 INFO - 2015-11-26 05:09:22,214 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:09:22 INFO - 2015-11-26 05:09:22,214 DEBUG : BROWSER_OUTPUT: 05:09:22 INFO - 2015-11-26 05:09:22,214 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5461.52 Median:5656.97 stddev:605.17 (10.7%) stddev-sans-first:580.16 05:09:22 INFO - 2015-11-26 05:09:22,215 DEBUG : BROWSER_OUTPUT: Values: 3188.6 3271.8 3318.8 3322.3 3333.9 5317.9 5437.1 5461.2 5481.9 5525.7 5405.8 5433.9 5467.8 5471.0 5535.3 4942.7 4967.6 4997.6 5027.6 5062.1 4825.3 5048.6 5077.2 5099.6 5146.4 4845.3 4907.9 4959.0 4980.5 4983.8 4963.7 4986.0 5014.6 5022.9 5047.1 4780.2 4872.4 4974.8 4993.3 5014.5 5309.5 5369.3 5391.4 5396.3 5405.3 5931.1 5933.2 5945.6 5951.1 5961.5 5709.8 5879.7 5917.3 5959.3 5990.6 5498.5 5523.9 5524.2 5531.3 5589.9 5965.9 5981.7 5982.3 5987.0 5994.9 5692.7 5709.9 5783.8 5813.1 5824.4 5871.3 5898.9 5903.1 5909.5 5910.2 5832.3 5837.6 5876.7 5885.5 5897.8 5718.5 5837.8 5877.4 5877.6 5883.6 4452.4 4521.1 4527.6 4547.5 4562.2 4056.4 4062.1 4065.1 4088.5 4102.2 5390.5 5489.8 5627.3 5634.2 5635.1 5780.6 5783.6 5868.7 5887.5 5907.9 5612.0 5634.1 5662.2 5663.9 5665.8 4942.9 5121.6 5170.5 5182.1 5189.8 6046.2 6116.8 6120.5 6120.7 6128.2 5901.4 5949.7 5953.0 5954.7 5986.5 5859.3 6001.0 6009.8 6216.0 6216.3 5593.3 5737.6 5738.8 5741.1 5791.4 5841.3 5889.3 5896.8 5916.8 5931.4 5620.5 5726.9 5734.4 5777.0 5780.0 5752.9 5774.3 5799.9 5800.7 5853.6 5625.2 5652.9 5653.7 5657.0 5658.4 5732.9 5748.3 5787.9 5822.5 5848.4 5471.3 5529.1 5591.9 5616.4 5655.2 05:09:22 INFO - 2015-11-26 05:09:22,215 DEBUG : BROWSER_OUTPUT: 05:09:22 INFO - 2015-11-26 05:09:22,215 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47244.70 Median:37740.53 stddev:75692.67 (200.6%) stddev-sans-first:75823.80 05:09:22 INFO - 2015-11-26 05:09:22,216 DEBUG : BROWSER_OUTPUT: Values: 548.8 594.6 597.9 604.7 626.2 37268.3 37706.4 37774.6 37794.6 37848.4 42654.0 43450.3 43495.1 43522.1 43595.6 7472.0 7640.6 7651.0 8696.7 8870.2 10466.7 10755.6 10763.9 10773.4 10775.9 10405.4 10496.7 10502.2 10509.9 10521.4 7635.9 7769.6 7772.8 10403.2 10471.7 10178.0 10372.8 10379.4 10380.4 10382.2 39819.0 39919.2 40301.8 40373.0 40380.8 3170.5 3303.9 3377.3 4021.7 4083.3 30116.5 30212.5 30229.0 30363.5 30460.4 3918.2 3946.3 3952.0 4077.0 4123.4 271486.0 271780.0 272008.6 272091.0 272386.0 57759.7 57870.0 57883.1 57892.1 57980.0 52276.0 53478.0 65288.3 66737.7 66744.7 15758.6 15865.2 15921.1 15971.1 15976.4 11211.8 11255.0 11271.4 11274.3 11569.4 19429.7 19786.6 19812.6 19817.2 19856.9 7593.2 7643.7 7725.8 7733.5 7800.3 875.4 910.8 918.5 994.1 1013.8 28496.9 28693.3 28783.9 28972.9 29263.7 995.1 996.3 1072.8 1113.9 1145.2 14952.5 15011.2 15036.0 15054.3 15129.8 327128.0 331617.0 332532.0 333210.0 333949.0 44199.8 44988.0 53312.7 53612.0 55022.4 1321.3 1324.8 1327.8 1329.7 1349.2 28066.0 28215.9 28965.6 29152.3 29348.0 41276.0 42372.4 52661.0 53033.2 53388.2 256798.0 263016.0 263897.0 265143.0 265235.0 42718.4 43516.3 43928.6 43933.0 44318.6 46935.3 47039.3 47216.5 48097.5 48252.8 39331.2 39909.2 43011.6 43317.8 44592.0 40283.3 41660.0 41684.4 42268.4 43194.0 39201.6 39387.6 40048.4 40074.6 41749.8 33685.5 33883.0 36600.0 37296.8 37389.3 26595.0 27176.2 27377.5 27410.5 27526.4 05:09:22 INFO - 2015-11-26 05:09:22,216 DEBUG : BROWSER_OUTPUT: 05:09:22 INFO - 2015-11-26 05:09:22,217 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28241.23 Median:17867.67 stddev:85982.32 (481.2%) stddev-sans-first:86198.00 05:09:22 INFO - 2015-11-26 05:09:22,217 DEBUG : BROWSER_OUTPUT: Values: 342.0 344.7 353.9 356.0 356.3 13782.2 14125.7 16629.6 17057.8 18081.7 16065.1 16199.9 16373.7 16470.7 16487.8 4605.8 4779.2 4779.4 4783.9 4793.9 3794.3 3893.9 4763.5 5377.3 5485.3 5426.0 5458.3 5460.7 5477.0 5487.2 5343.0 5921.2 5939.6 5942.4 5944.6 5262.3 5283.1 5287.3 5292.6 5293.9 12853.6 13165.5 19134.9 20066.8 20068.8 1922.4 1972.7 1996.7 2026.4 2165.7 9390.5 9571.8 9764.0 11033.3 13069.3 1724.7 1775.7 1842.4 1846.7 1899.3 59442.7 59502.1 60067.7 62368.4 62376.4 9763.0 10024.6 10054.7 10056.7 10070.4 13289.3 13293.5 13297.9 13302.2 13303.5 7512.8 7530.9 7563.0 7657.9 7789.9 7398.7 7560.1 7566.4 7589.2 7652.5 4348.3 4354.8 4385.4 4405.8 4416.4 1706.2 1744.6 1753.8 1754.3 1787.7 835.6 872.4 919.1 920.4 963.0 13201.6 15357.0 15782.4 15923.9 15927.2 879.4 893.8 909.3 929.7 990.5 9413.0 10134.7 10219.0 10232.1 10286.8 513816.0 522330.0 523352.7 533706.0 536356.0 77165.6 78946.2 79233.0 79729.0 80134.0 1139.3 1154.6 1156.8 1160.7 1166.3 14985.6 15024.8 15126.2 15361.3 15612.8 34188.3 34525.8 34953.0 35381.5 35565.3 46771.8 47062.1 47521.5 48156.3 50508.7 9065.0 9467.1 9583.3 9584.1 9590.0 11092.6 14058.8 16601.7 16839.6 17179.0 13679.9 13879.7 13918.3 14155.9 14301.4 13447.3 13766.7 13814.4 13889.1 13918.5 11134.7 14267.6 14628.6 14794.9 15343.5 9365.7 9377.7 9481.5 9490.0 9503.2 13946.6 14001.5 14111.9 14116.9 14257.0 05:09:22 INFO - 2015-11-26 05:09:22,217 DEBUG : BROWSER_OUTPUT: 05:09:22 INFO - 2015-11-26 05:09:22,218 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5127.30 Median:6494.11 stddev:2617.57 (40.3%) stddev-sans-first:2609.24 05:09:22 INFO - 2015-11-26 05:09:22,219 DEBUG : BROWSER_OUTPUT: Values: 1316.2 1463.6 1496.2 1634.7 1767.1 6354.3 7210.1 7406.3 7409.1 7411.7 7116.1 7267.6 7288.9 7293.9 7316.8 1985.5 2027.9 2179.2 2226.1 2237.2 2240.5 2242.6 2247.9 2249.2 2250.5 2173.3 2218.9 2219.0 2221.9 2224.7 1921.9 1949.2 2179.8 2212.8 2216.0 2195.4 2209.5 2210.6 2230.9 2253.0 7180.4 7258.3 7267.1 7275.5 7282.4 4493.6 4558.8 4576.6 4598.3 4599.3 2870.7 2872.4 2903.3 2914.6 2992.7 929.5 947.0 950.7 960.3 977.9 9836.4 9842.7 9846.5 9850.1 9855.9 4019.4 4075.1 4126.1 4129.5 4134.1 8544.6 8550.3 8574.9 8592.3 8593.9 4572.8 4593.6 4599.4 4600.3 4603.8 4150.4 4196.9 4204.2 4205.7 4207.1 3538.0 3572.6 3586.6 3592.1 3600.4 1138.0 1146.2 1155.9 1175.5 1196.9 915.9 923.0 923.8 958.8 1320.8 6850.9 6870.4 6943.7 6945.5 6950.7 501.2 506.4 508.0 510.6 511.3 5450.8 5605.5 5641.7 5660.3 5661.2 8211.4 8309.8 8334.6 8360.9 8369.7 8225.3 8488.7 8502.7 8506.1 8510.8 6747.6 6796.6 6819.5 6841.9 6847.5 6425.7 6463.8 6487.4 6500.9 6505.5 7567.7 7674.5 7872.4 7897.4 7923.2 7769.2 7880.2 7884.1 7884.4 7892.8 6640.0 6644.2 6736.8 6743.3 6752.6 7036.2 7074.0 7102.6 7132.2 7134.1 6527.4 6685.6 6743.8 6855.7 6857.9 5621.7 6535.1 6663.6 6711.2 6788.4 6756.4 6807.0 6861.2 6871.9 6885.0 6234.5 6241.0 6246.0 6246.4 6265.7 6139.3 6180.0 6209.8 6210.3 6216.4 05:09:22 INFO - 2015-11-26 05:09:22,219 DEBUG : BROWSER_OUTPUT: 05:09:22 INFO - 2015-11-26 05:09:22,219 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5273.90 Median:5962.31 stddev:1596.26 (26.8%) stddev-sans-first:1556.75 05:09:22 INFO - 2015-11-26 05:09:22,219 DEBUG : BROWSER_OUTPUT: Values: 315.6 320.9 322.1 329.8 330.9 5856.3 5857.3 5869.7 5945.8 5976.6 5658.3 5726.1 5794.8 5866.7 5874.2 4522.4 4525.3 4545.0 4553.2 4566.8 4351.9 4564.6 4565.6 4576.0 4578.9 4373.2 4392.4 4444.9 4447.9 4459.7 4461.7 4486.0 4488.3 4499.8 4500.0 3945.6 3950.4 3952.3 3957.3 3968.9 5487.4 5595.8 5597.5 5599.6 5606.4 5198.4 5213.6 5216.8 5219.4 5226.7 6220.5 6227.8 6231.2 6231.6 6233.6 4341.3 4357.1 4358.0 4365.1 4365.3 6345.2 6506.8 6511.3 6511.8 6523.1 4562.3 4566.4 4569.1 4571.5 4572.7 4617.1 4619.0 4624.0 4624.8 4628.1 5279.0 5281.7 5290.4 5292.0 5292.1 6182.2 6233.7 6274.6 6304.4 6309.5 1578.3 1593.0 1596.6 1597.2 1597.4 1070.3 1072.6 1072.6 1086.2 1093.1 6098.9 6100.9 6107.1 6115.8 6142.3 6488.3 6492.7 6493.3 6493.7 6497.2 5880.8 5948.0 6091.1 6134.2 6164.9 3503.5 3521.4 3524.9 3525.8 3531.3 6805.5 6805.9 6813.0 6814.3 6818.9 6511.4 6673.7 6686.8 6687.5 6688.1 6796.5 6797.7 6799.5 6812.5 6821.2 6522.2 6524.1 6524.8 6526.7 6547.1 6212.6 6429.9 6466.8 6469.9 6473.5 6812.6 6818.7 6822.9 6823.4 6830.9 4347.6 4376.8 4378.8 4381.6 4386.4 6275.8 6497.5 6526.8 6542.0 6542.8 6371.2 6375.9 6378.6 6379.5 6383.9 6322.6 6364.4 6374.5 6377.5 6388.1 6086.8 6224.4 6232.7 6238.3 6255.4 6391.5 6396.0 6399.3 6403.5 6404.4 6241.2 6245.2 6246.4 6249.2 6253.9 05:09:22 INFO - 2015-11-26 05:09:22,219 DEBUG : BROWSER_OUTPUT: 05:09:22 INFO - 2015-11-26 05:09:22,219 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13946.42 Median:47560.52 stddev:16337.87 (34.4%) stddev-sans-first:16353.69 05:09:22 INFO - 2015-11-26 05:09:22,221 DEBUG : BROWSER_OUTPUT: Values: 759.3 789.1 796.1 813.2 824.6 12679.6 12903.1 13104.7 13110.5 13178.4 12303.9 12314.0 13075.3 13092.8 13093.7 691.5 696.7 820.4 837.9 838.0 824.8 826.8 833.9 834.1 835.0 872.4 874.4 874.6 875.5 879.3 707.1 717.5 858.6 866.6 874.3 639.0 639.5 640.0 642.0 644.3 12886.9 13095.4 13106.5 13129.7 13137.0 12065.8 12230.9 12389.6 12474.9 12924.2 9750.7 9911.8 9930.0 10085.2 10099.5 3554.5 3645.5 3648.8 3658.6 3673.1 47786.5 48449.8 48794.8 49702.3 49730.8 9244.2 9774.3 9984.8 9989.7 10007.5 19028.9 19092.7 19103.0 19135.4 19137.2 7523.2 7586.4 7711.3 7747.5 7809.5 3897.1 3943.2 4022.1 4034.7 4122.9 3036.1 3068.7 3073.4 3080.0 3084.2 519.1 538.9 543.8 552.3 552.6 608.8 649.6 665.6 669.8 679.9 8361.9 8531.1 8556.4 8689.6 8804.6 468.9 615.0 650.8 663.4 686.5 3991.6 4026.2 4144.2 4221.2 4311.8 57893.4 57945.4 58688.4 58775.1 59326.4 53400.0 53465.8 53790.0 53938.7 54091.0 46327.3 46425.5 46657.5 46966.8 47334.5 8314.5 8444.5 8451.7 8534.8 8539.8 33582.0 34679.5 34905.0 35373.6 37486.3 45225.5 45251.3 45742.8 46069.3 46186.8 10212.6 10493.8 10934.2 11378.3 11521.7 12476.9 12484.4 12556.4 12684.4 13100.1 10616.9 10631.7 10667.1 10833.5 11263.5 11318.5 11392.7 11775.8 11810.4 11909.2 11570.3 11605.9 11866.2 12240.4 12244.7 9153.9 9379.4 9714.6 10055.3 10194.9 8910.7 9451.3 9576.0 9602.7 9627.1 05:09:22 INFO - 2015-11-26 05:09:22,221 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:09:22 INFO - 2015-11-26 05:09:22,221 DEBUG : BROWSER_OUTPUT: 05:09:23 INFO - 2015-11-26 05:09:23,001 INFO : Browser exited with error code: 0 05:09:23 INFO - 2015-11-26 05:09:23,018 INFO : Completed test dromaeo_css (00:18:35) 05:09:23 INFO - 2015-11-26 05:09:23,018 INFO : Starting test kraken 05:09:23 INFO - 2015-11-26 05:09:23,018 DEBUG : operating with platform_type : linux_ 05:09:23 INFO - 2015-11-26 05:09:23,018 INFO : Initialising browser for kraken test... 05:09:23 INFO - 2015-11-26 05:09:23,024 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQowagK/profile http://localhost:40681/getInfo.html 05:09:27 INFO - 2015-11-26 05:09:27,953 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:09:27 INFO - 2015-11-26 05:09:27,954 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:09:27 INFO - 2015-11-26 05:09:27,954 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:09:27 INFO - 2015-11-26 05:09:27,954 DEBUG : BROWSER_OUTPUT: __metrics 05:09:28 INFO - 2015-11-26 05:09:28,157 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:09:29 INFO - 2015-11-26 05:09:29,945 INFO : Browser initialized. 05:09:29 INFO - 2015-11-26 05:09:29,945 INFO : Running cycle 1/1 for kraken test... 05:09:29 INFO - 2015-11-26 05:09:29,946 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQowagK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:09:41 INFO - 2015-11-26 05:09:41,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 138936320 05:09:41 INFO - 2015-11-26 05:09:41,687 DEBUG : BROWSER_OUTPUT: 05:09:44 INFO - 2015-11-26 05:09:44,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40681/tests/kraken/driver.html?testName=audio-beat-detection) 05:09:44 INFO - 2015-11-26 05:09:44,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 176537600 05:09:44 INFO - 2015-11-26 05:09:44,710 DEBUG : BROWSER_OUTPUT: 05:09:47 INFO - 2015-11-26 05:09:47,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40681/tests/kraken/driver.html?testName=audio-dft) 05:09:47 INFO - 2015-11-26 05:09:47,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 165810176 05:09:47 INFO - 2015-11-26 05:09:47,848 DEBUG : BROWSER_OUTPUT: 05:09:50 INFO - 2015-11-26 05:09:50,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40681/tests/kraken/driver.html?testName=audio-fft) 05:09:51 INFO - 2015-11-26 05:09:51,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 150302720 05:09:51 INFO - 2015-11-26 05:09:51,233 DEBUG : BROWSER_OUTPUT: 05:09:53 INFO - 2015-11-26 05:09:53,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40681/tests/kraken/driver.html?testName=audio-oscillator) 05:09:53 INFO - 2015-11-26 05:09:53,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 153948160 05:09:53 INFO - 2015-11-26 05:09:53,748 DEBUG : BROWSER_OUTPUT: 05:09:55 INFO - 2015-11-26 05:09:55,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40681/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:09:56 INFO - 2015-11-26 05:09:56,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 153554944 05:09:56 INFO - 2015-11-26 05:09:56,474 DEBUG : BROWSER_OUTPUT: 05:09:59 INFO - 2015-11-26 05:09:59,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40681/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:59 INFO - 2015-11-26 05:09:59,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 155049984 05:09:59 INFO - 2015-11-26 05:09:59,934 DEBUG : BROWSER_OUTPUT: 05:10:03 INFO - 2015-11-26 05:10:03,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40681/tests/kraken/driver.html?testName=imaging-desaturate) 05:10:03 INFO - 2015-11-26 05:10:03,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 156491776 05:10:03 INFO - 2015-11-26 05:10:03,909 DEBUG : BROWSER_OUTPUT: 05:10:06 INFO - 2015-11-26 05:10:06,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40681/tests/kraken/driver.html?testName=json-parse-financial) 05:10:07 INFO - 2015-11-26 05:10:07,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 155136000 05:10:07 INFO - 2015-11-26 05:10:07,217 DEBUG : BROWSER_OUTPUT: 05:10:08 INFO - 2015-11-26 05:10:08,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40681/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:10:09 INFO - 2015-11-26 05:10:09,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 164388864 05:10:09 INFO - 2015-11-26 05:10:09,292 DEBUG : BROWSER_OUTPUT: 05:10:11 INFO - 2015-11-26 05:10:11,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40681/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:10:11 INFO - 2015-11-26 05:10:11,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 164937728 05:10:11 INFO - 2015-11-26 05:10:11,670 DEBUG : BROWSER_OUTPUT: 05:10:13 INFO - 2015-11-26 05:10:13,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40681/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:10:14 INFO - 2015-11-26 05:10:14,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 171900928 05:10:14 INFO - 2015-11-26 05:10:14,316 DEBUG : BROWSER_OUTPUT: 05:10:16 INFO - 2015-11-26 05:10:16,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:10:17 INFO - 2015-11-26 05:10:17,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 179331072 05:10:17 INFO - 2015-11-26 05:10:17,285 DEBUG : BROWSER_OUTPUT: 05:10:19 INFO - 2015-11-26 05:10:19,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:10:20 INFO - 2015-11-26 05:10:20,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 177438720 05:10:20 INFO - 2015-11-26 05:10:20,405 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40681/tests/kraken/driver.html?testName=ai-astar) 05:10:22 INFO - 2015-11-26 05:10:22,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 236871680 05:10:22 INFO - 2015-11-26 05:10:22,316 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,316 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:10:22 INFO - 2015-11-26 05:10:22,317 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:10:22 INFO - 2015-11-26 05:10:22,317 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:10:22 INFO - 2015-11-26 05:10:22,317 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:10:22 INFO - 2015-11-26 05:10:22,317 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;109;103;107;108;108;97;108;108;99 05:10:22 INFO - 2015-11-26 05:10:22,317 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;123;147;166;125;151;151;127;166;123 05:10:22 INFO - 2015-11-26 05:10:22,317 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;160;160;160;159;160;161;162;161;161 05:10:22 INFO - 2015-11-26 05:10:22,318 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;71;94;91;73;70;72;97;95;72 05:10:22 INFO - 2015-11-26 05:10:22,318 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;137;94;92;93;134;92;94;139 05:10:22 INFO - 2015-11-26 05:10:22,318 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 05:10:22 INFO - 2015-11-26 05:10:22,318 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;145;144;147;146;145;147;145 05:10:22 INFO - 2015-11-26 05:10:22,318 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;95;96;96;96;95;95 05:10:22 INFO - 2015-11-26 05:10:22,318 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;56;58;56;56;56;55;65;54;54 05:10:22 INFO - 2015-11-26 05:10:22,319 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;69;69;69;70;70;70;69;70 05:10:22 INFO - 2015-11-26 05:10:22,319 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;85;84;84;84;86;85;91;85 05:10:22 INFO - 2015-11-26 05:10:22,319 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;124;118;112;129;114;122;121;122;124 05:10:22 INFO - 2015-11-26 05:10:22,319 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;141;143;155;148;137;148;150;149;137 05:10:22 INFO - 2015-11-26 05:10:22,319 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;67;65;68;71;67;66;68;66 05:10:22 INFO - 2015-11-26 05:10:22,319 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:10:22 INFO - 2015-11-26 05:10:22,320 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:10:22 INFO - 2015-11-26 05:10:22,320 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,931 05:10:22 INFO - 2015-11-26 05:10:22,320 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:10:22 INFO - 2015-11-26 05:10:22,321 DEBUG : BROWSER_OUTPUT: __startTimestamp1448543422315__endTimestamp 05:10:22 INFO - 2015-11-26 05:10:22,321 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,323 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:10:22 INFO - 2015-11-26 05:10:22,323 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:10:22 INFO - 2015-11-26 05:10:22,323 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,323 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.30 Median:108.00 stddev:4.22 (3.9%) stddev-sans-first:4.47 05:10:22 INFO - 2015-11-26 05:10:22,323 DEBUG : BROWSER_OUTPUT: Values: 106.0 109.0 103.0 107.0 108.0 108.0 97.0 108.0 108.0 99.0 05:10:22 INFO - 2015-11-26 05:10:22,323 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,324 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.20 Median:151.00 stddev:17.26 (11.4%) stddev-sans-first:17.94 05:10:22 INFO - 2015-11-26 05:10:22,324 DEBUG : BROWSER_OUTPUT: Values: 153.0 123.0 147.0 166.0 125.0 151.0 151.0 127.0 166.0 123.0 05:10:22 INFO - 2015-11-26 05:10:22,324 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,324 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:0.88 05:10:22 INFO - 2015-11-26 05:10:22,324 DEBUG : BROWSER_OUTPUT: Values: 163.0 160.0 160.0 160.0 159.0 160.0 161.0 162.0 161.0 161.0 05:10:22 INFO - 2015-11-26 05:10:22,324 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,324 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.90 Median:82.50 stddev:11.63 (14.1%) stddev-sans-first:12.06 05:10:22 INFO - 2015-11-26 05:10:22,325 DEBUG : BROWSER_OUTPUT: Values: 74.0 71.0 94.0 91.0 73.0 70.0 72.0 97.0 95.0 72.0 05:10:22 INFO - 2015-11-26 05:10:22,325 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,325 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:92.50 stddev:21.21 (22.9%) stddev-sans-first:21.88 05:10:22 INFO - 2015-11-26 05:10:22,325 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 137.0 94.0 92.0 93.0 134.0 92.0 94.0 139.0 05:10:22 INFO - 2015-11-26 05:10:22,325 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,326 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:10:22 INFO - 2015-11-26 05:10:22,326 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 05:10:22 INFO - 2015-11-26 05:10:22,326 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,326 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 145.0 144.0 147.0 146.0 145.0 147.0 145.0 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:3.16 (5.7%) stddev-sans-first:3.35 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: Values: 57.0 56.0 58.0 56.0 56.0 56.0 55.0 65.0 54.0 54.0 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 69.0 69.0 69.0 70.0 70.0 70.0 69.0 70.0 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.00 stddev:2.11 (2.5%) stddev-sans-first:2.24 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 85.0 84.0 84.0 84.0 86.0 85.0 91.0 85.0 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:123.00 stddev:5.62 (4.6%) stddev-sans-first:5.27 05:10:22 INFO - 2015-11-26 05:10:22,327 DEBUG : BROWSER_OUTPUT: Values: 129.0 124.0 118.0 112.0 129.0 114.0 122.0 121.0 122.0 124.0 05:10:22 INFO - 2015-11-26 05:10:22,328 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,328 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:148.50 stddev:6.10 (4.1%) stddev-sans-first:6.18 05:10:22 INFO - 2015-11-26 05:10:22,328 DEBUG : BROWSER_OUTPUT: Values: 151.0 141.0 143.0 155.0 148.0 137.0 148.0 150.0 149.0 137.0 05:10:22 INFO - 2015-11-26 05:10:22,328 DEBUG : BROWSER_OUTPUT: 05:10:22 INFO - 2015-11-26 05:10:22,328 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.66 (2.5%) stddev-sans-first:1.72 05:10:22 INFO - 2015-11-26 05:10:22,328 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 65.0 68.0 71.0 67.0 66.0 68.0 66.0 05:10:22 INFO - 2015-11-26 05:10:22,328 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:10:22 INFO - 2015-11-26 05:10:22,328 DEBUG : BROWSER_OUTPUT: 05:10:23 INFO - 2015-11-26 05:10:23,181 INFO : Browser exited with error code: 0 05:10:23 INFO - 2015-11-26 05:10:23,230 INFO : Completed test kraken (00:01:00) 05:10:23 INFO - 2015-11-26 05:10:23,230 INFO : Starting test v8_7 05:10:23 INFO - 2015-11-26 05:10:23,230 DEBUG : operating with platform_type : linux_ 05:10:23 INFO - 2015-11-26 05:10:23,230 INFO : Initialising browser for v8_7 test... 05:10:23 INFO - 2015-11-26 05:10:23,236 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0YD_TR/profile http://localhost:40681/getInfo.html 05:10:27 INFO - 2015-11-26 05:10:27,725 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:10:27 INFO - 2015-11-26 05:10:27,725 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:10:27 INFO - 2015-11-26 05:10:27,725 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:10:27 INFO - 2015-11-26 05:10:27,725 DEBUG : BROWSER_OUTPUT: __metrics 05:10:27 INFO - 2015-11-26 05:10:27,854 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:10:29 INFO - 2015-11-26 05:10:29,505 INFO : Browser initialized. 05:10:29 INFO - 2015-11-26 05:10:29,506 INFO : Running cycle 1/1 for v8_7 test... 05:10:29 INFO - 2015-11-26 05:10:29,506 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0YD_TR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:10:41 INFO - 2015-11-26 05:10:41,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 138805248 05:10:41 INFO - 2015-11-26 05:10:41,217 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-11-26 05:11:02,603 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40681/tests/v8_7/run.html (next: http://localhost:40681/tests/v8_7/run.html) 05:11:02 INFO - 2015-11-26 05:11:02,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 166707200 05:11:02 INFO - 2015-11-26 05:11:02,853 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-11-26 05:11:02,854 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:11:02 INFO - 2015-11-26 05:11:02,854 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:11:02 INFO - 2015-11-26 05:11:02,854 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:11:02 INFO - 2015-11-26 05:11:02,854 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:11:02 INFO - 2015-11-26 05:11:02,854 DEBUG : BROWSER_OUTPUT: |0;Richards;164.47368421052633 05:11:02 INFO - 2015-11-26 05:11:02,854 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;197.19976336028398 05:11:02 INFO - 2015-11-26 05:11:02,855 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.09090909090907 05:11:02 INFO - 2015-11-26 05:11:02,855 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 05:11:02 INFO - 2015-11-26 05:11:02,855 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1121.0762331838564 05:11:02 INFO - 2015-11-26 05:11:02,855 DEBUG : BROWSER_OUTPUT: |5;Earley;780.64012490242 05:11:02 INFO - 2015-11-26 05:11:02,855 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 05:11:02 INFO - 2015-11-26 05:11:02,855 DEBUG : BROWSER_OUTPUT: |7;RegExp;25820.51282051282 05:11:02 INFO - 2015-11-26 05:11:02,856 DEBUG : BROWSER_OUTPUT: |8;Splay;556.7928730512249 05:11:02 INFO - 2015-11-26 05:11:02,856 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 05:11:02 INFO - 2015-11-26 05:11:02,856 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:11:02 INFO - 2015-11-26 05:11:02,856 DEBUG : BROWSER_OUTPUT: __startTimestamp1448543462853__endTimestamp 05:11:02 INFO - 2015-11-26 05:11:02,856 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-11-26 05:11:02,857 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:11:02 INFO - 2015-11-26 05:11:02,857 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:11:02 INFO - 2015-11-26 05:11:02,857 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-11-26 05:11:02,857 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.47 Median:164.47 stddev:0.00 (0.0%) 05:11:02 INFO - 2015-11-26 05:11:02,857 DEBUG : BROWSER_OUTPUT: Values: 164.5 05:11:02 INFO - 2015-11-26 05:11:02,857 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-11-26 05:11:02,858 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:197.20 Median:197.20 stddev:0.00 (0.0%) 05:11:02 INFO - 2015-11-26 05:11:02,858 DEBUG : BROWSER_OUTPUT: Values: 197.2 05:11:02 INFO - 2015-11-26 05:11:02,858 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-11-26 05:11:02,858 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.09 Median:284.09 stddev:0.00 (0.0%) 05:11:02 INFO - 2015-11-26 05:11:02,858 DEBUG : BROWSER_OUTPUT: Values: 284.1 05:11:02 INFO - 2015-11-26 05:11:02,859 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-11-26 05:11:02,859 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 05:11:02 INFO - 2015-11-26 05:11:02,859 DEBUG : BROWSER_OUTPUT: Values: 5191.7 05:11:02 INFO - 2015-11-26 05:11:02,859 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-11-26 05:11:02,859 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1121.08 Median:1121.08 stddev:0.00 (0.0%) 05:11:02 INFO - 2015-11-26 05:11:02,859 DEBUG : BROWSER_OUTPUT: Values: 1121.1 05:11:02 INFO - 2015-11-26 05:11:02,860 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-11-26 05:11:02,860 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:780.64 Median:780.64 stddev:0.00 (0.0%) 05:11:02 INFO - 2015-11-26 05:11:02,860 DEBUG : BROWSER_OUTPUT: Values: 780.6 05:11:02 INFO - 2015-11-26 05:11:02,861 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-11-26 05:11:02,861 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 05:11:02 INFO - 2015-11-26 05:11:02,861 DEBUG : BROWSER_OUTPUT: Values: 12195.1 05:11:02 INFO - 2015-11-26 05:11:02,861 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-11-26 05:11:02,861 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25820.51 Median:25820.51 stddev:0.00 (0.0%) 05:11:02 INFO - 2015-11-26 05:11:02,861 DEBUG : BROWSER_OUTPUT: Values: 25820.5 05:11:02 INFO - 2015-11-26 05:11:02,861 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-11-26 05:11:02,861 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:556.79 Median:556.79 stddev:0.00 (0.0%) 05:11:02 INFO - 2015-11-26 05:11:02,862 DEBUG : BROWSER_OUTPUT: Values: 556.8 05:11:02 INFO - 2015-11-26 05:11:02,862 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-11-26 05:11:02,862 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 05:11:02 INFO - 2015-11-26 05:11:02,862 DEBUG : BROWSER_OUTPUT: Values: 4854.4 05:11:02 INFO - 2015-11-26 05:11:02,862 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:11:02 INFO - 2015-11-26 05:11:02,862 DEBUG : BROWSER_OUTPUT: 05:11:03 INFO - 2015-11-26 05:11:03,721 INFO : Browser exited with error code: 0 05:11:03 INFO - 2015-11-26 05:11:03,738 INFO : Completed test v8_7 (00:00:40) 05:11:03 INFO - 2015-11-26 05:11:03,883 INFO : Completed test suite (00:20:16) 05:11:03 INFO - 2015-11-26 05:11:03,883 DEBUG : Working with test: dromaeo_css 05:11:03 INFO - 2015-11-26 05:11:03,883 DEBUG : Generating results file: dromaeo_css 05:11:03 INFO - 2015-11-26 05:11:03,885 DEBUG : Working with test: kraken 05:11:03 INFO - 2015-11-26 05:11:03,885 DEBUG : Generating results file: kraken 05:11:03 INFO - 2015-11-26 05:11:03,885 INFO : javascript benchmark 05:11:03 INFO - 2015-11-26 05:11:03,885 DEBUG : Working with test: v8_7 05:11:03 INFO - 2015-11-26 05:11:03,885 DEBUG : Generating results file: v8_7 05:11:03 INFO - 2015-11-26 05:11:03,886 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:11:03 INFO - 2015-11-26 05:11:03,947 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 05:11:03 INFO - 2015-11-26 05:11:03,947 DEBUG : process_Request line: dromaeo_css 6956.58 graph.html#tests=[[72,201,35]] 05:11:03 INFO - 2015-11-26 05:11:03,947 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:11:03 INFO - 2015-11-26 05:11:03,978 DEBUG : process_Request line: kraken 1492.20 graph.html#tests=[[232,201,35]] 05:11:03 INFO - 2015-11-26 05:11:03,979 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:11:04 INFO - 2015-11-26 05:11:04,013 DEBUG : process_Request line: v8_7 21099.18 graph.html#tests=[[230,201,35]] 05:11:04 INFO - 2015-11-26 05:11:04,015 INFO : javascript benchmark 05:11:04 INFO - 2015-11-26 05:11:04,018 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3188.601424821897, 3271.8364081795903, 3318.7676862619596, 3322.318924620453, 3333.9333213335735, 5317.9202311965255, 5437.13005919053, 5461.208124821898, 5481.890362192758, 5525.668459892404, 5405.81079662211, 5433.945660543393, 5467.753951072202, 5470.972645136779, 5535.280413546233, 4942.703437793726, 4967.627427942901, 4997.575206107485, 5027.597792176635, 5062.114130027249, 4825.300331451955, 5048.621353398491, 5077.187649976005, 5099.617528685345, 5146.3824341078935, 4845.27320901864, 4907.901841963158, 4959.0, 4980.501949805027, 4983.750812459362, 4963.677360971526, 4986.0, 5014.648974571782, 5022.924656130161, 5047.116754567973, 4780.163471392492, 4872.439669438025, 4974.751262436864, 4993.300937868701, 5014.52362025607, 5309.548688361494, 5369.301990741218, 5391.379991301012, 5396.271503347037, 5405.27028851104, 5931.139984702238, 5933.228680271537, 5945.64326140433, 5951.107333899907, 5961.493273071794, 5709.8287051388525, 5879.706014699291, 5917.289925208959, 5959.344472108065, 5990.610610310359, 5498.45015498447, 5523.917141242925, 5524.1989911462615, 5531.25328080708, 5589.888202235973, 5965.850853728604, 5981.6710080945095, 5982.282126144891, 5987.042073268256, 5994.910076348859, 5692.686902220417, 5709.857253568694, 5783.797567085132, 5813.069908814569, 5824.359320474744, 5871.266091738533, 5898.941010589925, 5903.144044113666, 5909.527237820964, 5910.231669882888, 5832.329282132524, 5837.620554663933, 5876.7355469004, 5885.499732522698, 5897.764089436375, 5718.542516598662, 5837.824865254049, 5877.4122587740885, 5877.588568800143, 5883.646981181143, 4452.443444569429, 4521.095780843844, 4527.637788976874, 4547.454305483363, 4562.224421848294, 4056.3915412687743, 4062.106336605942, 4065.1463192729857, 4088.509378874495, 4102.179564087194, 5390.51485366319, 5489.780408783684, 5627.324721033502, 5634.183043458757, 5635.070213414822, 5780.624259423208, 5783.595148339576, 5868.735906884115, 5887.4701276884425, 5907.852303692356, 5611.98984182851, 5634.070378387521, 5662.235598194191, 5663.943360566342, 5665.830025099253, 4942.9258561121615, 5121.564667003272, 5170.508801663836, 5182.093133701663, 5189.818356357509, 6046.183765191643, 6116.76924458105, 6120.548409105651, 6120.657843557623, 6128.1698938163645, 5901.380355062656, 5949.702514874152, 5953.047512397996, 5954.672493012753, 5986.521078313637, 5859.296884373903, 6001.0, 6009.849753756016, 6216.0, 6216.285127210248, 5593.272874526286, 5737.5983681141915, 5738.8278351649515, 5741.052726300114, 5791.449812267828, 5841.269841269841, 5889.322727886177, 5896.823095307148, 5916.792912248223, 5931.377205393372, 5620.4660557247, 5726.914096288476, 5734.3978882218435, 5777.04678728022, 5780.0, 5752.9137062943255, 5774.307083150049, 5799.94200057994, 5800.7099645018425, 5853.590248682552, 5625.184348269396, 5652.886942261214, 5653.660780353192, 5656.971715141398, 5658.377578466448, 5732.942670573241, 5748.252727145445, 5787.884242315046, 5822.534197264124, 5848.385919478394, 5471.261379713687, 5529.115341545334, 5591.916121258103, 5616.354119276336, 5655.1517272409465], "unit": "ms", "name": "dojo.html", "value": 5422.433381167777}, {"lowerIsBetter": false, "replicates": [548.7750022490779, 594.586762200271, 597.8953683105457, 604.7067172421376, 626.2422468812737, 37268.25463490729, 37706.43440348397, 37774.62225377745, 37794.62205377945, 37848.43227351585, 42654.0, 43450.34824477635, 43495.13009739811, 43522.12955740891, 43595.56404435963, 7472.0, 7640.5797681127515, 7650.961745191266, 8696.695615653454, 8870.201681848632, 10466.68599942003, 10755.56977720894, 10763.892361076407, 10773.353598784099, 10775.892241077607, 10405.375677459338, 10496.68509944703, 10502.212334074937, 10509.894901050968, 10521.368717876952, 7635.923640763577, 7769.611519424063, 7772.834074888756, 10403.167746580293, 10471.68584942453, 10178.0, 10372.79254414915, 10379.377237365783, 10380.429076400795, 10382.169426445942, 39819.0, 39919.20161596752, 40301.79849100765, 40373.0, 40380.798096009625, 3170.524421336795, 3303.8678452861855, 3377.324535092991, 4021.735885110318, 4083.2650122977852, 30116.54825177624, 30212.54681179784, 30229.0, 30363.544546831814, 30460.390792184033, 3918.2163567286657, 3946.2699400610977, 3952.0, 4076.9592304076878, 4123.402106694512, 271486.0, 271780.0, 272008.5598288043, 272091.0, 272386.0, 57759.71120144372, 57870.0, 57883.131753023736, 57892.13161802576, 57980.0, 52276.0, 53478.0, 65288.34711652918, 66737.66631166813, 66744.6662766683, 15758.606034848992, 15865.20673966297, 15921.12433816128, 15971.121588312755, 15976.440824571084, 11211.831822522505, 11255.0, 11271.436428178558, 11274.267172633752, 11569.363684997237, 19429.708554371697, 19786.60426791485, 19812.60374792496, 19817.20731170737, 19856.90071549633, 7593.202713715091, 7643.694252229849, 7725.8454830903065, 7733.4973226740085, 7800.336971357385, 875.444093000949, 910.7677542226689, 918.536139249688, 994.145367689775, 1013.7516308504316, 28496.862735294937, 28693.28266793347, 28783.856080719463, 28972.855135724185, 29263.707362926525, 995.0546980368679, 996.3025881882711, 1072.7639919217759, 1113.8663360396804, 1145.1926391893694, 14952.537150240998, 15011.174385408907, 15036.0, 15054.32255548481, 15129.848701512845, 327128.0, 331617.0, 332532.0, 333210.0, 333949.0, 44199.77900110479, 44988.0, 53312.73343633334, 53612.0, 55022.44977550254, 1321.2732996851694, 1324.8476425211225, 1327.82074419954, 1329.6875234319928, 1349.1837438349658, 28066.0, 28215.858920705265, 28965.565516516846, 29152.27119322034, 29348.0, 41276.0, 42372.36441453319, 52661.0, 53033.20450193327, 53388.19917701315, 256798.0, 263016.0, 263897.0, 265143.0, 265235.0, 42718.35922461228, 43516.347254791835, 43928.56071439245, 43933.0, 44318.556814431446, 46935.29597056115, 47039.29441058455, 47216.527834721215, 48097.519024809306, 48252.758736206095, 39331.21337573175, 39909.2018159641, 43011.56988430201, 43317.8439586455, 44592.0, 40283.3249188971, 41660.0, 41684.37473437961, 42268.36597451102, 43194.0, 39201.6079839198, 39387.60612393839, 40048.39927401033, 40074.59925400709, 41749.79125104355, 33685.49471757975, 33882.98351049473, 36600.0, 37296.81351593225, 37389.25221495609, 26595.0, 27176.1847144586, 27377.452450951267, 27410.453198135965, 27526.449471010867], "unit": "ms", "name": "ext.html", "value": 19286.214719940755}, {"lowerIsBetter": false, "replicates": [341.9521267022616, 344.6742828027515, 353.87437459701806, 355.9608443071262, 356.33543441481635, 13782.241976691303, 14125.71748565028, 16629.58426039348, 17057.82942170578, 18081.7287740684, 16065.116418596972, 16199.91900040501, 16373.672526549462, 16470.67058658826, 16487.752683709725, 4605.838795642145, 4779.187538118511, 4779.378680771495, 4783.880402989918, 4793.90412191756, 3794.298054859846, 3893.922121557567, 4763.4998325175875, 5377.274068000828, 5485.259489968863, 5425.9728701356435, 5458.344998600173, 5460.699661518614, 5477.0, 5487.176923461493, 5343.0, 5921.171036054956, 5939.55453340999, 5942.435468630473, 5944.613600115978, 5262.315898933152, 5283.101872681654, 5287.312649355597, 5292.629515933886, 5293.920591191135, 12853.614391568268, 13165.539206127836, 19134.904325478423, 20066.799332006638, 20068.799312006984, 1922.4289989496017, 1972.674508706076, 1996.670549359354, 2026.412340421276, 2165.6968024476587, 9390.5304734763, 9571.760705982337, 9763.951180244125, 11033.337999720043, 13069.346532673328, 1724.7499112628725, 1775.7336399540043, 1842.3643842874321, 1846.7229915512646, 1899.3162461513843, 59442.702786486225, 59502.10746838801, 60067.69966150185, 62368.37631623671, 62376.37623623751, 9763.0, 10024.599016039278, 10054.69835904924, 10056.748581285527, 10070.395776253448, 13289.269090199938, 13293.534726284533, 13297.867021329663, 13302.201867887958, 13303.534376296782, 7512.849743005109, 7530.924690753022, 7563.0, 7657.885131723028, 7789.922100778919, 7398.741044063539, 7560.130584982688, 7566.35685966699, 7589.203133670995, 7652.540847549165, 4348.326009468537, 4354.760488173181, 4385.3641222022625, 4405.801738921757, 4416.381706561084, 1706.215141035113, 1744.624905645267, 1753.7720096387388, 1754.3247246089284, 1787.7407775872425, 835.5571547079936, 872.358816270041, 919.0625561926931, 920.4339331311329, 962.9888616952312, 13201.60395188146, 15357.0, 15782.368705251662, 15923.920380398024, 15927.203639817963, 879.3844308983737, 893.7988952485639, 909.2862103248918, 929.7117893453051, 990.4750482244422, 9412.95293523528, 10134.695959121238, 10219.0, 10232.130268927076, 10286.845697314546, 513816.0, 522330.0, 523352.6826561052, 533706.0, 536356.0, 77165.61417192878, 78946.21053789389, 79233.0, 79729.0, 80134.0, 1139.2537887683416, 1154.6478324111226, 1156.8206927926185, 1160.715624671944, 1166.2535976974743, 14985.625359366102, 15024.774628380364, 15126.243687815786, 15361.308741106453, 15612.765808512655, 34188.264669163545, 34525.827370862986, 34953.0, 35381.46927796137, 35565.28869422649, 46771.76614116908, 47062.05875882395, 47521.52478475171, 48156.27765583589, 50508.747456262485, 9065.0, 9467.147956683932, 9583.329166958247, 9584.137427631547, 9590.0, 11092.556297748, 14058.789118163031, 16601.667966640358, 16839.579010524834, 17179.0, 13679.94800779891, 13879.722405552035, 13918.304084795518, 14155.858441415454, 14301.356438960063, 13447.327633618475, 13766.724665506434, 13814.447422103003, 13889.097208681404, 13918.51285205013, 11134.665960021212, 14267.571972840831, 14628.561143165296, 14794.926025370234, 15343.539693809204, 9365.719028429157, 9377.718668439958, 9481.525923703924, 9489.95255023748, 9503.19222866064, 13946.58160255194, 14001.5099471518, 14111.858881411055, 14116.858831411555, 14257.0], "unit": "ms", "name": "jquery.html", "value": 8692.467016493973}, {"lowerIsBetter": false, "replicates": [1316.1773891317926, 1463.590194745471, 1496.1546726099753, 1634.7384418493043, 1767.1076106566181, 6354.332795056522, 7210.098737657793, 7406.259374062598, 7409.073865766779, 7411.703531858732, 7116.074910261672, 7267.636618169084, 7288.854222915538, 7293.854122917552, 7316.817079573013, 1985.4540001499558, 2027.9290224842134, 2179.2372669565684, 2226.142934970036, 2237.2281562860785, 2240.4622890506325, 2242.5963326601204, 2247.910083596654, 2249.156566287642, 2250.493638931244, 2173.282816670495, 2218.9334319970426, 2218.977810221901, 2221.855579387343, 2224.744154422238, 1921.8750781199178, 1949.1521188283143, 2179.8365122615787, 2212.7897849704254, 2215.999999999984, 2195.4182141732454, 2209.5359974405396, 2210.635245184543, 2230.866148031107, 2253.0, 7180.425565954711, 7258.346748792581, 7267.091613548307, 7275.454340924399, 7282.417406607458, 4493.550644935481, 4558.817647294104, 4576.633869290449, 4598.2642777155825, 4599.264117741179, 2870.669872964615, 2872.439874224527, 2903.3177203357195, 2914.5628155776803, 2992.685767994351, 929.5166513413055, 946.9573869175834, 950.6720181537358, 960.2558017536395, 977.9217662586976, 9836.409815411098, 9842.704718858446, 9846.458444785534, 9850.064243896819, 9855.90144098557, 4019.3569028955226, 4075.083106301118, 4126.09225970286, 4129.525104612948, 4134.131832315247, 8544.61549230286, 8550.315974722007, 8574.871376929352, 8592.312614990911, 8593.871091933626, 4572.81708731647, 4593.563611456906, 4599.425071866017, 4600.3099535070005, 4603.838865639686, 4150.439690641785, 4196.853110141131, 4204.2432362175105, 4205.705600607928, 4207.137536804948, 3537.964620353815, 3572.6427357264065, 3586.605473397924, 3592.1199306170156, 3600.4419315006216, 1138.0497284767146, 1146.2205700123995, 1155.9364234967159, 1175.5239128153112, 1196.8803119688137, 915.949622770754, 923.0492592629603, 923.7690577355661, 958.7890664053897, 1320.7886738122047, 6850.862982740417, 6870.416014638811, 6943.6875340609795, 6945.51381403307, 6950.687219075154, 501.15555289337584, 506.4454422407458, 508.0372693745332, 510.5736709847319, 511.33015749368445, 5450.836474905759, 5605.467480589337, 5641.689707066069, 5660.29246344207, 5661.207430959669, 8211.384146189059, 8309.792255193668, 8334.62494187751, 8360.874586881202, 8369.748907532783, 8225.300849427866, 8488.660453581911, 8502.74491765248, 8506.064332923374, 8510.82978340442, 6747.561408508432, 6796.592204467748, 6819.488538359643, 6841.863162736718, 6847.452203823583, 6425.742970281136, 6463.7737679181, 6487.351264873475, 6500.869982600227, 6505.544611877123, 7567.735129270449, 7674.462787604814, 7872.448928575174, 7897.447178697436, 7923.168067352845, 7769.184235655175, 7880.211978802074, 7884.147225402141, 7884.4086693497065, 7892.802679933047, 6639.966800165968, 6644.235912869888, 6736.831579210559, 6743.325667433218, 6752.561083529555, 7036.19083805369, 7074.0, 7102.573845569075, 7132.179799322937, 7134.108236470442, 6527.445167160845, 6685.598864068172, 6743.797686069426, 6855.725770969106, 6857.862842743217, 5621.718914054362, 6535.117759102651, 6663.566868153554, 6711.194656641234, 6788.355106264897, 6756.425703815231, 6806.965965170142, 6861.245263020964, 6871.931280687129, 6884.965575172092, 6234.532410069353, 6241.032639940817, 6246.031865060922, 6246.3753624637175, 6265.686715664289, 6139.26328840542, 6179.969100154471, 6209.813705588839, 6210.285817131088, 6216.44052035319], "unit": "ms", "name": "mootools.html", "value": 4167.377913758146}, {"lowerIsBetter": false, "replicates": [315.6117974890884, 320.8604257148141, 322.1316365082521, 329.82519264789653, 330.8610383638871, 5856.267966504187, 5857.297124345079, 5869.677167755772, 5945.8216253512355, 5976.641401515912, 5658.264425624673, 5726.141078838176, 5794.82615521535, 5866.706664666771, 5874.206982057421, 4522.3668686383935, 4525.321201819737, 4545.0, 4553.225951588238, 4566.84016059438, 4351.912961740763, 4564.589186973171, 4565.634749220055, 4575.977120114395, 4578.908421831561, 4373.169097871394, 4392.3631073494325, 4444.866654000385, 4447.911041779163, 4459.732416055047, 4461.7322960622305, 4485.9551404485865, 4488.281874900017, 4499.820007199708, 4500.032493014018, 3945.6251656092627, 3950.3679411294343, 3952.3083460394314, 3957.2679054375035, 3968.8809335719975, 5487.396386397493, 5595.804146854841, 5597.496225339698, 5599.636023658449, 5606.439356064402, 5198.376194856603, 5213.5829133669595, 5216.843494695166, 5219.42586315505, 5226.686398816083, 6220.533459990519, 6227.813165605039, 6231.189945307126, 6231.563790534665, 6233.625982441068, 4341.348797680342, 4357.085012147453, 4358.0412309291905, 4365.061511774984, 4365.257906155961, 6345.206849143857, 6506.804795856132, 6511.34886511345, 6511.837204069889, 6523.086767852505, 4562.315652652129, 4566.406367172246, 4569.063342014879, 4571.451425828922, 4572.725636461823, 4617.053504031665, 4619.030003699261, 4623.976880115578, 4624.838130665411, 4628.074385122922, 5278.996990571779, 5281.656692314988, 5290.444503327095, 5292.02097611943, 5292.100342941709, 6182.196314479089, 6233.657148856856, 6274.623522588659, 6304.432601065926, 6309.463695585927, 1578.3213218316234, 1593.0362130910864, 1596.6008497875532, 1597.209381356236, 1597.4249270262696, 1070.277562645227, 1072.5816931396762, 1072.6192201768415, 1086.2070688397514, 1093.0763504838399, 6098.939010609926, 6100.908486372708, 6107.114468402056, 6115.816525504242, 6142.324344322121, 6488.31872653374, 6492.740290388331, 6493.285738568754, 6493.740250389931, 6497.18785151856, 5880.8235752927485, 5947.9702601486715, 6091.086337049478, 6134.2332208473945, 6164.876702466016, 3503.474478828145, 3521.401361768454, 3524.9118772030906, 3525.8060806655367, 3531.3290474809705, 6805.489588280899, 6805.863882722318, 6813.0, 6814.284500127515, 6818.897716534256, 6511.38141876521, 6673.666316684146, 6686.832829179212, 6687.465002799764, 6688.063671086052, 6796.52424330302, 6797.66011699423, 6799.524033317621, 6812.4550035997, 6821.249662537216, 6522.21733391996, 6524.1192439022025, 6524.804255872332, 6526.738930442729, 6547.083408322934, 6212.596181248205, 6429.871402571829, 6466.773662921775, 6469.902951455826, 6473.546851720523, 6812.625305608239, 6818.693158807766, 6822.897656535255, 6823.420009299067, 6830.863382732218, 4347.5652434756275, 4376.781160942004, 4378.846740364072, 4381.6275616571675, 4386.429764130643, 6275.803468785888, 6497.545171837926, 6526.804195874131, 6542.0, 6542.803715888531, 6371.23545174582, 6375.872482550416, 6378.585391949508, 6379.4896408286295, 6383.9361606383345, 6322.557420980671, 6364.427201551883, 6374.458171055512, 6377.4579160771855, 6388.105665206967, 6086.756529738938, 6224.439800417984, 6232.657203853832, 6238.313785483684, 6255.437010669061, 6391.488680905423, 6396.008618664115, 6399.296077431572, 6403.51973601991, 6404.359564043559, 6241.188645476059, 6245.188125543832, 6246.437820596168, 6249.187605611241, 6253.874922501615], "unit": "ms", "name": "prototype.html", "value": 4752.162298876262}, {"lowerIsBetter": false, "replicates": [759.3431681595415, 789.0767801672044, 796.1441450440774, 813.2477458351027, 824.5753436979954, 12679.619611411661, 12903.096783225177, 13104.672383190426, 13110.541131060403, 13178.406971686272, 12303.876961230386, 12314.0, 13075.346232688375, 13092.803607945889, 13093.67265818355, 691.5228492340269, 696.6899729620295, 820.3970081989733, 837.8785076163983, 837.9622916968751, 824.7773101262655, 826.7519744076783, 833.8749187621845, 834.0741776627938, 835.0, 872.3762509805488, 874.4097734029536, 874.5845723281454, 875.5009644502636, 879.278991227194, 707.056080133023, 717.4977515739004, 858.6393714639867, 866.618687777376, 874.2699845628875, 638.9808305750835, 639.48840927258, 639.9584027038228, 641.9807405777834, 644.3427703742203, 12886.87113128866, 13095.410706518229, 13106.541271055563, 13129.73740525184, 13137.0, 12065.819012714815, 12230.877691223062, 12389.566365177267, 12474.875251247462, 12924.159929604546, 9750.707478775648, 9911.752206194902, 9930.0, 10085.243606729451, 10099.495025248709, 3554.502369668223, 3645.5260816094005, 3648.8358023888723, 3658.634136586347, 3673.0633688409284, 47786.522134778555, 48449.78875528105, 48794.75602621964, 49702.254466183396, 49730.7513462434, 9244.210578569913, 9774.26692998028, 9984.750381240527, 9989.700308990741, 10007.49962501872, 19028.904855475634, 19092.71360929587, 19103.0, 19135.425937221906, 19137.23451061942, 7523.247675232543, 7586.431017673586, 7711.267429594292, 7747.535147891144, 7809.54367355451, 3897.0841852164717, 3943.171933893857, 4022.0950286185375, 4034.677225821927, 4122.91754164915, 3036.134701610075, 3068.6931306869583, 3073.4006868660845, 3079.9538006929915, 3084.151858238957, 519.08640792206, 538.9164679474687, 543.7743336515381, 552.34822908967, 552.5966044787248, 608.8112685067643, 649.5518092516148, 665.6172700697118, 669.7521916890685, 679.864027194563, 8361.916380836235, 8531.10423405546, 8556.40105192643, 8689.56552172389, 8804.603792829337, 468.9109069276827, 615.0391478876113, 650.8405440667067, 663.3697986912453, 686.4919959230134, 3991.560928297885, 4026.214888096793, 4144.191882582867, 4221.2401767681495, 4311.827526898952, 57893.42106578965, 57945.420545794004, 58688.413115868294, 58775.11837322444, 59326.40673593295, 53400.0, 53465.79205247697, 53790.0, 53938.73030634822, 54091.0, 46327.30509042367, 46425.535744642795, 46657.53342466532, 46966.765166174635, 47334.52665473301, 8314.501129932223, 8444.535550544779, 8451.711600739049, 8534.82930341402, 8539.786505337168, 33582.0, 34679.479807802396, 34905.0, 35373.64626353807, 37486.2502749938, 45225.54774452213, 45251.321230182235, 45742.771286143354, 46069.30896036629, 46186.769066154455, 10212.591496340063, 10493.790124197321, 10934.234603577992, 11378.260413073123, 11521.711957201138, 12476.937615311865, 12484.375781211085, 12556.37218139071, 12684.437518301227, 13100.148490348098, 10616.946915265684, 10631.734206644587, 10667.065808511761, 10833.512491937725, 11263.529259127765, 11318.490667920129, 11392.715182120513, 11775.76448471043, 11810.40947952616, 11909.22590031645, 11570.305781653127, 11605.883941160819, 11866.228695134789, 12240.449179787109, 12244.693882653006, 9153.862692059758, 9379.390339627902, 9714.591384249103, 10055.296129271173, 10194.949025255122, 8910.688125915822, 9451.338406311492, 9576.042395760369, 9602.66390676323, 9627.133557979816], "unit": "ms", "name": "yui.html", "value": 6294.947027046918}], "name": "dromaeo_css", "value": 6956.575672226897}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [106.0, 109.0, 103.0, 107.0, 108.0, 108.0, 97.0, 108.0, 108.0, 99.0], "unit": "ms", "name": "ai-astar", "value": 105.3}, {"lowerIsBetter": true, "replicates": [153.0, 123.0, 147.0, 166.0, 125.0, 151.0, 151.0, 127.0, 166.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 160.0, 160.0, 159.0, 160.0, 161.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 94.0, 91.0, 73.0, 70.0, 72.0, 97.0, 95.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 137.0, 94.0, 92.0, 93.0, 134.0, 92.0, 94.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 144.0, 147.0, 146.0, 145.0, 147.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 58.0, 56.0, 56.0, 56.0, 55.0, 65.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 69.0, 69.0, 70.0, 70.0, 70.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 86.0, 85.0, 91.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [129.0, 124.0, 118.0, 112.0, 129.0, 114.0, 122.0, 121.0, 122.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [151.0, 141.0, 143.0, 155.0, 148.0, 137.0, 148.0, 150.0, 149.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 65.0, 68.0, 71.0, 67.0, 66.0, 68.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1492.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.47368421052633], "unit": "score", "name": "Richards", "value": 214.6361599999999}, {"lowerIsBetter": false, "replicates": [197.19976336028398], "unit": "score", "name": "DeltaBlue", "value": 335.28437799999983}, {"lowerIsBetter": false, "replicates": [284.09090909090907], "unit": "score", "name": "Encrypt", "value": 936.95712}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1121.0762331838564], "unit": "score", "name": "RayTrace", "value": 660.070188}, {"lowerIsBetter": false, "replicates": [780.64012490242], "unit": "score", "name": "Earley", "value": 853.7391030000001}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [25820.51282051282], "unit": "score", "name": "RegExp", "value": 35.28144488579943}, {"lowerIsBetter": false, "replicates": [556.7928730512249], "unit": "score", "name": "Splay", "value": 146.35783600000002}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21099.17853153787}]} 05:11:04 INFO - RETURN: dromaeo_css: 6956.58 05:11:04 INFO - RETURN: kraken: 1492.20 05:11:04 INFO - RETURN: v8_7: 21099.18 05:11:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "21099.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1492.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6956.58"}}} 05:11:04 INFO - Return code: 0 05:11:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:11:04 INFO - # TBPL SUCCESS # 05:11:04 INFO - Running post-action listener: _resource_record_post_action 05:11:04 INFO - Running post-run listener: _resource_record_post_run 05:11:05 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521244672; Read time: 12; Write time: 1024536 05:11:05 INFO - install - Wall time: 15s; CPU: 18.0%; Read bytes: 0; Write bytes: 248864768; Read time: 0; Write time: 741080 05:11:05 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272375808; Read time: 12; Write time: 282080 05:11:05 INFO - Running post-run listener: _upload_blobber_files 05:11:05 INFO - Blob upload gear active. 05:11:05 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:11:05 INFO - Copying logs to upload dir... 05:11:05 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.695723 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-26 05:11:05.325954) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 05:11:05.333473) ========= 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=a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010257 build_url: 'https://queue.taskcluster.net/v1/task/yJEEPXc-T9iP2fI6sLgk1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 05:11:05.388128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:11:05.388550) ========= 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=a194aa7faa1be204aaca7d660000020b-1448541768.195312-1783461011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:11:05.438834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 05:11:05.439153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 05:11:05.439465) ========= ========= Total master_lag: 0.25 =========