builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1451508204.85 results: success (0) buildid: 20151230103013 builduid: 52bc8af9d193425eab619594368db2c4 revision: 84479159751f5517950730506875887b9f22d1c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:24.854025) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:24.854478) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:24.854787) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006395 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:24.915458) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:24.915754) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:24.976114) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:24.976492) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:25.028107) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:25.028479) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:25.028880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:25.029179) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 12:43:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 218M=0s 2015-12-30 12:43:25 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099551 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:25.142380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:25.142682) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018394 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:25.193053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:25.193461) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 84479159751f5517950730506875887b9f22d1c9 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 84479159751f5517950730506875887b9f22d1c9 --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=0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 12:43:25,696 truncating revision to first 12 chars 2015-12-30 12:43:25,696 Setting DEBUG logging. 2015-12-30 12:43:25,696 attempt 1/10 2015-12-30 12:43:25,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/84479159751f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 12:43:26,222 unpacking tar archive at: mozilla-inbound-84479159751f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.803996 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:26.012056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:26.012435) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:26.023637) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:26.024084) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 12:43:26.024560) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2015-12-30 12:43:26.024851) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:43:26 INFO - MultiFileLogger online at 20151230 12:43:26 in /builds/slave/test-pgo 12:43:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 12:43:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:43:26 INFO - {'append_to_log': False, 12:43:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:43:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:43:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:43:26 INFO - 'branch': 'Mozilla-Inbound', 12:43:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:43:26 INFO - 'config_files': ('talos/linux_config.py',), 12:43:26 INFO - 'default_actions': ('clobber', 12:43:26 INFO - 'read-buildbot-config', 12:43:26 INFO - 'download-and-extract', 12:43:26 INFO - 'populate-webroot', 12:43:26 INFO - 'create-virtualenv', 12:43:26 INFO - 'install', 12:43:26 INFO - 'run-tests'), 12:43:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:43:26 INFO - 'download_minidump_stackwalk': True, 12:43:26 INFO - 'download_symbols': 'ondemand', 12:43:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:43:26 INFO - 'tooltool.py': '/tools/tooltool.py', 12:43:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:43:26 INFO - '/tools/misc-python/virtualenv.py')}, 12:43:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:43:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:43:26 INFO - 'installer_path': 'installer.exe', 12:43:26 INFO - 'log_level': 'info', 12:43:26 INFO - 'log_name': 'talos', 12:43:26 INFO - 'log_to_console': True, 12:43:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:43:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:43:26 INFO - 'opt_config_files': (), 12:43:26 INFO - 'pip_index': False, 12:43:26 INFO - 'sps_profile': False, 12:43:26 INFO - 'sps_profile_interval': 0, 12:43:26 INFO - 'suite': 'dromaeojs-e10s', 12:43:26 INFO - 'system_bits': '32', 12:43:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:43:26 INFO - 'title': 'talos-linux64-ix-035', 12:43:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:43:26 INFO - 'use_talos_json': True, 12:43:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:43:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:43:26 INFO - 'work_dir': 'build'} 12:43:26 INFO - ##### 12:43:26 INFO - ##### Running clobber step. 12:43:26 INFO - ##### 12:43:26 INFO - Running pre-action listener: _resource_record_pre_action 12:43:26 INFO - Running main action method: clobber 12:43:26 INFO - rmtree: /builds/slave/test-pgo/build 12:43:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:43:27 INFO - Running post-action listener: _resource_record_post_action 12:43:27 INFO - ##### 12:43:27 INFO - ##### Running read-buildbot-config step. 12:43:27 INFO - ##### 12:43:27 INFO - Running pre-action listener: _resource_record_pre_action 12:43:27 INFO - Running main action method: read_buildbot_config 12:43:27 INFO - Using buildbot properties: 12:43:27 INFO - { 12:43:27 INFO - "project": "", 12:43:27 INFO - "product": "firefox", 12:43:27 INFO - "script_repo_revision": "production", 12:43:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 12:43:27 INFO - "repository": "", 12:43:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 12:43:27 INFO - "buildid": "20151230103013", 12:43:27 INFO - "pgo_build": "True", 12:43:27 INFO - "basedir": "/builds/slave/test-pgo", 12:43:27 INFO - "buildnumber": 570, 12:43:27 INFO - "slavename": "talos-linux64-ix-035", 12:43:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:43:27 INFO - "platform": "ubuntu64_hw", 12:43:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 12:43:27 INFO - "branch": "mozilla-inbound", 12:43:27 INFO - "repo_path": "integration/mozilla-inbound", 12:43:27 INFO - "revision": "84479159751f5517950730506875887b9f22d1c9", 12:43:27 INFO - "stage_platform": "linux64-pgo", 12:43:27 INFO - "builduid": "52bc8af9d193425eab619594368db2c4", 12:43:27 INFO - "slavebuilddir": "test" 12:43:27 INFO - } 12:43:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:43:27 INFO - Running post-action listener: _resource_record_post_action 12:43:27 INFO - ##### 12:43:27 INFO - ##### Running download-and-extract step. 12:43:27 INFO - ##### 12:43:27 INFO - Running pre-action listener: _resource_record_pre_action 12:43:27 INFO - Running main action method: download_and_extract 12:43:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:27 INFO - https://queue.taskcluster.net/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:43:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/test_packages.json 12:43:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/test_packages.json 12:43:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:43:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:43:36 INFO - Downloaded 1302 bytes. 12:43:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:43:36 INFO - Using the following test package requirements: 12:43:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:43:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:43:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:43:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:43:36 INFO - u'jsshell-linux-x86_64.zip'], 12:43:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:43:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:43:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:43:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:43:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:43:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:43:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:43:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:43:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:43:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:43:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:43:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:43:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:36 INFO - https://queue.taskcluster.net/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:43:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:43:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:43:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:43:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:43:41 INFO - Downloaded 23202568 bytes. 12:43:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:43:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:43:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:43:42 INFO - Return code: 0 12:43:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:42 INFO - https://queue.taskcluster.net/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:43:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:43:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:43:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:43:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:43:44 INFO - Downloaded 23202568 bytes. 12:43:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:43:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:43:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:43:45 INFO - Return code: 0 12:43:45 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')]} 12:43:45 INFO - https://queue.taskcluster.net/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:43:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:43:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:43:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:43:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:43:47 INFO - Downloaded 11132285 bytes. 12:43:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 12:43:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:43:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:43:47 INFO - Return code: 0 12:43: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')]} 12:43:47 INFO - https://queue.taskcluster.net/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:43:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:43:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:43:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:43:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:43:49 INFO - Downloaded 54950498 bytes. 12:43:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:43:49 INFO - mkdir: /builds/slave/test-pgo/properties 12:43:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:43:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:43:49 INFO - Contents: 12:43:49 INFO - build_url:https://queue.taskcluster.net/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:43:49 INFO - Running post-action listener: _resource_record_post_action 12:43:49 INFO - Running post-action listener: set_extra_try_arguments 12:43:49 INFO - ##### 12:43:49 INFO - ##### Running populate-webroot step. 12:43:49 INFO - ##### 12:43:49 INFO - Running pre-action listener: _resource_record_pre_action 12:43:49 INFO - Running main action method: populate_webroot 12:43:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:43:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:43:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:43:49 INFO - '--tppagecycles', 12:43:49 INFO - '7'], 12:43:49 INFO - 'tests': ['tsvgm']}}, 12:43:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:43:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:43:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:43:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:43:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:43:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:43:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:43:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:49 INFO - 'talos_options': ['--e10s'], 12:43:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:43:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:49 INFO - 'tests': ['damp', 'tps']}, 12:43:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:49 INFO - 'talos_options': ['--e10s'], 12:43:49 INFO - 'tests': ['damp', 'tps']}, 12:43:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:43:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:43:49 INFO - 'other': {'tests': ['a11yr', 12:43:49 INFO - 'ts_paint', 12:43:49 INFO - 'tpaint', 12:43:49 INFO - 'sessionrestore', 12:43:49 INFO - 'sessionrestore_no_auto_restore']}, 12:43:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:43:49 INFO - 'tests': ['a11yr', 12:43:49 INFO - 'ts_paint', 12:43:49 INFO - 'tpaint', 12:43:49 INFO - 'sessionrestore', 12:43:49 INFO - 'sessionrestore_no_auto_restore']}, 12:43:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:43:49 INFO - 'tests': ['a11yr', 12:43:49 INFO - 'ts_paint', 12:43:49 INFO - 'tpaint', 12:43:49 INFO - 'sessionrestore', 12:43:49 INFO - 'sessionrestore_no_auto_restore']}, 12:43:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:43:49 INFO - 'tests': ['a11yr', 12:43:49 INFO - 'ts_paint', 12:43:49 INFO - 'tpaint', 12:43:49 INFO - 'sessionrestore', 12:43:49 INFO - 'sessionrestore_no_auto_restore']}, 12:43:49 INFO - 'other_l64': {'tests': ['a11yr', 12:43:49 INFO - 'ts_paint', 12:43:49 INFO - 'tpaint', 12:43:49 INFO - 'sessionrestore', 12:43:49 INFO - 'sessionrestore_no_auto_restore']}, 12:43:49 INFO - 'other_nol64': {'tests': ['a11yr', 12:43:49 INFO - 'ts_paint', 12:43:49 INFO - 'tpaint', 12:43:49 INFO - 'sessionrestore', 12:43:49 INFO - 'sessionrestore_no_auto_restore']}, 12:43:49 INFO - 'svgr': {'tests': ['tsvgx', 12:43:49 INFO - 'tsvgr_opacity', 12:43:49 INFO - 'tart', 12:43:49 INFO - 'tscrollx', 12:43:49 INFO - 'cart']}, 12:43:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:43:49 INFO - 'tests': ['tsvgx', 12:43:49 INFO - 'tsvgr_opacity', 12:43:49 INFO - 'tart', 12:43:49 INFO - 'tscrollx', 12:43:49 INFO - 'cart']}, 12:43:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:49 INFO - 'tests': ['tp5o']}, 12:43:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:49 INFO - 'talos_options': ['--e10s'], 12:43:49 INFO - 'tests': ['tp5o']}, 12:43:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:49 INFO - 'talos_options': ['--xperf_path', 12:43:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:43:49 INFO - 'tests': ['tp5n']}, 12:43:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:49 INFO - 'talos_options': ['--e10s', 12:43:49 INFO - '--xperf_path', 12:43:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:43:49 INFO - 'tests': ['tp5n']}}, 12:43:49 INFO - 'talos.zip': {'path': '', 12:43:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:43:49 INFO - Running post-action listener: _resource_record_post_action 12:43:49 INFO - ##### 12:43:49 INFO - ##### Running create-virtualenv step. 12:43:49 INFO - ##### 12:43:49 INFO - Running pre-action listener: _resource_record_pre_action 12:43:49 INFO - Running main action method: create_virtualenv 12:43:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:43:49 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 12:43:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:43:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:43:49 INFO - Using real prefix '/usr' 12:43:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:43:50 INFO - Installing distribute.............................................................................................................................................................................................done. 12:43:52 INFO - Installing pip.................done. 12:43:52 INFO - Return code: 0 12:43:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:52 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 0x7f0fdbeeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e7f0>, '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 0xeea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeea760>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', '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 12:43:52 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 12:43:52 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 12:43:52 INFO - Using env: {'DISPLAY': ':0', 12:43:52 INFO - 'HOME': '/home/cltbld', 12:43:52 INFO - 'LANG': 'en_US.UTF-8', 12:43:52 INFO - 'LANGUAGE': 'en_US:en', 12:43:52 INFO - 'LOGNAME': 'cltbld', 12:43:52 INFO - 'MAIL': '/var/mail/cltbld', 12:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:52 INFO - 'MOZ_NO_REMOTE': '1', 12:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:52 INFO - 'NO_EM_RESTART': '1', 12:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:43:52 INFO - 'PWD': '/builds/slave/test-pgo', 12:43:52 INFO - 'SHELL': '/bin/bash', 12:43:52 INFO - 'SHLVL': '1', 12:43:52 INFO - 'TERM': 'linux', 12:43:52 INFO - 'TMOUT': '86400', 12:43:52 INFO - 'USER': 'cltbld', 12:43:52 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', 12:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:52 INFO - '_': '/tools/buildbot/bin/python'} 12:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:52 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 12:43:52 INFO - Cleaning up... 12:43:52 INFO - Return code: 0 12:43:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:52 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 0x7f0fdbeeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e7f0>, '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 0xeea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeea760>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', '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 12:43:52 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 12:43:52 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 12:43:52 INFO - Using env: {'DISPLAY': ':0', 12:43:52 INFO - 'HOME': '/home/cltbld', 12:43:52 INFO - 'LANG': 'en_US.UTF-8', 12:43:52 INFO - 'LANGUAGE': 'en_US:en', 12:43:52 INFO - 'LOGNAME': 'cltbld', 12:43:52 INFO - 'MAIL': '/var/mail/cltbld', 12:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:52 INFO - 'MOZ_NO_REMOTE': '1', 12:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:52 INFO - 'NO_EM_RESTART': '1', 12:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:43:52 INFO - 'PWD': '/builds/slave/test-pgo', 12:43:52 INFO - 'SHELL': '/bin/bash', 12:43:52 INFO - 'SHLVL': '1', 12:43:52 INFO - 'TERM': 'linux', 12:43:52 INFO - 'TMOUT': '86400', 12:43:52 INFO - 'USER': 'cltbld', 12:43:52 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', 12:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:52 INFO - '_': '/tools/buildbot/bin/python'} 12:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:52 INFO - Downloading/unpacking psutil>=0.7.1 12:43:52 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 12:43:52 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 12:43:52 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 12:43:52 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 12:43:52 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 12:43:52 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 12:43:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:43:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:43:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:43:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:54 INFO - Installing collected packages: psutil 12:43:54 INFO - Running setup.py install for psutil 12:43:54 INFO - building 'psutil._psutil_linux' extension 12:43:54 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 12:43:54 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 12:43:54 INFO - building 'psutil._psutil_posix' extension 12:43:54 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 12:43:54 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 12:43:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:54 INFO - Successfully installed psutil 12:43:54 INFO - Cleaning up... 12:43:54 INFO - Return code: 0 12:43:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:54 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 0x7f0fdbeeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e7f0>, '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 0xeea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeea760>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', '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 12:43:54 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 12:43:54 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 12:43:54 INFO - Using env: {'DISPLAY': ':0', 12:43:54 INFO - 'HOME': '/home/cltbld', 12:43:54 INFO - 'LANG': 'en_US.UTF-8', 12:43:54 INFO - 'LANGUAGE': 'en_US:en', 12:43:54 INFO - 'LOGNAME': 'cltbld', 12:43:54 INFO - 'MAIL': '/var/mail/cltbld', 12:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:54 INFO - 'MOZ_NO_REMOTE': '1', 12:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:54 INFO - 'NO_EM_RESTART': '1', 12:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:43:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:43:54 INFO - 'SHELL': '/bin/bash', 12:43:54 INFO - 'SHLVL': '1', 12:43:54 INFO - 'TERM': 'linux', 12:43:54 INFO - 'TMOUT': '86400', 12:43:54 INFO - 'USER': 'cltbld', 12:43:54 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', 12:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:54 INFO - '_': '/tools/buildbot/bin/python'} 12:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:43:55 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 12:43:55 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 12:43:55 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 12:43:55 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 12:43:55 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 12:43:55 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 12:43:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:43:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:43:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:43:56 INFO - Installing collected packages: mozsystemmonitor 12:43:56 INFO - Running setup.py install for mozsystemmonitor 12:43:56 INFO - Successfully installed mozsystemmonitor 12:43:56 INFO - Cleaning up... 12:43:56 INFO - Return code: 0 12:43:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:43:56 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')]} 12:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:56 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')]} 12:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:56 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 0x7f0fdbeeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e7f0>, '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 0xeea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeea760>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', '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 12:43:56 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 12:43:56 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 12:43:56 INFO - Using env: {'DISPLAY': ':0', 12:43:56 INFO - 'HOME': '/home/cltbld', 12:43:56 INFO - 'LANG': 'en_US.UTF-8', 12:43:56 INFO - 'LANGUAGE': 'en_US:en', 12:43:56 INFO - 'LOGNAME': 'cltbld', 12:43:56 INFO - 'MAIL': '/var/mail/cltbld', 12:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:56 INFO - 'MOZ_NO_REMOTE': '1', 12:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:56 INFO - 'NO_EM_RESTART': '1', 12:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:43:56 INFO - 'PWD': '/builds/slave/test-pgo', 12:43:56 INFO - 'SHELL': '/bin/bash', 12:43:56 INFO - 'SHLVL': '1', 12:43:56 INFO - 'TERM': 'linux', 12:43:56 INFO - 'TMOUT': '86400', 12:43:56 INFO - 'USER': 'cltbld', 12:43:56 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', 12:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:56 INFO - '_': '/tools/buildbot/bin/python'} 12:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:57 INFO - Downloading/unpacking blobuploader==1.2.4 12:43:57 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 12:43:57 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 12:43:57 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 12:43:57 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 12:43:57 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 12:43:57 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 12:43:58 INFO - Downloading blobuploader-1.2.4.tar.gz 12:43:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:43:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:43:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:43:58 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 12:43:58 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 12:43:58 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 12:43:58 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 12:43:58 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 12:43:58 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 12:43:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:43:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:43:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:59 INFO - Downloading docopt-0.6.1.tar.gz 12:43:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:43:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:43:59 INFO - Installing collected packages: blobuploader, requests, docopt 12:43:59 INFO - Running setup.py install for blobuploader 12:43:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:43:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:43:59 INFO - Running setup.py install for requests 12:44:00 INFO - Running setup.py install for docopt 12:44:00 INFO - Successfully installed blobuploader requests docopt 12:44:00 INFO - Cleaning up... 12:44:00 INFO - Return code: 0 12:44:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:44:00 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')]} 12:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:00 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')]} 12:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:00 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 0x7f0fdbeeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e7f0>, '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 0xeea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeea760>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', '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 12:44:00 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 12:44:00 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 12:44:00 INFO - Using env: {'DISPLAY': ':0', 12:44:00 INFO - 'HOME': '/home/cltbld', 12:44:00 INFO - 'LANG': 'en_US.UTF-8', 12:44:00 INFO - 'LANGUAGE': 'en_US:en', 12:44:00 INFO - 'LOGNAME': 'cltbld', 12:44:00 INFO - 'MAIL': '/var/mail/cltbld', 12:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:00 INFO - 'MOZ_NO_REMOTE': '1', 12:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:00 INFO - 'NO_EM_RESTART': '1', 12:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:00 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:00 INFO - 'SHELL': '/bin/bash', 12:44:00 INFO - 'SHLVL': '1', 12:44:00 INFO - 'TERM': 'linux', 12:44:00 INFO - 'TMOUT': '86400', 12:44:00 INFO - 'USER': 'cltbld', 12:44:00 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', 12:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:00 INFO - '_': '/tools/buildbot/bin/python'} 12:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:44:00 INFO - Running setup.py (path:/tmp/pip-5sBJDT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:44:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:44:00 INFO - Running setup.py (path:/tmp/pip-iPp9EH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:44:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:44:00 INFO - Running setup.py (path:/tmp/pip-M5QUb_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:44:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:44:00 INFO - Running setup.py (path:/tmp/pip-b46tit-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:44:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:44:00 INFO - Running setup.py (path:/tmp/pip-q8QRc_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:44:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:44:00 INFO - Running setup.py (path:/tmp/pip-peP2LQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:44:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:44:00 INFO - Running setup.py (path:/tmp/pip-SyjCGN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:44:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:44:00 INFO - Running setup.py (path:/tmp/pip-TmKP3h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:44:01 INFO - Running setup.py (path:/tmp/pip-wVXaqS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:44:01 INFO - Running setup.py (path:/tmp/pip-o3CHoZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:44:01 INFO - Running setup.py (path:/tmp/pip-hNahMs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:44:01 INFO - Running setup.py (path:/tmp/pip-s8pKR8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:44:01 INFO - Running setup.py (path:/tmp/pip-Gl6pAE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:44:01 INFO - Running setup.py (path:/tmp/pip-4oBlpk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:44:01 INFO - Running setup.py (path:/tmp/pip-hS5CX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:44:01 INFO - Running setup.py (path:/tmp/pip-g9olyb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:44:01 INFO - Running setup.py (path:/tmp/pip-Kdlg0x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:44:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:44:01 INFO - Running setup.py install for manifestparser 12:44:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:44:01 INFO - Running setup.py install for mozcrash 12:44:01 INFO - Running setup.py install for mozdebug 12:44:01 INFO - Running setup.py install for mozdevice 12:44:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:44:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:44:02 INFO - Running setup.py install for mozfile 12:44:02 INFO - Running setup.py install for mozhttpd 12:44:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:44:02 INFO - Running setup.py install for mozinfo 12:44:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:44:02 INFO - Running setup.py install for mozInstall 12:44:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:44:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:44:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:44:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:44:02 INFO - Running setup.py install for mozleak 12:44:02 INFO - Running setup.py install for mozlog 12:44:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:44:02 INFO - Running setup.py install for moznetwork 12:44:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:44:02 INFO - Running setup.py install for mozprocess 12:44:02 INFO - Running setup.py install for mozprofile 12:44:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:44:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:44:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:44:03 INFO - Running setup.py install for mozrunner 12:44:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:44:03 INFO - Running setup.py install for mozscreenshot 12:44:03 INFO - Running setup.py install for moztest 12:44:03 INFO - Running setup.py install for mozversion 12:44:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:44:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:44:03 INFO - Cleaning up... 12:44:03 INFO - Return code: 0 12:44:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:44:03 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')]} 12:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:03 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')]} 12:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:03 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 0x7f0fdbeeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e7f0>, '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 0xeea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeea760>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', '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 12:44:03 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 12:44:03 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 12:44:03 INFO - Using env: {'DISPLAY': ':0', 12:44:03 INFO - 'HOME': '/home/cltbld', 12:44:03 INFO - 'LANG': 'en_US.UTF-8', 12:44:03 INFO - 'LANGUAGE': 'en_US:en', 12:44:03 INFO - 'LOGNAME': 'cltbld', 12:44:03 INFO - 'MAIL': '/var/mail/cltbld', 12:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:03 INFO - 'MOZ_NO_REMOTE': '1', 12:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:03 INFO - 'NO_EM_RESTART': '1', 12:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:03 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:03 INFO - 'SHELL': '/bin/bash', 12:44:03 INFO - 'SHLVL': '1', 12:44:03 INFO - 'TERM': 'linux', 12:44:03 INFO - 'TMOUT': '86400', 12:44:03 INFO - 'USER': 'cltbld', 12:44:03 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', 12:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:03 INFO - '_': '/tools/buildbot/bin/python'} 12:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:44:03 INFO - Running setup.py (path:/tmp/pip-WUiNGX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:44:03 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)) 12:44:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:44:03 INFO - Running setup.py (path:/tmp/pip-p6hyBL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:44:03 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)) 12:44:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:44:03 INFO - Running setup.py (path:/tmp/pip-iiMjZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:44:03 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)) 12:44:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:44:03 INFO - Running setup.py (path:/tmp/pip-RVPrWD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:44:03 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)) 12:44:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:44:03 INFO - Running setup.py (path:/tmp/pip-tBhgDd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:44:04 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)) 12:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:44:04 INFO - Running setup.py (path:/tmp/pip-zIkwmk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:44:04 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)) 12:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:44:04 INFO - Running setup.py (path:/tmp/pip-WslgaW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:44:04 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)) 12:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:44:04 INFO - Running setup.py (path:/tmp/pip-hRDghZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:44:04 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)) 12:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:44:04 INFO - Running setup.py (path:/tmp/pip-4lwyo6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:44:04 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)) 12:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:44:04 INFO - Running setup.py (path:/tmp/pip-ND4vWV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:44:04 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)) 12:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:44:04 INFO - Running setup.py (path:/tmp/pip-yDgUCH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:44:04 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)) 12:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:44:04 INFO - Running setup.py (path:/tmp/pip-q23Njs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:44:04 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)) 12:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:44:04 INFO - Running setup.py (path:/tmp/pip-N6q3tA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 12:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:44:04 INFO - Running setup.py (path:/tmp/pip-T6jjoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:44:04 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)) 12:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:44:04 INFO - Running setup.py (path:/tmp/pip-I4NJG1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:44:04 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)) 12:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:44:04 INFO - Running setup.py (path:/tmp/pip-pYBAlh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:44:04 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)) 12:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:44:04 INFO - Running setup.py (path:/tmp/pip-cLoKbD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:44:04 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)) 12:44:04 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)) 12:44:04 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)) 12:44:04 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)) 12:44:04 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)) 12:44:04 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)) 12:44:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:44:04 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 12:44:04 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 12:44:04 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 12:44:04 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 12:44:04 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 12:44:04 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 12:44:06 INFO - Downloading blessings-1.5.1.tar.gz 12:44:06 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 12:44:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:44:06 INFO - Installing collected packages: blessings 12:44:06 INFO - Running setup.py install for blessings 12:44:06 INFO - Successfully installed blessings 12:44:06 INFO - Cleaning up... 12:44:06 INFO - Return code: 0 12:44:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:44:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:44:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:44:07 INFO - Reading from file tmpfile_stdout 12:44:07 INFO - Current package versions: 12:44:07 INFO - argparse == 1.2.1 12:44:07 INFO - blessings == 1.5.1 12:44:07 INFO - blobuploader == 1.2.4 12:44:07 INFO - docopt == 0.6.1 12:44:07 INFO - manifestparser == 1.1 12:44:07 INFO - mozInstall == 1.12 12:44:07 INFO - mozcrash == 0.16 12:44:07 INFO - mozdebug == 0.1 12:44:07 INFO - mozdevice == 0.47 12:44:07 INFO - mozfile == 1.2 12:44:07 INFO - mozhttpd == 0.7 12:44:07 INFO - mozinfo == 0.9 12:44:07 INFO - mozleak == 0.1 12:44:07 INFO - mozlog == 3.1 12:44:07 INFO - moznetwork == 0.27 12:44:07 INFO - mozprocess == 0.22 12:44:07 INFO - mozprofile == 0.28 12:44:07 INFO - mozrunner == 6.11 12:44:07 INFO - mozscreenshot == 0.1 12:44:07 INFO - mozsystemmonitor == 0.0 12:44:07 INFO - moztest == 0.7 12:44:07 INFO - mozversion == 1.4 12:44:07 INFO - psutil == 3.1.1 12:44:07 INFO - requests == 1.2.3 12:44:07 INFO - wsgiref == 0.1.2 12:44:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:44: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')]} 12:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44: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')]} 12:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f0fdbeeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e7f0>, '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 0xeea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeea760>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', '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 12:44:07 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 12:44:07 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 12:44:07 INFO - Using env: {'DISPLAY': ':0', 12:44:07 INFO - 'HOME': '/home/cltbld', 12:44:07 INFO - 'LANG': 'en_US.UTF-8', 12:44:07 INFO - 'LANGUAGE': 'en_US:en', 12:44:07 INFO - 'LOGNAME': 'cltbld', 12:44:07 INFO - 'MAIL': '/var/mail/cltbld', 12:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:07 INFO - 'MOZ_NO_REMOTE': '1', 12:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:07 INFO - 'NO_EM_RESTART': '1', 12:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:07 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:07 INFO - 'SHELL': '/bin/bash', 12:44:07 INFO - 'SHLVL': '1', 12:44:07 INFO - 'TERM': 'linux', 12:44:07 INFO - 'TMOUT': '86400', 12:44:07 INFO - 'USER': 'cltbld', 12:44:07 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', 12:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:07 INFO - '_': '/tools/buildbot/bin/python'} 12:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 12:44:07 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 2)) 12:44:07 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 3)) 12:44:07 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 4)) 12:44:07 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 5)) 12:44:07 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 6)) 12:44:07 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 7)) 12:44:07 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 8)) 12:44:07 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 9)) 12:44:07 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 12:44:07 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 4)) 12:44:07 INFO - Cleaning up... 12:44:07 INFO - Return code: 0 12:44:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:44: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')]} 12:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44: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')]} 12:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0fdbeeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e7f0>, '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 0xeea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeea760>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', '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 12:44:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 12:44:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:44:07 INFO - Using env: {'DISPLAY': ':0', 12:44:07 INFO - 'HOME': '/home/cltbld', 12:44:07 INFO - 'LANG': 'en_US.UTF-8', 12:44:07 INFO - 'LANGUAGE': 'en_US:en', 12:44:07 INFO - 'LOGNAME': 'cltbld', 12:44:07 INFO - 'MAIL': '/var/mail/cltbld', 12:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:07 INFO - 'MOZ_NO_REMOTE': '1', 12:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:07 INFO - 'NO_EM_RESTART': '1', 12:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:07 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:07 INFO - 'SHELL': '/bin/bash', 12:44:07 INFO - 'SHLVL': '1', 12:44:07 INFO - 'TERM': 'linux', 12:44:07 INFO - 'TMOUT': '86400', 12:44:07 INFO - 'USER': 'cltbld', 12:44:07 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', 12:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:07 INFO - '_': '/tools/buildbot/bin/python'} 12:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:07 INFO - Downloading/unpacking jsonschema 12:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:44:09 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 12:44:09 INFO - Downloading/unpacking functools32 (from jsonschema) 12:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:09 INFO - Downloading functools32-3.2.3-2.tar.gz 12:44:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:44:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:44:09 INFO - warning: no files found matching '*.txt' 12:44:09 INFO - no previously-included directories found matching 'build' 12:44:09 INFO - no previously-included directories found matching 'dist' 12:44:09 INFO - no previously-included directories found matching '.git*' 12:44:09 INFO - Installing collected packages: jsonschema, functools32 12:44:09 INFO - Running setup.py install for functools32 12:44:09 INFO - warning: no files found matching '*.txt' 12:44:09 INFO - no previously-included directories found matching 'build' 12:44:09 INFO - no previously-included directories found matching 'dist' 12:44:09 INFO - no previously-included directories found matching '.git*' 12:44:09 INFO - Successfully installed jsonschema functools32 12:44:09 INFO - Cleaning up... 12:44:09 INFO - Return code: 0 12:44:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0fdbeeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e7f0>, '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 0xeea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeea760>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', '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 12:44:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 12:44:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:44:09 INFO - Using env: {'DISPLAY': ':0', 12:44:09 INFO - 'HOME': '/home/cltbld', 12:44:09 INFO - 'LANG': 'en_US.UTF-8', 12:44:09 INFO - 'LANGUAGE': 'en_US:en', 12:44:09 INFO - 'LOGNAME': 'cltbld', 12:44:09 INFO - 'MAIL': '/var/mail/cltbld', 12:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:09 INFO - 'MOZ_NO_REMOTE': '1', 12:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:09 INFO - 'NO_EM_RESTART': '1', 12:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:09 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:09 INFO - 'SHELL': '/bin/bash', 12:44:09 INFO - 'SHLVL': '1', 12:44:09 INFO - 'TERM': 'linux', 12:44:09 INFO - 'TMOUT': '86400', 12:44:09 INFO - 'USER': 'cltbld', 12:44:09 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', 12:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:09 INFO - '_': '/tools/buildbot/bin/python'} 12:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:09 INFO - Downloading/unpacking flake8 12:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:44:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 12:44:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:44:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 12:44:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 12:44:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:44:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:44:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:44:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:44:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:44:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:44:12 INFO - no previously-included directories found matching 'docs/_build' 12:44:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:44:12 INFO - Running setup.py install for pep8 12:44:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:44:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:44:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:44:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:44:12 INFO - no previously-included directories found matching 'docs/_build' 12:44:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:44:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:44:12 INFO - Cleaning up... 12:44:12 INFO - Return code: 0 12:44:12 INFO - Running post-action listener: _resource_record_post_action 12:44:12 INFO - Running post-action listener: _start_resource_monitoring 12:44:12 INFO - Starting resource monitoring. 12:44:12 INFO - ##### 12:44:12 INFO - ##### Running install step. 12:44:12 INFO - ##### 12:44:12 INFO - Running pre-action listener: _resource_record_pre_action 12:44:12 INFO - Running main action method: install 12:44:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:44:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:44:12 INFO - Reading from file tmpfile_stdout 12:44:12 INFO - Detecting whether we're running mozinstall >=1.0... 12:44:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:44:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:44:12 INFO - Reading from file tmpfile_stdout 12:44:12 INFO - Output received: 12:44:12 INFO - Usage: mozinstall [options] installer 12:44:12 INFO - Options: 12:44:12 INFO - -h, --help show this help message and exit 12:44:12 INFO - -d DEST, --destination=DEST 12:44:12 INFO - Directory to install application into. [default: 12:44:12 INFO - "/builds/slave/test-pgo"] 12:44:12 INFO - --app=APP Application being installed. [default: firefox] 12:44:12 INFO - mkdir: /builds/slave/test-pgo/build/application 12:44:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 12:44:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 12:44:28 INFO - Reading from file tmpfile_stdout 12:44:28 INFO - Output received: 12:44:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:44:28 INFO - Running post-action listener: _resource_record_post_action 12:44:28 INFO - ##### 12:44:28 INFO - ##### Running run-tests step. 12:44:28 INFO - ##### 12:44:28 INFO - Running pre-action listener: _resource_record_pre_action 12:44:28 INFO - Running main action method: run_tests 12:44:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:44:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:44:28 INFO - Python 2.7.3 12:44:28 INFO - Return code: 0 12:44:28 INFO - grabbing minidump binary from tooltool 12:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:28 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 0xf7e7f0>, '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 0xeea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeea760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:44:28 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 12:44:28 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 12:44:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:44:28 INFO - Return code: 0 12:44:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:44:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:44:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:44:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:44:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:44:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:44:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:44:29 INFO - Return code: 0 12:44:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 12:44:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:44:29 INFO - Using env: {'DISPLAY': ':0', 12:44:29 INFO - 'HOME': '/home/cltbld', 12:44:29 INFO - 'LANG': 'en_US.UTF-8', 12:44:29 INFO - 'LANGUAGE': 'en_US:en', 12:44:29 INFO - 'LOGNAME': 'cltbld', 12:44:29 INFO - 'MAIL': '/var/mail/cltbld', 12:44:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:44:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:29 INFO - 'MOZ_NO_REMOTE': '1', 12:44:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:29 INFO - 'NO_EM_RESTART': '1', 12:44:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:29 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:44:29 INFO - 'SHELL': '/bin/bash', 12:44:29 INFO - 'SHLVL': '1', 12:44:29 INFO - 'TERM': 'linux', 12:44:29 INFO - 'TMOUT': '86400', 12:44:29 INFO - 'USER': 'cltbld', 12:44:29 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794', 12:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:29 INFO - '_': '/tools/buildbot/bin/python'} 12:44:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:44:29 INFO - mozversion application_buildid: 20151230103013 12:44:29 INFO - mozversion application_changeset: 84479159751f5517950730506875887b9f22d1c9 12:44:29 INFO - mozversion application_display_name: Nightly 12:44:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:44:29 INFO - mozversion application_name: Firefox 12:44:29 INFO - mozversion application_remotingname: firefox 12:44:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:44:29 INFO - mozversion application_vendor: Mozilla 12:44:29 INFO - mozversion application_version: 46.0a1 12:44:29 INFO - mozversion platform_buildid: 20151230103013 12:44:29 INFO - mozversion platform_changeset: 84479159751f5517950730506875887b9f22d1c9 12:44:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:44:29 INFO - mozversion platform_version: 46.0a1 12:44:29 INFO - using testdate: 1451508269 12:44:29 INFO - actual date: 1451508269 12:44:29 INFO - starting webserver on 'localhost:40401' 12:44:29 INFO - SUITE-START | Running 3 tests 12:44:29 INFO - TEST-START | dromaeo_css 12:44:29 INFO - operating with platform_type : linux_ 12:44:29 INFO - Initialising browser for dromaeo_css test... 12:44:29 INFO - TEST-INFO | started process 4027 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmcMbHf/profile http://localhost:40401/getInfo.html) 12:44:34 INFO - PROCESS | 4027 | __metrics Screen width/height:1600/1200 12:44:34 INFO - PROCESS | 4027 | colorDepth:24 12:44:34 INFO - PROCESS | 4027 | Browser inner width/height: 1024/697 12:44:34 INFO - PROCESS | 4027 | __metrics 12:44:34 INFO - PROCESS | 4027 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:44:35 INFO - TEST-INFO | 4027: exit 0 12:44:35 INFO - Browser initialized. 12:44:35 INFO - Running cycle 1/1 for dromaeo_css test... 12:44:35 INFO - TEST-INFO | started process 4159 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmcMbHf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:44:47 INFO - PROCESS | 4159 | RSS: Main: 150188032 12:44:47 INFO - PROCESS | 4159 | 12:45:36 INFO - PROCESS | 4159 | 1451508336769 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] 12:47:45 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:40401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40401/tests/dromaeo/cssquery-ext.html) 12:47:46 INFO - PROCESS | 4159 | RSS: Main: 158748672 12:47:46 INFO - PROCESS | 4159 | 12:50:48 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:40401/tests/dromaeo/cssquery-ext.html (next: http://localhost:40401/tests/dromaeo/cssquery-jquery.html) 12:50:49 INFO - PROCESS | 4159 | RSS: Main: 153559040 12:50:49 INFO - PROCESS | 4159 | 12:53:51 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:40401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40401/tests/dromaeo/cssquery-mootools.html) 12:53:51 INFO - PROCESS | 4159 | RSS: Main: 154144768 12:53:51 INFO - PROCESS | 4159 | 12:56:53 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:40401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40401/tests/dromaeo/cssquery-prototype.html) 12:56:54 INFO - PROCESS | 4159 | RSS: Main: 152641536 12:56:54 INFO - PROCESS | 4159 | 12:59:56 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:40401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40401/tests/dromaeo/cssquery-yui.html) 12:59:57 INFO - PROCESS | 4159 | RSS: Main: 153636864 12:59:57 INFO - PROCESS | 4159 | 13:02:59 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:40401/tests/dromaeo/cssquery-yui.html (next: http://localhost:40401/tests/dromaeo/cssquery-dojo.html) 13:02:59 INFO - PROCESS | 4159 | RSS: Main: 155820032 13:02:59 INFO - PROCESS | 4159 | 13:02:59 INFO - PROCESS | 4159 | __start_tp_report 13:02:59 INFO - PROCESS | 4159 | _x_x_mozilla_page_load 13:02:59 INFO - PROCESS | 4159 | _x_x_mozilla_page_load_details 13:02:59 INFO - PROCESS | 4159 | |i|pagename|runs| 13:02:59 INFO - PROCESS | 4159 | |0;dojo.html;3156.1793933577264;3201.711845933864;3235.9676403235962;3245.5618491503647;3249.350129974006;5187.766550505227;5295.258663787073;5328.600354973378;5337.626366154371;5341.89316213676;5256.211568264762;5278.524932756051;5302.337207849019;5326.414094449608;5366.91949620756;4527.139843429754;4811.711297322155;4940.802367905298;4976;4976.079425306312;4802.447718512363;4865.391826021747;4932.704037757746;4933.7286449245275;4943.6539442239055;4843.443004054526;4881.145799485076;4911;4920.237363208708;4956.355673762424;4870.732109733964;4883.389576302962;4905.566352718401;4919.893024069592;4925.75371231437;4795.856124316276;4870.512948705136;4873.122837889178;4895.094407534618;4915.950840491585;5063.544281014726;5143.228515722634;5152.793888244466;5154.149565321717;5163.922541161885;5792.044312688401;5792.275965504312;5793.652380857162;5798.1302804579655;5802.738876750556;5792.739326730307;5798.768049278024;5804.187413762077;5813.273340832396;5814.709264536757;5275.472452754694;5368.489993450655;5374.408815030343;5376.704281264529;5420.783168673248;5710.057840456278;5807.303123625192;5822.301323841166;5876.177335173079;5902.026165682614;5639.041362968305;5677.091665333527;5694.715264236772;5710.600257981984;5730.627509211888;5652.067408877571;5704.572157088235;5749.223854779635;5763.337216220189;5771.769129234784;5589.720513974285;5693.857653558612;5748;5764.538836893039;5804.506616937608;5679.375268720438;5689.459501347365;5690.715464226772;5699.145128230799;5714.485696287354;4339.848105316299;4414.249577571821;4415.315626077963;4424.225760491901;4474;3939;3975.6223158799867;3982.681385489154;3999.920001599952;4010.9972506873282;5275.5515781158265;5300.231466437345;5301.787928482895;5306.8142615009065;5344.171653393652;5610.579206559524;5688.06146985751;5689.68706721126;5731.8567035824435;5745.626534275259;5380.91928621071;5411.404745477994;5415.187721841755;5426.213199086111;5433.402325744165;4876.6930204626215;4883.316335713003;4918.508149185053;4921.926171107365;4961.032598643302;5625.578081643893;5698.487136157766;5805.7387417566315;5907.852303692442;5938.406159384027;5687.459691329317;5693.174489699053;5720.914186287126;5756.625819321731;5762.798302059407;5843.2695913010875;5845.269341332333;5849.298084229919;5849.444302791228;5862.443067908542;5554.222408862682;5646.3506696728755;5662.292213473316;5717.914231286451;5760.94239057604;5749.252597162342;5754.51086657622;5760.539156867357;5764.394738552559;5770.019096753478;5442.401335852974;5580.665160090408;5589.077802162597;5593.440655934374;5598.188262701967;5525.4474552546035;5631.183478395692;5684.971575142098;5699.401562836008;5724.513416359656;5515.420880807457;5516.117421212587;5518.227448157341;5518.44815518461;5552.167174923794;5500.312460942382;5600.131979543177;5634.408387119293;5660.264165658603;5661.2923384576925;5510.448955104457;5536.418676039119;5577.525910297508;5585.134304182858;5586.441355864381 13:02:59 INFO - PROCESS | 4159 | |1;ext.html;553.3359968038355;555.7221389305348;564.4524810933393;568.4628026514944;599.9141553787645;35929.64070359296;37207.81396093022;37212.81393593035;37296.62703372965;37303.626963730356;40257.77937764979;40397;40507.39238911419;40690.59309406905;40935.38596921049;8423.494590324584;8603.612837422299;8626.35302352323;8648.481091134521;8662.177093176138;8415.70545030924;8573.228409443149;8579;8725;8766.912330876705;8780.560971951409;8828.24959878408;8854.955725221365;8885.95557022214;8891.68879089232;8733.12668733128;8817.691380801705;8823.985241697223;8827.33794965377;8832.69085582008;8467.576621168917;8585.484870907703;8624.741257762276;8643.65425382984;8666.653333866638;39746.403803942965;40078.79960600178;40137.799311003255;40202.39696404556;40223.59776402257;3138.1997590614246;3169.3027533942495;3175.301433684586;3272.427325218101;3299.686529779667;29725.256868578243;29915.850420747975;30059.248518786986;30538.389232215453;30611.540826887616;3670.284294562561;3703.092742278132;3721.3301605710963;3770.8310423768444;3773;263588;264472;264833;265088;265574;53673;55089.72455137779;60035;60243.39756602466;62009;56533.152002719995;56760.43239567634;57074.42925570691;57135.714321428124;57240.42759572351;15508.379664813507;15623;15719.528414147593;15729.921350393175;15770.211489425712;11667.708307292385;11703.88296117045;11839.11206659504;11840.289582624897;11852.762944741056;19424.12591433389;19773.60452790965;20255.392338229878;20275.46556680415;20400.693989590167;7222.927770722225;7344.6412413702565;7449.925500744923;7478.813029674193;7542.245775422414;873.7160422862595;878.7056336127469;972.6060945317158;1030.1912998296302;1047.512906498482;25334.873325633253;25639.615405768927;25829.095981640552;25868.870655646602;28434.431311373657;1006.9043440873105;1027.671145233533;1080.8865069167782;1137.8919002694731;1174.5595401724354;14271.64320891986;14667.77998330026;14773.409063637335;15935.920320398323;16414.179291035638;319399;322491;322680;323108;323465;52809.47190528122;53394.19908701372;53502.46497535053;53516.46483535193;53518;1323.9139455935526;1374.656335916021;1378.5864240727742;1382.6059573021842;1384.9307534623229;28798.424031519673;29508.114756557337;29766.553501697927;30120.397592048474;30662.386752265276;46774.53225467702;46805.76597116992;47402.288965664855;47491.28763068626;47607.76196118997;294278;298167;299373;299403;299793;31810.52284215785;32145.517817233227;32759.344813104082;32972;33041;38759.806200968815;41183.176336472505;42124.15751685011;42421.575784242996;42491;34718.47922281218;35242;35287.470687940215;35597;35923.46114808332;35564.466533002545;35569.64430355663;36445.27109457849;36455.27089458249;36477.63522364849;34942.30115397627;35060;35159.47260791141;35404;35507.82246088753;31312.686873130977;32225.677743222266;32609.347813043132;32836.67163328336;33029.33941321208;24514.75485245196;24820.91227930681;24912.750872491044;25004;25175.8530183727 13:02:59 INFO - PROCESS | 4159 | |2;jquery.html;345.7234212629895;358.9964100358997;359.0789624612868;359.11286191065943;362.7660159197317;16609.33562657494;16705.164741762925;17238.65522689547;17553.210105545248;18345;16163.676726465465;16500.917495412537;16574.50276491704;16784.66430671389;16799.580010499743;4883.194272944968;5009.599232061426;5015.04714104319;5019.322391477159;5025.246213068032;4393;4990.451050384455;5051.318072060261;5055.69665820052;5056.418511871127;5074.822381216658;5241.213817927322;5270.92093618596;5379.596530260226;5408.486193811582;5161.967606478719;5244.527992480676;5247.737613119348;5276.234945932837;5454.809081682122;5276.947230527684;5281.683099014072;5287.391949925769;5292.179712144623;5308.973455132699;12546.874531254662;13115.606531804062;19885;20137.697934530996;20326.390208293775;1961.744973153481;1997.1611922992233;2004.7694515130654;2039.51051747581;2094.4554415851835;9474.289428292906;9631.662891798753;9682.467464289532;9710.223182145412;9785.461799601018;1834.2937968881943;1840.74229607855;1860.6092720528704;1901.372547059481;1914.1386376130797;58174;60758.08862867061;61766;61974.38025619731;62091;10180.287379883484;10311.278210525341;10389.636362727419;10417.270791044706;10419.687409377731;13530.188188708513;13565.186088834702;13611.795823062663;13633.045686801828;13653.590392288248;7742.7677169685;7749.302562769378;7750.612469376621;7766.145723970359;7851.057873055156;7400.074990626172;7486.812829679302;7491.063617047869;7496.962515187389;7543.283388078124;4423.137488189836;4426.623736982393;4436.511983681792;4458.710183838105;4483.19302525542;1684.8062472815539;1759.5161330633923;1777.742227377023;1788.3383148235237;1838.9540261493569;899.4513346858411;932.5383934952107;947.7441090905555;1051.784384201237;1056.5404049238605;15948.840511594735;16067.357305707641;16071.919640401957;16454.83545164557;16548.669026619402;932.7155217658543;951.9286053546011;989.7030890732896;1024.2881197567767;1024.5594394410475;9362.438253704664;9728.124468797841;9795;9973.800523989625;10149.34029288094;494014;506655;512737;524936;584321;82727.17272827314;84543.5772821132;85009;86159.5692021536;88071.55964220266;1150.4592841364545;1167.3404526442532;1167.8948894599528;1178.0693252330564;1181.6927598824368;15656.217189140725;15765.166574498768;15803.683926321179;16097.356105756107;16246.837531625006;19351.90324048371;23643.52712945766;27890;36712;37578;47530.049399011135;47814.760926195144;48671.5132848667;49900.50099498958;51177.488225117275;9346.766330841783;9567.473788941676;9771.755706107404;9812.950935245279;9849.409035457895;16979.575510611838;17599.736003960206;17758.37845675395;18122.81877181211;18157.727634085237;11049.447527623426;12378.071644626869;14007.789883151965;14619.780703289673;14808.555743327717;9501.857472138061;9605;14300.427982880568;14692.779608306098;14710.705785884436;9994.10053095225;10659.46702664848;10790.784184316426;10791.838122428328;10897.128229741444;15092.39630414771;15142.772858407354;15356.616084597528;15804.209789510709;15835;15909.284082216096;16375.918120409322;16386.344546218017;16851.41020064292;16952.915235423745 13:02:59 INFO - PROCESS | 4159 | |3;mootools.html;1423.2815322733582;1440.0783498560922;1556.5952852258417;1714.3828221840135;1745.458907738602;7356.1540422851385;7374.188839227681;7516.098068231813;7620.771376858696;7645.541267523946;7525.811854703635;7614.809629759259;7693.576853273068;7710.730124445646;7720.7297744578955;2161.124744478485;2191.068795761803;2196.494806194576;2198.4723666320047;2203.6253836847695;2213.0815711479795;2220.666899965002;2221.433534448713;2225.0209907640588;2243.842930994831;1911.1877452082879;1946.5814849807289;2207.7461091974387;2208.8895555222257;2231.564844855254;2188.6498160294277;2204.250554811372;2206.6138425775584;2206.933791986243;2213.8671679699187;2168.490404754881;2216.645336746129;2228.4874478869788;2230.888455577231;2233.363491404958;7600.201978792203;7641.617919104078;7648.502847314907;7653.387728981668;7663.042119735033;4547.727136371828;4573;4603.5396460353695;4605.194091034089;4635.212013957602;2930.7069293070736;2949.351142748592;3035.2411897025745;3061.9234519136976;3062.4640687879755;961.8412961861354;966.8694726211942;982;994.8010397920444;1030.4847576211894;10047.799044019079;10089.293749437542;10108.595656173818;10139.39163650176;10178.541965611565;3961.74248673841;3967.821448034845;4008.318585840414;4022.8189731462153;4063.4717486726536;8284.212999765012;8299.087100418948;8335.166483351617;8350.206730360605;8360.45657032291;4500.459944806644;4507.909841803145;4521.525239849834;4531.048479819209;4578.084383123389;4129.69027322952;4168.91662166761;4175.457190565267;4183.6234738873645;4191.706580539333;3259.9674003259665;3268.313654132611;3272.787268827519;3291.7860339077884;3295.802251864896;1030.7526193713454;1041.063043261056;1044.6552637629563;1059.682095371401;1060.522764755863;942.8020115775627;982.975425614351;1002.8144793213133;1109.2734259060328;1181.5273890443718;6764.255931847493;6926.515143939977;6941.34057264559;6943.548669336477;6954.617496037666;613.8649497110629;638.2054342343812;639.3925770518026;641.8331233879225;775.9456838021284;5139.820106296262;5253.684778913201;5293.12663410533;5358.4373640767935;5370.489803468742;8898.243649289754;9100.135487128713;9200.4479731215;9244.953775231215;9270.119338662817;8108.351331893435;8290.129536398712;8297.12880147588;8331.083580806106;8357.58212089393;7172.493776307034;7191.17301510333;7241.746538871114;7293.197748247795;7299.89050164248;7006.124234470692;7182.174049984319;7207.171175314906;7212.74755383559;7217.097862767154;7938.364930805406;8037.19628037215;8082.515049097073;8116.2695357418115;8189.7133600323705;7912.802179945547;8118.350531957311;8227.917720822716;8434;8511.276541494042;6522.641254731036;6554.344565543598;6560.3111673275525;6560.8359791005605;6575.50683698715;7138.964305178441;7238.335182907856;7279.417646588155;7294.817629559304;7309.451791115794;6936.895946560705;6957.895631565631;7137.857242855218;7150.42796576283;7155.356017958408;6072.089186622042;6197.690115494117;6593.505487088391;7002.5798452091;7045.189803172496;6628.337166283333;6703.798886033427;6720.865582688417;6726.8654626908165;6728.529002969745;6273.811785646438;6297.275813281348;6329.778457753957;6332.081848131903;6358.950773122383;6242.032484964838;6359.713812878339;6364.363563643598;6380.298167201697;6385.648789316632 13:02:59 INFO - PROCESS | 4159 | |4;prototype.html;341.16244619459223;347.8173958671697;352.3077153393581;352.36046575465514;353.11192351236645;6315.621062736233;6358.554901156921;6365.45893599044;6368.745250189987;6545.083688283644;6304.33804450533;6348.809535713925;6355.936440635593;6366.172397588307;6367.076773867786;4811.783469743861;4811.951880481203;4812.614990800727;4812.975935120319;4821.397325334333;4813.253945638432;4826.131296366652;4830.1788695921605;4830.985493046464;4838.685485443452;4675.789589468465;4757.714537127766;4757.9286310705365;4767.5709186173235;4778.713277203362;4741.620670346381;4742.881427964294;4744.7627618618935;4758.262469317244;4762.857114286577;4096.56986016467;4105.527864295615;4114.91770164598;4125.29869922114;4126.277901367249;6051.152838602599;6056.545759068087;6084.878302433971;6088.208532890741;6096.390360963868;5374.462553744634;5484.314460692413;5499.322706574493;5545.112781954908;5550.27846379972;6679.666016699146;6698.531102822804;6706.463482921404;6707.631080290582;6739.494537909627;4519.186546421643;4520.412346394981;4533.478649955231;4539.954600454019;4548.931766023512;6774.966125169342;6906.620135892524;6966.4078553323025;6968.233494315672;6978.720851165947;4577.176108300538;4597.42532183477;4599.103174880933;4607.009492958963;4636;4680.204365257914;4680.789364478606;4686.133065382915;4695.201815691341;4698.2247929092;5443.237946687467;5488.341399032141;5499.340079190522;5499.477549632778;5501.064818980783;6632.966835165793;6777.322267773183;6791.762288319885;6794.388505034571;6806.387425131663;1628.3974929276244;1648.044134402044;1693.8729595280404;1699.447679504166;1699.4561740243003;1072.6299426697776;1104.9226554141133;1121.5681962444517;1123.4495097402214;1127.6335191062938;6212.844678883064;6254.937450625435;6257.78097766576;6258.749650013949;6263.404976527223;6801.387875091166;6819.181698196248;6830.556013859183;6846.075779769667;6851.588904665736;6100.176476175749;6222;6227.408396202353;6241.719122639402;6242.843928901723;3718.8326525306425;3723.6648701616987;3730.0301921500063;3736.2439653362876;3738.6074462181077;6934.954188514401;7042.084529011298;7066.893996590055;7069.278327843715;7077.292270772881;6977.93022069783;7054.541454805421;7055.647217639097;7062.505624606229;7100.573965562083;7088.539244949062;7098.893516597255;7159.355657990805;7234.819129521804;7270.527415717961;6981.755638552626;7001.824954376181;7016.824579385352;7019.789406317818;7020.262872398324;6829.6243706596615;6858.451323894176;6909.44724422035;6930.272321406382;6972.79081627552;7121.9643901780155;7183.604901730455;7191.7842464726145;7197.064381630355;7199.208087110309;4662.976685116552;4680;4717.811287548597;4727.125481785881;4733.431988161305;6832.316768323128;7001.50989430735;7027.22700502934;7029.718811247493;7033.929660703532;6808.93191068083;6813.3527314905;6830.897536537055;6857.382835544825;6870.519063665495;6796.626185559644;6829.52193346461;6833.111695479556;6836.418904392984;6839.213490448662;6574.342565743387;6651.900221496585;6670.733170673118;6702.798916032527;6713.093732346266;6794.388505034571;6871.9656401717675;6872.965635171792;6876.209235937931;6888.827779305558;6653.035309880137;6675.365840245169;6681.599104053772;6681.933180668326;6684.732610695518 13:02:59 INFO - PROCESS | 4159 | |5;yui.html;709.2517394149173;730.4156674660273;738.2064280898035;763.9656215470303;880.3969281042484;12601;12781.680457988543;12834.229946203212;12929.353532323381;15462.149581772997;14883.553493395188;15015.249237538133;15041.6991660167;15049.548513544583;15050.623734406645;839.8908141941539;840.2437805974611;854.4830377621543;860.8106216632331;862.7929296968745;819.4345901328064;828.45736042892;829.9668013279462;831.4221615976899;834.2575108153748;878.1262643669526;887.2547060469204;892.955352232389;893.6604090445621;895.212213252337;884.6726711116863;886;886.3883920095113;888.8488956877314;889.5907882374115;645.3997782062727;647.0682217606632;647.5305403582412;647.9222493300834;649.3149727037973;13904.860951390458;14061.437542498288;14065.80440662545;14114.153150810984;14126;12175.147739658227;12662.36688165588;12791.5522956697;13021.088523803337;13510.527131550349;10254.846177307347;10320;10328.32865863724;10418.635347762867;10431.634892778717;3607.062163837421;3635.618260082706;3641.836117374698;3660.4509323601405;3784.678302344304;48403.27395089076;49037.75481122607;49039.264411033866;49042;49083.26375104376;9806.803863922682;9893.65372211969;9951.701448956543;10062.647807326708;10196.541155648014;18366.90816545909;19141.712874306897;19416.805831941783;19476.318328858422;19521.414357569294;7742.8838567421535;7749.7287594933905;7805.453618246668;7820.296173344313;7894.171112033154;4296.4414626098405;4438.866833994985;4450.109978004347;4483.955160448419;4485.1702435048965;3174.158847905307;3203.4554125798672;3211.4219440500465;3214.8392580370887;3229.7739158259164;558.1934105217921;581.3111462916457;588.5262363797099;591.3672370563456;600.1957377114687;599.5263741644139;692.536000879412;695.2873304862557;699.3356311504092;713.7430525010992;7887.881681774778;7938.9206107939335;8204.179582041868;8254.628541715638;8384.580770961427;511.8771494841211;533.6131304804063;672.7409947170277;686.1526015371013;695.7495301691387;3634.7092232621326;3793.7534060285993;4016.096378314856;4041.4231031720174;4129.958700413017;50576.24135637969;52289.47710522922;52784.73607632014;53274.73362633162;53464.19803702948;46522.99999999932;46694.29958550625;46855;47055.29417058747;47349;43983;43999;44840;45101;45826.5417345829;7915.604219788872;8007.599620019092;8145.918540814753;8223.77539302265;8243.299319557906;33938.830305848314;34226.65773342235;34782.65217347794;34872;34930.825345874124;40393;41282.587174127875;41679;43686.344704828814;43695.56304437042;10666.786664266516;10766.407847568458;10772.289036875;11324.150688698215;11769.588064417705;12695.174813637084;12847.614571562868;12907.741845162856;12983.870161298266;13334.931647112002;10714.357138571711;10800.567977280822;10993.985643148148;11127.499262533367;11639.127065469955;11392.715182120513;12044.819327709916;12099.274043557414;12398.5660501882;12402.503899843905;11499.942500287445;11777.175597708077;12039.578614748792;12189.69525761863;12191.512339506675;9895.962717489638;9966.700998970042;10019.448930308903;10352.844707329547;10519;8835.381523293308;8976.192142706926;9117.635294588143;9651.758706032124;9724.173445257233 13:02:59 INFO - PROCESS | 4159 | __end_tp_report 13:02:59 INFO - PROCESS | 4159 | __start_cc_report 13:02:59 INFO - PROCESS | 4159 | _x_x_mozilla_cycle_collect,306 13:02:59 INFO - PROCESS | 4159 | __end_cc_report 13:02:59 INFO - PROCESS | 4159 | __startTimestamp1451509379767__endTimestamp 13:02:59 INFO - PROCESS | 4159 | 13:02:59 INFO - PROCESS | 4159 | ------- Summary: start ------- 13:02:59 INFO - PROCESS | 4159 | Number of tests: 6 13:02:59 INFO - PROCESS | 4159 | 13:02:59 INFO - PROCESS | 4159 | [#0] dojo.html Cycles:165 Average:5315.74 Median:5525.45 stddev:581.58 (10.5%) stddev-sans-first:558.15 13:02:59 INFO - PROCESS | 4159 | Values: 3156.2 3201.7 3236.0 3245.6 3249.4 5187.8 5295.3 5328.6 5337.6 5341.9 5256.2 5278.5 5302.3 5326.4 5366.9 4527.1 4811.7 4940.8 4976.0 4976.1 4802.4 4865.4 4932.7 4933.7 4943.7 4843.4 4881.1 4911.0 4920.2 4956.4 4870.7 4883.4 4905.6 4919.9 4925.8 4795.9 4870.5 4873.1 4895.1 4916.0 5063.5 5143.2 5152.8 5154.1 5163.9 5792.0 5792.3 5793.7 5798.1 5802.7 5792.7 5798.8 5804.2 5813.3 5814.7 5275.5 5368.5 5374.4 5376.7 5420.8 5710.1 5807.3 5822.3 5876.2 5902.0 5639.0 5677.1 5694.7 5710.6 5730.6 5652.1 5704.6 5749.2 5763.3 5771.8 5589.7 5693.9 5748.0 5764.5 5804.5 5679.4 5689.5 5690.7 5699.1 5714.5 4339.8 4414.2 4415.3 4424.2 4474.0 3939.0 3975.6 3982.7 3999.9 4011.0 5275.6 5300.2 5301.8 5306.8 5344.2 5610.6 5688.1 5689.7 5731.9 5745.6 5380.9 5411.4 5415.2 5426.2 5433.4 4876.7 4883.3 4918.5 4921.9 4961.0 5625.6 5698.5 5805.7 5907.9 5938.4 5687.5 5693.2 5720.9 5756.6 5762.8 5843.3 5845.3 5849.3 5849.4 5862.4 5554.2 5646.4 5662.3 5717.9 5760.9 5749.3 5754.5 5760.5 5764.4 5770.0 5442.4 5580.7 5589.1 5593.4 5598.2 5525.4 5631.2 5685.0 5699.4 5724.5 5515.4 5516.1 5518.2 5518.4 5552.2 5500.3 5600.1 5634.4 5660.3 5661.3 5510.4 5536.4 5577.5 5585.1 5586.4 13:02:59 INFO - PROCESS | 4159 | 13:02:59 INFO - PROCESS | 4159 | [#1] ext.html Cycles:180 Average:46306.43 Median:35567.06 stddev:77348.00 (217.5%) stddev-sans-first:77488.70 13:02:59 INFO - PROCESS | 4159 | Values: 553.3 555.7 564.5 568.5 599.9 35929.6 37207.8 37212.8 37296.6 37303.6 40257.8 40397.0 40507.4 40690.6 40935.4 8423.5 8603.6 8626.4 8648.5 8662.2 8415.7 8573.2 8579.0 8725.0 8766.9 8780.6 8828.2 8855.0 8886.0 8891.7 8733.1 8817.7 8824.0 8827.3 8832.7 8467.6 8585.5 8624.7 8643.7 8666.7 39746.4 40078.8 40137.8 40202.4 40223.6 3138.2 3169.3 3175.3 3272.4 3299.7 29725.3 29915.9 30059.2 30538.4 30611.5 3670.3 3703.1 3721.3 3770.8 3773.0 263588.0 264472.0 264833.0 265088.0 265574.0 53673.0 55089.7 60035.0 60243.4 62009.0 56533.2 56760.4 57074.4 57135.7 57240.4 15508.4 15623.0 15719.5 15729.9 15770.2 11667.7 11703.9 11839.1 11840.3 11852.8 19424.1 19773.6 20255.4 20275.5 20400.7 7222.9 7344.6 7449.9 7478.8 7542.2 873.7 878.7 972.6 1030.2 1047.5 25334.9 25639.6 25829.1 25868.9 28434.4 1006.9 1027.7 1080.9 1137.9 1174.6 14271.6 14667.8 14773.4 15935.9 16414.2 319399.0 322491.0 322680.0 323108.0 323465.0 52809.5 53394.2 53502.5 53516.5 53518.0 1323.9 1374.7 1378.6 1382.6 1384.9 28798.4 29508.1 29766.6 30120.4 30662.4 46774.5 46805.8 47402.3 47491.3 47607.8 294278.0 298167.0 299373.0 299403.0 299793.0 31810.5 32145.5 32759.3 32972.0 33041.0 38759.8 41183.2 42124.2 42421.6 42491.0 34718.5 35242.0 35287.5 35597.0 35923.5 35564.5 35569.6 36445.3 36455.3 36477.6 34942.3 35060.0 35159.5 35404.0 35507.8 31312.7 32225.7 32609.3 32836.7 33029.3 24514.8 24820.9 24912.8 25004.0 25175.9 13:02:59 INFO - PROCESS | 4159 | 13:02:59 INFO - PROCESS | 4159 | [#2] jquery.html Cycles:180 Average:28497.74 Median:352.36 stddev:85991.89 (24404.6%) stddev-sans-first:86207.14 13:02:59 INFO - PROCESS | 4159 | Values: 345.7 359.0 359.1 359.1 362.8 16609.3 16705.2 17238.7 17553.2 18345.0 16163.7 16500.9 16574.5 16784.7 16799.6 4883.2 5009.6 5015.0 5019.3 5025.2 4393.0 4990.5 5051.3 5055.7 5056.4 5074.8 5241.2 5270.9 5379.6 5408.5 5162.0 5244.5 5247.7 5276.2 5454.8 5276.9 5281.7 5287.4 5292.2 5309.0 12546.9 13115.6 19885.0 20137.7 20326.4 1961.7 1997.2 2004.8 2039.5 2094.5 9474.3 9631.7 9682.5 9710.2 9785.5 1834.3 1840.7 1860.6 1901.4 1914.1 58174.0 60758.1 61766.0 61974.4 62091.0 10180.3 10311.3 10389.6 10417.3 10419.7 13530.2 13565.2 13611.8 13633.0 13653.6 7742.8 7749.3 7750.6 7766.1 7851.1 7400.1 7486.8 7491.1 7497.0 7543.3 4423.1 4426.6 4436.5 4458.7 4483.2 1684.8 1759.5 1777.7 1788.3 1839.0 899.5 932.5 947.7 1051.8 1056.5 15948.8 16067.4 16071.9 16454.8 16548.7 932.7 951.9 989.7 1024.3 1024.6 9362.4 9728.1 9795.0 9973.8 10149.3 494014.0 506655.0 512737.0 524936.0 584321.0 82727.2 84543.6 85009.0 86159.6 88071.6 1150.5 1167.3 1167.9 1178.1 1181.7 15656.2 15765.2 15803.7 16097.4 16246.8 19351.9 23643.5 27890.0 36712.0 37578.0 47530.0 47814.8 48671.5 49900.5 51177.5 9346.8 9567.5 9771.8 9813.0 9849.4 16979.6 17599.7 17758.4 18122.8 18157.7 11049.4 12378.1 14007.8 14619.8 14808.6 9501.9 9605.0 14300.4 14692.8 14710.7 9994.1 10659.5 10790.8 10791.8 10897.1 15092.4 15142.8 15356.6 15804.2 15835.0 15909.3 16375.9 16386.3 16851.4 16952.9 13:02:59 INFO - PROCESS | 4159 | 13:02:59 INFO - PROCESS | 4159 | [#3] mootools.html Cycles:180 Average:5228.31 Median:3509.25 stddev:2717.80 (77.4%) stddev-sans-first:2710.38 13:02:59 INFO - PROCESS | 4159 | Values: 1423.3 1440.1 1556.6 1714.4 1745.5 7356.2 7374.2 7516.1 7620.8 7645.5 7525.8 7614.8 7693.6 7710.7 7720.7 2161.1 2191.1 2196.5 2198.5 2203.6 2213.1 2220.7 2221.4 2225.0 2243.8 1911.2 1946.6 2207.7 2208.9 2231.6 2188.6 2204.3 2206.6 2206.9 2213.9 2168.5 2216.6 2228.5 2230.9 2233.4 7600.2 7641.6 7648.5 7653.4 7663.0 4547.7 4573.0 4603.5 4605.2 4635.2 2930.7 2949.4 3035.2 3061.9 3062.5 961.8 966.9 982.0 994.8 1030.5 10047.8 10089.3 10108.6 10139.4 10178.5 3961.7 3967.8 4008.3 4022.8 4063.5 8284.2 8299.1 8335.2 8350.2 8360.5 4500.5 4507.9 4521.5 4531.0 4578.1 4129.7 4168.9 4175.5 4183.6 4191.7 3260.0 3268.3 3272.8 3291.8 3295.8 1030.8 1041.1 1044.7 1059.7 1060.5 942.8 983.0 1002.8 1109.3 1181.5 6764.3 6926.5 6941.3 6943.5 6954.6 613.9 638.2 639.4 641.8 775.9 5139.8 5253.7 5293.1 5358.4 5370.5 8898.2 9100.1 9200.4 9245.0 9270.1 8108.4 8290.1 8297.1 8331.1 8357.6 7172.5 7191.2 7241.7 7293.2 7299.9 7006.1 7182.2 7207.2 7212.7 7217.1 7938.4 8037.2 8082.5 8116.3 8189.7 7912.8 8118.4 8227.9 8434.0 8511.3 6522.6 6554.3 6560.3 6560.8 6575.5 7139.0 7238.3 7279.4 7294.8 7309.5 6936.9 6957.9 7137.9 7150.4 7155.4 6072.1 6197.7 6593.5 7002.6 7045.2 6628.3 6703.8 6720.9 6726.9 6728.5 6273.8 6297.3 6329.8 6332.1 6359.0 6242.0 6359.7 6364.4 6380.3 6385.6 13:02:59 INFO - PROCESS | 4159 | 13:02:59 INFO - PROCESS | 4159 | [#4] prototype.html Cycles:180 Average:5591.68 Median:6309.98 stddev:1712.69 (27.1%) stddev-sans-first:1671.54 13:02:59 INFO - PROCESS | 4159 | Values: 341.2 347.8 352.3 352.4 353.1 6315.6 6358.6 6365.5 6368.7 6545.1 6304.3 6348.8 6355.9 6366.2 6367.1 4811.8 4812.0 4812.6 4813.0 4821.4 4813.3 4826.1 4830.2 4831.0 4838.7 4675.8 4757.7 4757.9 4767.6 4778.7 4741.6 4742.9 4744.8 4758.3 4762.9 4096.6 4105.5 4114.9 4125.3 4126.3 6051.2 6056.5 6084.9 6088.2 6096.4 5374.5 5484.3 5499.3 5545.1 5550.3 6679.7 6698.5 6706.5 6707.6 6739.5 4519.2 4520.4 4533.5 4540.0 4548.9 6775.0 6906.6 6966.4 6968.2 6978.7 4577.2 4597.4 4599.1 4607.0 4636.0 4680.2 4680.8 4686.1 4695.2 4698.2 5443.2 5488.3 5499.3 5499.5 5501.1 6633.0 6777.3 6791.8 6794.4 6806.4 1628.4 1648.0 1693.9 1699.4 1699.5 1072.6 1104.9 1121.6 1123.4 1127.6 6212.8 6254.9 6257.8 6258.7 6263.4 6801.4 6819.2 6830.6 6846.1 6851.6 6100.2 6222.0 6227.4 6241.7 6242.8 3718.8 3723.7 3730.0 3736.2 3738.6 6935.0 7042.1 7066.9 7069.3 7077.3 6977.9 7054.5 7055.6 7062.5 7100.6 7088.5 7098.9 7159.4 7234.8 7270.5 6981.8 7001.8 7016.8 7019.8 7020.3 6829.6 6858.5 6909.4 6930.3 6972.8 7122.0 7183.6 7191.8 7197.1 7199.2 4663.0 4680.0 4717.8 4727.1 4733.4 6832.3 7001.5 7027.2 7029.7 7033.9 6808.9 6813.4 6830.9 6857.4 6870.5 6796.6 6829.5 6833.1 6836.4 6839.2 6574.3 6651.9 6670.7 6702.8 6713.1 6794.4 6872.0 6873.0 6876.2 6888.8 6653.0 6675.4 6681.6 6681.9 6684.7 13:02:59 INFO - PROCESS | 4159 | 13:02:59 INFO - PROCESS | 4159 | [#5] yui.html Cycles:180 Average:13582.97 Median:24661.98 stddev:15105.71 (61.3%) stddev-sans-first:15117.14 13:02:59 INFO - PROCESS | 4159 | Values: 709.3 730.4 738.2 764.0 880.4 12601.0 12781.7 12834.2 12929.4 15462.1 14883.6 15015.2 15041.7 15049.5 15050.6 839.9 840.2 854.5 860.8 862.8 819.4 828.5 830.0 831.4 834.3 878.1 887.3 893.0 893.7 895.2 884.7 886.0 886.4 888.8 889.6 645.4 647.1 647.5 647.9 649.3 13904.9 14061.4 14065.8 14114.2 14126.0 12175.1 12662.4 12791.6 13021.1 13510.5 10254.8 10320.0 10328.3 10418.6 10431.6 3607.1 3635.6 3641.8 3660.5 3784.7 48403.3 49037.8 49039.3 49042.0 49083.3 9806.8 9893.7 9951.7 10062.6 10196.5 18366.9 19141.7 19416.8 19476.3 19521.4 7742.9 7749.7 7805.5 7820.3 7894.2 4296.4 4438.9 4450.1 4484.0 4485.2 3174.2 3203.5 3211.4 3214.8 3229.8 558.2 581.3 588.5 591.4 600.2 599.5 692.5 695.3 699.3 713.7 7887.9 7938.9 8204.2 8254.6 8384.6 511.9 533.6 672.7 686.2 695.7 3634.7 3793.8 4016.1 4041.4 4130.0 50576.2 52289.5 52784.7 53274.7 53464.2 46523.0 46694.3 46855.0 47055.3 47349.0 43983.0 43999.0 44840.0 45101.0 45826.5 7915.6 8007.6 8145.9 8223.8 8243.3 33938.8 34226.7 34782.7 34872.0 34930.8 40393.0 41282.6 41679.0 43686.3 43695.6 10666.8 10766.4 10772.3 11324.2 11769.6 12695.2 12847.6 12907.7 12983.9 13334.9 10714.4 10800.6 10994.0 11127.5 11639.1 11392.7 12044.8 12099.3 12398.6 12402.5 11499.9 11777.2 12039.6 12189.7 12191.5 9896.0 9966.7 10019.4 10352.8 10519.0 8835.4 8976.2 9117.6 9651.8 9724.2 13:02:59 INFO - PROCESS | 4159 | -------- Summary: end -------- 13:02:59 INFO - PROCESS | 4159 | 13:03:00 INFO - TEST-INFO | 4159: exit 0 13:03:00 INFO - TEST-OK | dromaeo_css | took 1110689ms 13:03:00 INFO - TEST-START | kraken 13:03:00 INFO - operating with platform_type : linux_ 13:03:00 INFO - Initialising browser for kraken test... 13:03:00 INFO - TEST-INFO | started process 4400 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp162e1e/profile http://localhost:40401/getInfo.html) 13:03:04 INFO - PROCESS | 4400 | __metrics Screen width/height:1600/1200 13:03:04 INFO - PROCESS | 4400 | colorDepth:24 13:03:04 INFO - PROCESS | 4400 | Browser inner width/height: 1024/697 13:03:04 INFO - PROCESS | 4400 | __metrics 13:03:04 INFO - PROCESS | 4400 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:03:05 INFO - TEST-INFO | 4400: exit 0 13:03:05 INFO - Browser initialized. 13:03:05 INFO - Running cycle 1/1 for kraken test... 13:03:05 INFO - TEST-INFO | started process 4519 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp162e1e/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:03:17 INFO - PROCESS | 4519 | RSS: Main: 150507520 13:03:17 INFO - PROCESS | 4519 | 13:03:19 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40401/tests/kraken/driver.html?testName=audio-beat-detection) 13:03:20 INFO - PROCESS | 4519 | RSS: Main: 152096768 13:03:20 INFO - PROCESS | 4519 | 13:03:23 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40401/tests/kraken/driver.html?testName=audio-dft) 13:03:23 INFO - PROCESS | 4519 | RSS: Main: 152023040 13:03:23 INFO - PROCESS | 4519 | 13:03:26 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40401/tests/kraken/driver.html?testName=audio-fft) 13:03:27 INFO - PROCESS | 4519 | RSS: Main: 146272256 13:03:27 INFO - PROCESS | 4519 | 13:03:29 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40401/tests/kraken/driver.html?testName=audio-oscillator) 13:03:29 INFO - PROCESS | 4519 | RSS: Main: 146522112 13:03:29 INFO - PROCESS | 4519 | 13:03:31 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:03:32 INFO - PROCESS | 4519 | RSS: Main: 147202048 13:03:32 INFO - PROCESS | 4519 | 13:03:35 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40401/tests/kraken/driver.html?testName=imaging-darkroom) 13:03:36 INFO - PROCESS | 4519 | RSS: Main: 149356544 13:03:36 INFO - PROCESS | 4519 | 13:03:39 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40401/tests/kraken/driver.html?testName=imaging-desaturate) 13:03:40 INFO - PROCESS | 4519 | RSS: Main: 149131264 13:03:40 INFO - PROCESS | 4519 | 13:03:42 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40401/tests/kraken/driver.html?testName=json-parse-financial) 13:03:43 INFO - PROCESS | 4519 | RSS: Main: 149078016 13:03:43 INFO - PROCESS | 4519 | 13:03:45 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:03:45 INFO - PROCESS | 4519 | RSS: Main: 147881984 13:03:45 INFO - PROCESS | 4519 | 13:03:47 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40401/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:03:48 INFO - PROCESS | 4519 | RSS: Main: 147640320 13:03:48 INFO - PROCESS | 4519 | 13:03:50 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:03:50 INFO - PROCESS | 4519 | RSS: Main: 147230720 13:03:50 INFO - PROCESS | 4519 | 13:03:53 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:03:53 INFO - PROCESS | 4519 | RSS: Main: 148504576 13:03:53 INFO - PROCESS | 4519 | 13:03:56 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:03:56 INFO - PROCESS | 4519 | RSS: Main: 147140608 13:03:56 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | Cycle 1(1): loaded http://localhost:40401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40401/tests/kraken/driver.html?testName=ai-astar) 13:03:58 INFO - PROCESS | 4519 | RSS: Main: 149385216 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | __start_tp_report 13:03:58 INFO - PROCESS | 4519 | _x_x_mozilla_page_load 13:03:58 INFO - PROCESS | 4519 | _x_x_mozilla_page_load_details 13:03:58 INFO - PROCESS | 4519 | |i|pagename|runs| 13:03:58 INFO - PROCESS | 4519 | |0;ai-astar;113;108;115;111;113;122;110;112;112;113 13:03:58 INFO - PROCESS | 4519 | |1;audio-beat-detection;149;126;155;166;129;154;152;123;164;128 13:03:58 INFO - PROCESS | 4519 | |2;audio-dft;162;163;163;162;163;164;162;165;171;162 13:03:58 INFO - PROCESS | 4519 | |3;audio-fft;72;73;74;72;79;73;146;75;71;75 13:03:58 INFO - PROCESS | 4519 | |4;audio-oscillator;96;97;140;96;97;96;144;96;98;142 13:03:58 INFO - PROCESS | 4519 | |5;imaging-gaussian-blur;110;110;110;110;110;110;109;109;110;110 13:03:58 INFO - PROCESS | 4519 | |6;imaging-darkroom;146;146;147;146;146;147;146;147;147;148 13:03:58 INFO - PROCESS | 4519 | |7;imaging-desaturate;96;97;97;96;96;98;96;96;96;96 13:03:58 INFO - PROCESS | 4519 | |8;json-parse-financial;57;57;60;60;57;66;58;58;54;55 13:03:58 INFO - PROCESS | 4519 | |9;json-stringify-tinderbox;68;71;68;68;69;68;69;68;68;68 13:03:58 INFO - PROCESS | 4519 | |10;stanford-crypto-aes;95;89;85;86;87;86;94;86;89;86 13:03:58 INFO - PROCESS | 4519 | |11;stanford-crypto-ccm;120;117;124;135;127;130;129;120;122;118 13:03:58 INFO - PROCESS | 4519 | |12;stanford-crypto-pbkdf2;151;153;151;151;155;144;155;151;150;141 13:03:58 INFO - PROCESS | 4519 | |13;stanford-crypto-sha256-iterative;69;69;71;71;70;67;68;68;69;68 13:03:58 INFO - PROCESS | 4519 | __end_tp_report 13:03:58 INFO - PROCESS | 4519 | __start_cc_report 13:03:58 INFO - PROCESS | 4519 | _x_x_mozilla_cycle_collect,747 13:03:58 INFO - PROCESS | 4519 | __end_cc_report 13:03:58 INFO - PROCESS | 4519 | __startTimestamp1451509438915__endTimestamp 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | ------- Summary: start ------- 13:03:58 INFO - PROCESS | 4519 | Number of tests: 14 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:3.73 (3.3%) stddev-sans-first:3.95 13:03:58 INFO - PROCESS | 4519 | Values: 113.0 108.0 115.0 111.0 113.0 122.0 110.0 112.0 112.0 113.0 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:153.00 stddev:16.45 (10.8%) stddev-sans-first:17.37 13:03:58 INFO - PROCESS | 4519 | Values: 149.0 126.0 155.0 166.0 129.0 154.0 152.0 123.0 164.0 128.0 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:2.75 (1.7%) stddev-sans-first:2.85 13:03:58 INFO - PROCESS | 4519 | Values: 162.0 163.0 163.0 162.0 163.0 164.0 162.0 165.0 171.0 162.0 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#3] audio-fft Cycles:10 Average:81.00 Median:73.50 stddev:22.95 (31.2%) stddev-sans-first:24.11 13:03:58 INFO - PROCESS | 4519 | Values: 72.0 73.0 74.0 72.0 79.0 73.0 146.0 75.0 71.0 75.0 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.00 stddev:21.97 (22.9%) stddev-sans-first:22.70 13:03:58 INFO - PROCESS | 4519 | Values: 96.0 97.0 140.0 96.0 97.0 96.0 144.0 96.0 98.0 142.0 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:03:58 INFO - PROCESS | 4519 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 13:03:58 INFO - PROCESS | 4519 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 148.0 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 13:03:58 INFO - PROCESS | 4519 | Values: 96.0 97.0 97.0 96.0 96.0 98.0 96.0 96.0 96.0 96.0 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:3.33 (5.7%) stddev-sans-first:3.50 13:03:58 INFO - PROCESS | 4519 | Values: 57.0 57.0 60.0 60.0 57.0 66.0 58.0 58.0 54.0 55.0 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 13:03:58 INFO - PROCESS | 4519 | Values: 68.0 71.0 68.0 68.0 69.0 68.0 69.0 68.0 68.0 68.0 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:88.00 stddev:3.53 (4.0%) stddev-sans-first:2.79 13:03:58 INFO - PROCESS | 4519 | Values: 95.0 89.0 85.0 86.0 87.0 86.0 94.0 86.0 89.0 86.0 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:125.50 stddev:5.88 (4.7%) stddev-sans-first:6.04 13:03:58 INFO - PROCESS | 4519 | Values: 120.0 117.0 124.0 135.0 127.0 130.0 129.0 120.0 122.0 118.0 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.20 Median:151.00 stddev:4.47 (3.0%) stddev-sans-first:4.73 13:03:58 INFO - PROCESS | 4519 | Values: 151.0 153.0 151.0 151.0 155.0 144.0 155.0 151.0 150.0 141.0 13:03:58 INFO - PROCESS | 4519 | 13:03:58 INFO - PROCESS | 4519 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.33 (1.9%) stddev-sans-first:1.41 13:03:58 INFO - PROCESS | 4519 | Values: 69.0 69.0 71.0 71.0 70.0 67.0 68.0 68.0 69.0 68.0 13:03:58 INFO - PROCESS | 4519 | -------- Summary: end -------- 13:03:58 INFO - PROCESS | 4519 | 13:03:59 INFO - TEST-INFO | 4519: exit 0 13:03:59 INFO - TEST-OK | kraken | took 59360ms 13:03:59 INFO - TEST-START | v8_7 13:03:59 INFO - operating with platform_type : linux_ 13:03:59 INFO - Initialising browser for v8_7 test... 13:03:59 INFO - TEST-INFO | started process 4807 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc3qwOc/profile http://localhost:40401/getInfo.html) 13:04:04 INFO - PROCESS | 4807 | __metrics Screen width/height:1600/1200 13:04:04 INFO - PROCESS | 4807 | colorDepth:24 13:04:04 INFO - PROCESS | 4807 | Browser inner width/height: 1024/697 13:04:04 INFO - PROCESS | 4807 | __metrics 13:04:04 INFO - PROCESS | 4807 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:04:05 INFO - TEST-INFO | 4807: exit 0 13:04:05 INFO - Browser initialized. 13:04:05 INFO - Running cycle 1/1 for v8_7 test... 13:04:05 INFO - TEST-INFO | started process 4925 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc3qwOc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:04:16 INFO - PROCESS | 4925 | RSS: Main: 150220800 13:04:16 INFO - PROCESS | 4925 | 13:04:38 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:40401/tests/v8_7/run.html (next: http://localhost:40401/tests/v8_7/run.html) 13:04:38 INFO - PROCESS | 4925 | RSS: Main: 147292160 13:04:38 INFO - PROCESS | 4925 | 13:04:38 INFO - PROCESS | 4925 | __start_tp_report 13:04:38 INFO - PROCESS | 4925 | _x_x_mozilla_page_load 13:04:38 INFO - PROCESS | 4925 | _x_x_mozilla_page_load_details 13:04:38 INFO - PROCESS | 4925 | |i|pagename|runs| 13:04:38 INFO - PROCESS | 4925 | |0;Richards;166.86133822793258 13:04:38 INFO - PROCESS | 4925 | |1;DeltaBlue;189.14318138831095 13:04:38 INFO - PROCESS | 4925 | |2;Encrypt;279.2516056967328 13:04:38 INFO - PROCESS | 4925 | |3;Decrypt;5251.308900523561 13:04:38 INFO - PROCESS | 4925 | |4;RayTrace;1085.7763300760043 13:04:38 INFO - PROCESS | 4925 | |5;Earley;730.9941520467836 13:04:38 INFO - PROCESS | 4925 | |6;Boyer;12358.024691358025 13:04:38 INFO - PROCESS | 4925 | |7;RegExp;25100 13:04:38 INFO - PROCESS | 4925 | |8;Splay;555.4942020982883 13:04:38 INFO - PROCESS | 4925 | |9;NavierStokes;4840.579710144928 13:04:38 INFO - PROCESS | 4925 | __end_tp_report 13:04:38 INFO - PROCESS | 4925 | __startTimestamp1451509478432__endTimestamp 13:04:38 INFO - PROCESS | 4925 | 13:04:38 INFO - PROCESS | 4925 | ------- Summary: start ------- 13:04:38 INFO - PROCESS | 4925 | Number of tests: 10 13:04:38 INFO - PROCESS | 4925 | 13:04:38 INFO - PROCESS | 4925 | [#0] Richards Cycles:1 Average:166.86 Median:166.86 stddev:0.00 (0.0%) 13:04:38 INFO - PROCESS | 4925 | Values: 166.9 13:04:38 INFO - PROCESS | 4925 | 13:04:38 INFO - PROCESS | 4925 | [#1] DeltaBlue Cycles:1 Average:189.14 Median:189.14 stddev:0.00 (0.0%) 13:04:38 INFO - PROCESS | 4925 | Values: 189.1 13:04:38 INFO - PROCESS | 4925 | 13:04:38 INFO - PROCESS | 4925 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 13:04:38 INFO - PROCESS | 4925 | Values: 279.3 13:04:38 INFO - PROCESS | 4925 | 13:04:38 INFO - PROCESS | 4925 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 13:04:38 INFO - PROCESS | 4925 | Values: 5251.3 13:04:38 INFO - PROCESS | 4925 | 13:04:38 INFO - PROCESS | 4925 | [#4] RayTrace Cycles:1 Average:1085.78 Median:1085.78 stddev:0.00 (0.0%) 13:04:38 INFO - PROCESS | 4925 | Values: 1085.8 13:04:38 INFO - PROCESS | 4925 | 13:04:38 INFO - PROCESS | 4925 | [#5] Earley Cycles:1 Average:730.99 Median:730.99 stddev:0.00 (0.0%) 13:04:38 INFO - PROCESS | 4925 | Values: 731.0 13:04:38 INFO - PROCESS | 4925 | 13:04:38 INFO - PROCESS | 4925 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 13:04:38 INFO - PROCESS | 4925 | Values: 12358.0 13:04:38 INFO - PROCESS | 4925 | 13:04:38 INFO - PROCESS | 4925 | [#7] RegExp Cycles:1 Average:25100.00 Median:25100.00 stddev:0.00 (0.0%) 13:04:38 INFO - PROCESS | 4925 | Values: 25100.0 13:04:38 INFO - PROCESS | 4925 | 13:04:38 INFO - PROCESS | 4925 | [#8] Splay Cycles:1 Average:555.49 Median:555.49 stddev:0.00 (0.0%) 13:04:38 INFO - PROCESS | 4925 | Values: 555.5 13:04:38 INFO - PROCESS | 4925 | 13:04:38 INFO - PROCESS | 4925 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 13:04:38 INFO - PROCESS | 4925 | Values: 4840.6 13:04:38 INFO - PROCESS | 4925 | -------- Summary: end -------- 13:04:38 INFO - PROCESS | 4925 | 13:04:39 INFO - TEST-INFO | 4925: exit 0 13:04:39 INFO - TEST-OK | v8_7 | took 39458ms 13:04:39 INFO - SUITE-END | took 1209s 13:04:39 INFO - Completed test suite (00:20:09) 13:04:39 INFO - Working with test: dromaeo_css 13:04:39 INFO - Generating results file: dromaeo_css 13:04:39 INFO - Working with test: kraken 13:04:39 INFO - Generating results file: kraken 13:04:39 INFO - javascript benchmark 13:04:39 INFO - Working with test: v8_7 13:04:39 INFO - Generating results file: v8_7 13:04:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:04:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 13:04:39 INFO - process_Request line: dromaeo_css 6989.52 graph.html#tests=[[72,63,43]] 13:04:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:04:39 INFO - process_Request line: kraken 1523.60 graph.html#tests=[[232,63,43]] 13:04:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:04:39 INFO - process_Request line: v8_7 21420.54 graph.html#tests=[[230,63,43]] 13:04:39 INFO - RETURN: dromaeo_css: 6989.52 13:04:39 INFO - RETURN: kraken: 1523.60 13:04:39 INFO - RETURN: v8_7: 21420.54 13:04:39 INFO - javascript benchmark 13:04:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3156.1793933577264, 3201.711845933864, 3235.9676403235962, 3245.5618491503647, 3249.350129974006, 5187.766550505227, 5295.258663787073, 5328.600354973378, 5337.626366154371, 5341.89316213676, 5256.211568264762, 5278.524932756051, 5302.337207849019, 5326.414094449608, 5366.91949620756, 4527.139843429754, 4811.711297322155, 4940.802367905298, 4976.0, 4976.079425306312, 4802.447718512363, 4865.391826021747, 4932.704037757746, 4933.7286449245275, 4943.6539442239055, 4843.443004054526, 4881.145799485076, 4911.0, 4920.237363208708, 4956.355673762424, 4870.732109733964, 4883.389576302962, 4905.566352718401, 4919.893024069592, 4925.75371231437, 4795.856124316276, 4870.512948705136, 4873.122837889178, 4895.094407534618, 4915.950840491585, 5063.544281014726, 5143.228515722634, 5152.793888244466, 5154.149565321717, 5163.922541161885, 5792.044312688401, 5792.275965504312, 5793.652380857162, 5798.1302804579655, 5802.738876750556, 5792.739326730307, 5798.768049278024, 5804.187413762077, 5813.273340832396, 5814.709264536757, 5275.472452754694, 5368.489993450655, 5374.408815030343, 5376.704281264529, 5420.783168673248, 5710.057840456278, 5807.303123625192, 5822.301323841166, 5876.177335173079, 5902.026165682614, 5639.041362968305, 5677.091665333527, 5694.715264236772, 5710.600257981984, 5730.627509211888, 5652.067408877571, 5704.572157088235, 5749.223854779635, 5763.337216220189, 5771.769129234784, 5589.720513974285, 5693.857653558612, 5748.0, 5764.538836893039, 5804.506616937608, 5679.375268720438, 5689.459501347365, 5690.715464226772, 5699.145128230799, 5714.485696287354, 4339.848105316299, 4414.249577571821, 4415.315626077963, 4424.225760491901, 4474.0, 3939.0, 3975.6223158799867, 3982.681385489154, 3999.920001599952, 4010.9972506873282, 5275.5515781158265, 5300.231466437345, 5301.787928482895, 5306.8142615009065, 5344.171653393652, 5610.579206559524, 5688.06146985751, 5689.68706721126, 5731.8567035824435, 5745.626534275259, 5380.91928621071, 5411.404745477994, 5415.187721841755, 5426.213199086111, 5433.402325744165, 4876.6930204626215, 4883.316335713003, 4918.508149185053, 4921.926171107365, 4961.032598643302, 5625.578081643893, 5698.487136157766, 5805.7387417566315, 5907.852303692442, 5938.406159384027, 5687.459691329317, 5693.174489699053, 5720.914186287126, 5756.625819321731, 5762.798302059407, 5843.2695913010875, 5845.269341332333, 5849.298084229919, 5849.444302791228, 5862.443067908542, 5554.222408862682, 5646.3506696728755, 5662.292213473316, 5717.914231286451, 5760.94239057604, 5749.252597162342, 5754.51086657622, 5760.539156867357, 5764.394738552559, 5770.019096753478, 5442.401335852974, 5580.665160090408, 5589.077802162597, 5593.440655934374, 5598.188262701967, 5525.4474552546035, 5631.183478395692, 5684.971575142098, 5699.401562836008, 5724.513416359656, 5515.420880807457, 5516.117421212587, 5518.227448157341, 5518.44815518461, 5552.167174923794, 5500.312460942382, 5600.131979543177, 5634.408387119293, 5660.264165658603, 5661.2923384576925, 5510.448955104457, 5536.418676039119, 5577.525910297508, 5585.134304182858, 5586.441355864381], "unit": "score", "name": "dojo.html", "value": 5278.672208209223}, {"lowerIsBetter": false, "replicates": [553.3359968038355, 555.7221389305348, 564.4524810933393, 568.4628026514944, 599.9141553787645, 35929.64070359296, 37207.81396093022, 37212.81393593035, 37296.62703372965, 37303.626963730356, 40257.77937764979, 40397.0, 40507.39238911419, 40690.59309406905, 40935.38596921049, 8423.494590324584, 8603.612837422299, 8626.35302352323, 8648.481091134521, 8662.177093176138, 8415.70545030924, 8573.228409443149, 8579.0, 8725.0, 8766.912330876705, 8780.560971951409, 8828.24959878408, 8854.955725221365, 8885.95557022214, 8891.68879089232, 8733.12668733128, 8817.691380801705, 8823.985241697223, 8827.33794965377, 8832.69085582008, 8467.576621168917, 8585.484870907703, 8624.741257762276, 8643.65425382984, 8666.653333866638, 39746.403803942965, 40078.79960600178, 40137.799311003255, 40202.39696404556, 40223.59776402257, 3138.1997590614246, 3169.3027533942495, 3175.301433684586, 3272.427325218101, 3299.686529779667, 29725.256868578243, 29915.850420747975, 30059.248518786986, 30538.389232215453, 30611.540826887616, 3670.284294562561, 3703.092742278132, 3721.3301605710963, 3770.8310423768444, 3773.0, 263588.0, 264472.0, 264833.0, 265088.0, 265574.0, 53673.0, 55089.72455137779, 60035.0, 60243.39756602466, 62009.0, 56533.152002719995, 56760.43239567634, 57074.42925570691, 57135.714321428124, 57240.42759572351, 15508.379664813507, 15623.0, 15719.528414147593, 15729.921350393175, 15770.211489425712, 11667.708307292385, 11703.88296117045, 11839.11206659504, 11840.289582624897, 11852.762944741056, 19424.12591433389, 19773.60452790965, 20255.392338229878, 20275.46556680415, 20400.693989590167, 7222.927770722225, 7344.6412413702565, 7449.925500744923, 7478.813029674193, 7542.245775422414, 873.7160422862595, 878.7056336127469, 972.6060945317158, 1030.1912998296302, 1047.512906498482, 25334.873325633253, 25639.615405768927, 25829.095981640552, 25868.870655646602, 28434.431311373657, 1006.9043440873105, 1027.671145233533, 1080.8865069167782, 1137.8919002694731, 1174.5595401724354, 14271.64320891986, 14667.77998330026, 14773.409063637335, 15935.920320398323, 16414.179291035638, 319399.0, 322491.0, 322680.0, 323108.0, 323465.0, 52809.47190528122, 53394.19908701372, 53502.46497535053, 53516.46483535193, 53518.0, 1323.9139455935526, 1374.656335916021, 1378.5864240727742, 1382.6059573021842, 1384.9307534623229, 28798.424031519673, 29508.114756557337, 29766.553501697927, 30120.397592048474, 30662.386752265276, 46774.53225467702, 46805.76597116992, 47402.288965664855, 47491.28763068626, 47607.76196118997, 294278.0, 298167.0, 299373.0, 299403.0, 299793.0, 31810.52284215785, 32145.517817233227, 32759.344813104082, 32972.0, 33041.0, 38759.806200968815, 41183.176336472505, 42124.15751685011, 42421.575784242996, 42491.0, 34718.47922281218, 35242.0, 35287.470687940215, 35597.0, 35923.46114808332, 35564.466533002545, 35569.64430355663, 36445.27109457849, 36455.27089458249, 36477.63522364849, 34942.30115397627, 35060.0, 35159.47260791141, 35404.0, 35507.82246088753, 31312.686873130977, 32225.677743222266, 32609.347813043132, 32836.67163328336, 33029.33941321208, 24514.75485245196, 24820.91227930681, 24912.750872491044, 25004.0, 25175.8530183727], "unit": "score", "name": "ext.html", "value": 18326.871722348784}, {"lowerIsBetter": false, "replicates": [345.7234212629895, 358.9964100358997, 359.0789624612868, 359.11286191065943, 362.7660159197317, 16609.33562657494, 16705.164741762925, 17238.65522689547, 17553.210105545248, 18345.0, 16163.676726465465, 16500.917495412537, 16574.50276491704, 16784.66430671389, 16799.580010499743, 4883.194272944968, 5009.599232061426, 5015.04714104319, 5019.322391477159, 5025.246213068032, 4393.0, 4990.451050384455, 5051.318072060261, 5055.69665820052, 5056.418511871127, 5074.822381216658, 5241.213817927322, 5270.92093618596, 5379.596530260226, 5408.486193811582, 5161.967606478719, 5244.527992480676, 5247.737613119348, 5276.234945932837, 5454.809081682122, 5276.947230527684, 5281.683099014072, 5287.391949925769, 5292.179712144623, 5308.973455132699, 12546.874531254662, 13115.606531804062, 19885.0, 20137.697934530996, 20326.390208293775, 1961.744973153481, 1997.1611922992233, 2004.7694515130654, 2039.51051747581, 2094.4554415851835, 9474.289428292906, 9631.662891798753, 9682.467464289532, 9710.223182145412, 9785.461799601018, 1834.2937968881943, 1840.74229607855, 1860.6092720528704, 1901.372547059481, 1914.1386376130797, 58174.0, 60758.08862867061, 61766.0, 61974.38025619731, 62091.0, 10180.287379883484, 10311.278210525341, 10389.636362727419, 10417.270791044706, 10419.687409377731, 13530.188188708513, 13565.186088834702, 13611.795823062663, 13633.045686801828, 13653.590392288248, 7742.7677169685, 7749.302562769378, 7750.612469376621, 7766.145723970359, 7851.057873055156, 7400.074990626172, 7486.812829679302, 7491.063617047869, 7496.962515187389, 7543.283388078124, 4423.137488189836, 4426.623736982393, 4436.511983681792, 4458.710183838105, 4483.19302525542, 1684.8062472815539, 1759.5161330633923, 1777.742227377023, 1788.3383148235237, 1838.9540261493569, 899.4513346858411, 932.5383934952107, 947.7441090905555, 1051.784384201237, 1056.5404049238605, 15948.840511594735, 16067.357305707641, 16071.919640401957, 16454.83545164557, 16548.669026619402, 932.7155217658543, 951.9286053546011, 989.7030890732896, 1024.2881197567767, 1024.5594394410475, 9362.438253704664, 9728.124468797841, 9795.0, 9973.800523989625, 10149.34029288094, 494014.0, 506655.0, 512737.0, 524936.0, 584321.0, 82727.17272827314, 84543.5772821132, 85009.0, 86159.5692021536, 88071.55964220266, 1150.4592841364545, 1167.3404526442532, 1167.8948894599528, 1178.0693252330564, 1181.6927598824368, 15656.217189140725, 15765.166574498768, 15803.683926321179, 16097.356105756107, 16246.837531625006, 19351.90324048371, 23643.52712945766, 27890.0, 36712.0, 37578.0, 47530.049399011135, 47814.760926195144, 48671.5132848667, 49900.50099498958, 51177.488225117275, 9346.766330841783, 9567.473788941676, 9771.755706107404, 9812.950935245279, 9849.409035457895, 16979.575510611838, 17599.736003960206, 17758.37845675395, 18122.81877181211, 18157.727634085237, 11049.447527623426, 12378.071644626869, 14007.789883151965, 14619.780703289673, 14808.555743327717, 9501.857472138061, 9605.0, 14300.427982880568, 14692.779608306098, 14710.705785884436, 9994.10053095225, 10659.46702664848, 10790.784184316426, 10791.838122428328, 10897.128229741444, 15092.39630414771, 15142.772858407354, 15356.616084597528, 15804.209789510709, 15835.0, 15909.284082216096, 16375.918120409322, 16386.344546218017, 16851.41020064292, 16952.915235423745], "unit": "score", "name": "jquery.html", "value": 8861.962664933475}, {"lowerIsBetter": false, "replicates": [1423.2815322733582, 1440.0783498560922, 1556.5952852258417, 1714.3828221840135, 1745.458907738602, 7356.1540422851385, 7374.188839227681, 7516.098068231813, 7620.771376858696, 7645.541267523946, 7525.811854703635, 7614.809629759259, 7693.576853273068, 7710.730124445646, 7720.7297744578955, 2161.124744478485, 2191.068795761803, 2196.494806194576, 2198.4723666320047, 2203.6253836847695, 2213.0815711479795, 2220.666899965002, 2221.433534448713, 2225.0209907640588, 2243.842930994831, 1911.1877452082879, 1946.5814849807289, 2207.7461091974387, 2208.8895555222257, 2231.564844855254, 2188.6498160294277, 2204.250554811372, 2206.6138425775584, 2206.933791986243, 2213.8671679699187, 2168.490404754881, 2216.645336746129, 2228.4874478869788, 2230.888455577231, 2233.363491404958, 7600.201978792203, 7641.617919104078, 7648.502847314907, 7653.387728981668, 7663.042119735033, 4547.727136371828, 4573.0, 4603.5396460353695, 4605.194091034089, 4635.212013957602, 2930.7069293070736, 2949.351142748592, 3035.2411897025745, 3061.9234519136976, 3062.4640687879755, 961.8412961861354, 966.8694726211942, 982.0, 994.8010397920444, 1030.4847576211894, 10047.799044019079, 10089.293749437542, 10108.595656173818, 10139.39163650176, 10178.541965611565, 3961.74248673841, 3967.821448034845, 4008.318585840414, 4022.8189731462153, 4063.4717486726536, 8284.212999765012, 8299.087100418948, 8335.166483351617, 8350.206730360605, 8360.45657032291, 4500.459944806644, 4507.909841803145, 4521.525239849834, 4531.048479819209, 4578.084383123389, 4129.69027322952, 4168.91662166761, 4175.457190565267, 4183.6234738873645, 4191.706580539333, 3259.9674003259665, 3268.313654132611, 3272.787268827519, 3291.7860339077884, 3295.802251864896, 1030.7526193713454, 1041.063043261056, 1044.6552637629563, 1059.682095371401, 1060.522764755863, 942.8020115775627, 982.975425614351, 1002.8144793213133, 1109.2734259060328, 1181.5273890443718, 6764.255931847493, 6926.515143939977, 6941.34057264559, 6943.548669336477, 6954.617496037666, 613.8649497110629, 638.2054342343812, 639.3925770518026, 641.8331233879225, 775.9456838021284, 5139.820106296262, 5253.684778913201, 5293.12663410533, 5358.4373640767935, 5370.489803468742, 8898.243649289754, 9100.135487128713, 9200.4479731215, 9244.953775231215, 9270.119338662817, 8108.351331893435, 8290.129536398712, 8297.12880147588, 8331.083580806106, 8357.58212089393, 7172.493776307034, 7191.17301510333, 7241.746538871114, 7293.197748247795, 7299.89050164248, 7006.124234470692, 7182.174049984319, 7207.171175314906, 7212.74755383559, 7217.097862767154, 7938.364930805406, 8037.19628037215, 8082.515049097073, 8116.2695357418115, 8189.7133600323705, 7912.802179945547, 8118.350531957311, 8227.917720822716, 8434.0, 8511.276541494042, 6522.641254731036, 6554.344565543598, 6560.3111673275525, 6560.8359791005605, 6575.50683698715, 7138.964305178441, 7238.335182907856, 7279.417646588155, 7294.817629559304, 7309.451791115794, 6936.895946560705, 6957.895631565631, 7137.857242855218, 7150.42796576283, 7155.356017958408, 6072.089186622042, 6197.690115494117, 6593.505487088391, 7002.5798452091, 7045.189803172496, 6628.337166283333, 6703.798886033427, 6720.865582688417, 6726.8654626908165, 6728.529002969745, 6273.811785646438, 6297.275813281348, 6329.778457753957, 6332.081848131903, 6358.950773122383, 6242.032484964838, 6359.713812878339, 6364.363563643598, 6380.298167201697, 6385.648789316632], "unit": "score", "name": "mootools.html", "value": 4245.8724323416045}, {"lowerIsBetter": false, "replicates": [341.16244619459223, 347.8173958671697, 352.3077153393581, 352.36046575465514, 353.11192351236645, 6315.621062736233, 6358.554901156921, 6365.45893599044, 6368.745250189987, 6545.083688283644, 6304.33804450533, 6348.809535713925, 6355.936440635593, 6366.172397588307, 6367.076773867786, 4811.783469743861, 4811.951880481203, 4812.614990800727, 4812.975935120319, 4821.397325334333, 4813.253945638432, 4826.131296366652, 4830.1788695921605, 4830.985493046464, 4838.685485443452, 4675.789589468465, 4757.714537127766, 4757.9286310705365, 4767.5709186173235, 4778.713277203362, 4741.620670346381, 4742.881427964294, 4744.7627618618935, 4758.262469317244, 4762.857114286577, 4096.56986016467, 4105.527864295615, 4114.91770164598, 4125.29869922114, 4126.277901367249, 6051.152838602599, 6056.545759068087, 6084.878302433971, 6088.208532890741, 6096.390360963868, 5374.462553744634, 5484.314460692413, 5499.322706574493, 5545.112781954908, 5550.27846379972, 6679.666016699146, 6698.531102822804, 6706.463482921404, 6707.631080290582, 6739.494537909627, 4519.186546421643, 4520.412346394981, 4533.478649955231, 4539.954600454019, 4548.931766023512, 6774.966125169342, 6906.620135892524, 6966.4078553323025, 6968.233494315672, 6978.720851165947, 4577.176108300538, 4597.42532183477, 4599.103174880933, 4607.009492958963, 4636.0, 4680.204365257914, 4680.789364478606, 4686.133065382915, 4695.201815691341, 4698.2247929092, 5443.237946687467, 5488.341399032141, 5499.340079190522, 5499.477549632778, 5501.064818980783, 6632.966835165793, 6777.322267773183, 6791.762288319885, 6794.388505034571, 6806.387425131663, 1628.3974929276244, 1648.044134402044, 1693.8729595280404, 1699.447679504166, 1699.4561740243003, 1072.6299426697776, 1104.9226554141133, 1121.5681962444517, 1123.4495097402214, 1127.6335191062938, 6212.844678883064, 6254.937450625435, 6257.78097766576, 6258.749650013949, 6263.404976527223, 6801.387875091166, 6819.181698196248, 6830.556013859183, 6846.075779769667, 6851.588904665736, 6100.176476175749, 6222.0, 6227.408396202353, 6241.719122639402, 6242.843928901723, 3718.8326525306425, 3723.6648701616987, 3730.0301921500063, 3736.2439653362876, 3738.6074462181077, 6934.954188514401, 7042.084529011298, 7066.893996590055, 7069.278327843715, 7077.292270772881, 6977.93022069783, 7054.541454805421, 7055.647217639097, 7062.505624606229, 7100.573965562083, 7088.539244949062, 7098.893516597255, 7159.355657990805, 7234.819129521804, 7270.527415717961, 6981.755638552626, 7001.824954376181, 7016.824579385352, 7019.789406317818, 7020.262872398324, 6829.6243706596615, 6858.451323894176, 6909.44724422035, 6930.272321406382, 6972.79081627552, 7121.9643901780155, 7183.604901730455, 7191.7842464726145, 7197.064381630355, 7199.208087110309, 4662.976685116552, 4680.0, 4717.811287548597, 4727.125481785881, 4733.431988161305, 6832.316768323128, 7001.50989430735, 7027.22700502934, 7029.718811247493, 7033.929660703532, 6808.93191068083, 6813.3527314905, 6830.897536537055, 6857.382835544825, 6870.519063665495, 6796.626185559644, 6829.52193346461, 6833.111695479556, 6836.418904392984, 6839.213490448662, 6574.342565743387, 6651.900221496585, 6670.733170673118, 6702.798916032527, 6713.093732346266, 6794.388505034571, 6871.9656401717675, 6872.965635171792, 6876.209235937931, 6888.827779305558, 6653.035309880137, 6675.365840245169, 6681.599104053772, 6681.933180668326, 6684.732610695518], "unit": "score", "name": "prototype.html", "value": 5031.637426962649}, {"lowerIsBetter": false, "replicates": [709.2517394149173, 730.4156674660273, 738.2064280898035, 763.9656215470303, 880.3969281042484, 12601.0, 12781.680457988543, 12834.229946203212, 12929.353532323381, 15462.149581772997, 14883.553493395188, 15015.249237538133, 15041.6991660167, 15049.548513544583, 15050.623734406645, 839.8908141941539, 840.2437805974611, 854.4830377621543, 860.8106216632331, 862.7929296968745, 819.4345901328064, 828.45736042892, 829.9668013279462, 831.4221615976899, 834.2575108153748, 878.1262643669526, 887.2547060469204, 892.955352232389, 893.6604090445621, 895.212213252337, 884.6726711116863, 886.0, 886.3883920095113, 888.8488956877314, 889.5907882374115, 645.3997782062727, 647.0682217606632, 647.5305403582412, 647.9222493300834, 649.3149727037973, 13904.860951390458, 14061.437542498288, 14065.80440662545, 14114.153150810984, 14126.0, 12175.147739658227, 12662.36688165588, 12791.5522956697, 13021.088523803337, 13510.527131550349, 10254.846177307347, 10320.0, 10328.32865863724, 10418.635347762867, 10431.634892778717, 3607.062163837421, 3635.618260082706, 3641.836117374698, 3660.4509323601405, 3784.678302344304, 48403.27395089076, 49037.75481122607, 49039.264411033866, 49042.0, 49083.26375104376, 9806.803863922682, 9893.65372211969, 9951.701448956543, 10062.647807326708, 10196.541155648014, 18366.90816545909, 19141.712874306897, 19416.805831941783, 19476.318328858422, 19521.414357569294, 7742.8838567421535, 7749.7287594933905, 7805.453618246668, 7820.296173344313, 7894.171112033154, 4296.4414626098405, 4438.866833994985, 4450.109978004347, 4483.955160448419, 4485.1702435048965, 3174.158847905307, 3203.4554125798672, 3211.4219440500465, 3214.8392580370887, 3229.7739158259164, 558.1934105217921, 581.3111462916457, 588.5262363797099, 591.3672370563456, 600.1957377114687, 599.5263741644139, 692.536000879412, 695.2873304862557, 699.3356311504092, 713.7430525010992, 7887.881681774778, 7938.9206107939335, 8204.179582041868, 8254.628541715638, 8384.580770961427, 511.8771494841211, 533.6131304804063, 672.7409947170277, 686.1526015371013, 695.7495301691387, 3634.7092232621326, 3793.7534060285993, 4016.096378314856, 4041.4231031720174, 4129.958700413017, 50576.24135637969, 52289.47710522922, 52784.73607632014, 53274.73362633162, 53464.19803702948, 46522.99999999932, 46694.29958550625, 46855.0, 47055.29417058747, 47349.0, 43983.0, 43999.0, 44840.0, 45101.0, 45826.5417345829, 7915.604219788872, 8007.599620019092, 8145.918540814753, 8223.77539302265, 8243.299319557906, 33938.830305848314, 34226.65773342235, 34782.65217347794, 34872.0, 34930.825345874124, 40393.0, 41282.587174127875, 41679.0, 43686.344704828814, 43695.56304437042, 10666.786664266516, 10766.407847568458, 10772.289036875, 11324.150688698215, 11769.588064417705, 12695.174813637084, 12847.614571562868, 12907.741845162856, 12983.870161298266, 13334.931647112002, 10714.357138571711, 10800.567977280822, 10993.985643148148, 11127.499262533367, 11639.127065469955, 11392.715182120513, 12044.819327709916, 12099.274043557414, 12398.5660501882, 12402.503899843905, 11499.942500287445, 11777.175597708077, 12039.578614748792, 12189.69525761863, 12191.512339506675, 9895.962717489638, 9966.700998970042, 10019.448930308903, 10352.844707329547, 10519.0, 8835.381523293308, 8976.192142706926, 9117.635294588143, 9651.758706032124, 9724.173445257233], "unit": "score", "name": "yui.html", "value": 6365.4023822112185}], "name": "dromaeo_css", "value": 6989.519903651145}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 115.0, 111.0, 113.0, 122.0, 110.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [149.0, 126.0, 155.0, 166.0, 129.0, 154.0, 152.0, 123.0, 164.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 162.0, 163.0, 164.0, 162.0, 165.0, 171.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 74.0, 72.0, 79.0, 73.0, 146.0, 75.0, 71.0, 75.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 140.0, 96.0, 97.0, 96.0, 144.0, 96.0, 98.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 60.0, 60.0, 57.0, 66.0, 58.0, 58.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [95.0, 89.0, 85.0, 86.0, 87.0, 86.0, 94.0, 86.0, 89.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.3}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 124.0, 135.0, 127.0, 130.0, 129.0, 120.0, 122.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [151.0, 153.0, 151.0, 151.0, 155.0, 144.0, 155.0, 151.0, 150.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 71.0, 70.0, 67.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1523.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.86133822793258], "unit": "score", "name": "Richards", "value": 211.56488599999994}, {"lowerIsBetter": false, "replicates": [189.14318138831095], "unit": "score", "name": "DeltaBlue", "value": 349.565866}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1085.7763300760043], "unit": "score", "name": "RayTrace", "value": 681.5298690000002}, {"lowerIsBetter": false, "replicates": [730.9941520467836], "unit": "score", "name": "Earley", "value": 911.7213840000002}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [25100.0], "unit": "score", "name": "RegExp", "value": 36.294223107569735}, {"lowerIsBetter": false, "replicates": [555.4942020982883], "unit": "score", "name": "Splay", "value": 146.7000009940358}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21420.536201800114}]} 13:04:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21420.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1523.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6989.52"}}} 13:04:39 INFO - Return code: 0 13:04:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:04:39 INFO - # TBPL SUCCESS # 13:04:39 INFO - Running post-action listener: _resource_record_post_action 13:04:39 INFO - Running post-run listener: _resource_record_post_run 13:04:40 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 8192; Write bytes: 554885120; Read time: 24; Write time: 405340 13:04:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 235216896; Read time: 0; Write time: 194400 13:04:40 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 8192; Write bytes: 319668224; Read time: 24; Write time: 210940 13:04:40 INFO - Running post-run listener: _upload_blobber_files 13:04:40 INFO - Blob upload gear active. 13:04:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:04:40 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:04:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 13:04:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 13:04:41 INFO - (blobuploader) - INFO - Open directory for files ... 13:04:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:04:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:04:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:42 INFO - (blobuploader) - INFO - Done attempting. 13:04:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:04:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:04:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:42 INFO - (blobuploader) - INFO - Done attempting. 13:04:42 INFO - (blobuploader) - INFO - Iteration through files over. 13:04:42 INFO - Return code: 0 13:04:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:04:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:04:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d696f8cfe168b3cabd7c9abc615ae54b01fdbdf0b7ccfa2758d59700600ff08735bdb7e7f5f097f9c1c3d66b7235523c1d4d6a881d53f6847a25fc14d6c0616c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/967e3f2efd4ade4a59af90baab5b7109ddc9b98e4a6ab1fbc310a9168674ef55ac73aedb598d687586d559ab6a49ed8533744b271b8b12a8feb489735ae48f00"} 13:04:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:04:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:04:42 INFO - Contents: 13:04:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d696f8cfe168b3cabd7c9abc615ae54b01fdbdf0b7ccfa2758d59700600ff08735bdb7e7f5f097f9c1c3d66b7235523c1d4d6a881d53f6847a25fc14d6c0616c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/967e3f2efd4ade4a59af90baab5b7109ddc9b98e4a6ab1fbc310a9168674ef55ac73aedb598d687586d559ab6a49ed8533744b271b8b12a8feb489735ae48f00"} 13:04:42 INFO - Copying logs to upload dir... 13:04:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.426289 ========= master_lag: 30.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2015-12-30 13:05:12.550929) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 13:05:12.554566) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d696f8cfe168b3cabd7c9abc615ae54b01fdbdf0b7ccfa2758d59700600ff08735bdb7e7f5f097f9c1c3d66b7235523c1d4d6a881d53f6847a25fc14d6c0616c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/967e3f2efd4ade4a59af90baab5b7109ddc9b98e4a6ab1fbc310a9168674ef55ac73aedb598d687586d559ab6a49ed8533744b271b8b12a8feb489735ae48f00"} build_url:https://queue.taskcluster.net/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/UxKSnhU9TX6micuEDnkDIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d696f8cfe168b3cabd7c9abc615ae54b01fdbdf0b7ccfa2758d59700600ff08735bdb7e7f5f097f9c1c3d66b7235523c1d4d6a881d53f6847a25fc14d6c0616c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/967e3f2efd4ade4a59af90baab5b7109ddc9b98e4a6ab1fbc310a9168674ef55ac73aedb598d687586d559ab6a49ed8533744b271b8b12a8feb489735ae48f00"}' ========= master_lag: 0.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 13:05:12.710287) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 13:05:12.710630) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451505848.992641-594519794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004723 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 13:05:12.727054) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 13:05:12.727384) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 13:05:12.727703) ========= ========= Total master_lag: 30.42 =========