builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1453226832.6 results: success (0) buildid: 20160119073404 builduid: da516b5f8037441b9f6f40b4d2b9e297 revision: 4f090efcb1b6a8d3058cd2c0dc310e5943e9c74c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.599317) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.599741) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.600035) ========= 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=52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006267 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.626882) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.627208) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.655583) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.655830) ========= 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=52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004718 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.707003) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.707277) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.707614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.707908) ========= 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=52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 10:07:13-- 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 2016-01-19 10:07:13 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087631 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.807762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.808072) ========= 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=52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018805 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.857938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:12.858249) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4f090efcb1b6a8d3058cd2c0dc310e5943e9c74c --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 4f090efcb1b6a8d3058cd2c0dc310e5943e9c74c --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=52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 10:07:13,224 truncating revision to first 12 chars 2016-01-19 10:07:13,224 Setting DEBUG logging. 2016-01-19 10:07:13,225 attempt 1/10 2016-01-19 10:07:13,225 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4f090efcb1b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 10:07:13,491 unpacking tar archive at: mozilla-inbound-4f090efcb1b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568036 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:13.439333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:13.439653) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004767 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:13.496156) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:13.496440) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:13.508734) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:13.509093) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 10:07:13.509527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-19 10:07:13.509811) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:07:13 INFO - MultiFileLogger online at 20160119 10:07:13 in /builds/slave/test-pgo 10:07:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:07:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:07:13 INFO - {'append_to_log': False, 10:07:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:07:13 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:07:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:07:13 INFO - 'branch': 'Mozilla-Inbound', 10:07:13 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:13 INFO - 'config_files': ('talos/linux_config.py',), 10:07:13 INFO - 'default_actions': ('clobber', 10:07:13 INFO - 'read-buildbot-config', 10:07:13 INFO - 'download-and-extract', 10:07:13 INFO - 'populate-webroot', 10:07:13 INFO - 'create-virtualenv', 10:07:13 INFO - 'install', 10:07:13 INFO - 'run-tests'), 10:07:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:13 INFO - 'download_minidump_stackwalk': True, 10:07:13 INFO - 'download_symbols': 'ondemand', 10:07:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:13 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:13 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:13 INFO - 'installer_path': 'installer.exe', 10:07:13 INFO - 'log_level': 'info', 10:07:13 INFO - 'log_name': 'talos', 10:07:13 INFO - 'log_to_console': True, 10:07:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:07:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:07:13 INFO - 'opt_config_files': (), 10:07:13 INFO - 'pip_index': False, 10:07:13 INFO - 'sps_profile': False, 10:07:13 INFO - 'sps_profile_interval': 0, 10:07:13 INFO - 'suite': 'dromaeojs', 10:07:13 INFO - 'system_bits': '32', 10:07:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:13 INFO - 'title': 'talos-linux64-ix-056', 10:07:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:13 INFO - 'use_talos_json': True, 10:07:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:07:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:13 INFO - 'work_dir': 'build'} 10:07:13 INFO - ##### 10:07:13 INFO - ##### Running clobber step. 10:07:13 INFO - ##### 10:07:13 INFO - Running pre-action listener: _resource_record_pre_action 10:07:13 INFO - Running main action method: clobber 10:07:13 INFO - rmtree: /builds/slave/test-pgo/build 10:07:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:07:14 INFO - Running post-action listener: _resource_record_post_action 10:07:14 INFO - ##### 10:07:14 INFO - ##### Running read-buildbot-config step. 10:07:14 INFO - ##### 10:07:14 INFO - Running pre-action listener: _resource_record_pre_action 10:07:14 INFO - Running main action method: read_buildbot_config 10:07:14 INFO - Using buildbot properties: 10:07:14 INFO - { 10:07:14 INFO - "project": "", 10:07:14 INFO - "product": "firefox", 10:07:14 INFO - "script_repo_revision": "production", 10:07:14 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:07:14 INFO - "repository": "", 10:07:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:07:14 INFO - "buildid": "20160119073404", 10:07:14 INFO - "pgo_build": "True", 10:07:14 INFO - "basedir": "/builds/slave/test-pgo", 10:07:14 INFO - "buildnumber": 637, 10:07:14 INFO - "slavename": "talos-linux64-ix-056", 10:07:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:07:14 INFO - "platform": "ubuntu64_hw", 10:07:14 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:07:14 INFO - "branch": "mozilla-inbound", 10:07:14 INFO - "repo_path": "integration/mozilla-inbound", 10:07:14 INFO - "revision": "4f090efcb1b6a8d3058cd2c0dc310e5943e9c74c", 10:07:14 INFO - "stage_platform": "linux64-pgo", 10:07:14 INFO - "builduid": "da516b5f8037441b9f6f40b4d2b9e297", 10:07:14 INFO - "slavebuilddir": "test" 10:07:14 INFO - } 10:07:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:07:14 INFO - Running post-action listener: _resource_record_post_action 10:07:14 INFO - ##### 10:07:14 INFO - ##### Running download-and-extract step. 10:07:14 INFO - ##### 10:07:14 INFO - Running pre-action listener: _resource_record_pre_action 10:07:14 INFO - Running main action method: download_and_extract 10:07:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:14 INFO - https://queue.taskcluster.net/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:07:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/test_packages.json 10:07:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/test_packages.json 10:07:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:07:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:07:15 INFO - Downloaded 1448 bytes. 10:07:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:07:15 INFO - Using the following test package requirements: 10:07:15 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:15 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:07:15 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:07:15 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:15 INFO - u'jsshell-linux-x86_64.zip'], 10:07:15 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:07:15 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:15 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:07:15 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:07:15 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:07:15 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:15 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:07:15 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:15 INFO - https://queue.taskcluster.net/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:07:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:07:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/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 10:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/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 10:07:17 INFO - Downloaded 22484608 bytes. 10:07:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:07:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:07:19 INFO - Return code: 0 10:07:19 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 10:07:19 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')]} 10:07:19 INFO - https://queue.taskcluster.net/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:07:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:07:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/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 10:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/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 10:07:20 INFO - Downloaded 22484608 bytes. 10:07:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:07:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:07:21 INFO - Return code: 0 10:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:21 INFO - https://queue.taskcluster.net/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:07:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/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 10:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/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 10:07:25 INFO - Downloaded 11132144 bytes. 10:07:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:07:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 10:07:26 INFO - Return code: 0 10:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:26 INFO - https://queue.taskcluster.net/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:07:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:07:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:07:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/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 10:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8Psque-SpyIfYCNT98zgg/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 10:07:27 INFO - Downloaded 55929762 bytes. 10:07:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:07:27 INFO - mkdir: /builds/slave/test-pgo/properties 10:07:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:07:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:07:27 INFO - Contents: 10:07:27 INFO - build_url:https://queue.taskcluster.net/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:07:27 INFO - Running post-action listener: _resource_record_post_action 10:07:27 INFO - Running post-action listener: set_extra_try_arguments 10:07:27 INFO - ##### 10:07:27 INFO - ##### Running populate-webroot step. 10:07:27 INFO - ##### 10:07:27 INFO - Running pre-action listener: _resource_record_pre_action 10:07:27 INFO - Running main action method: populate_webroot 10:07:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:27 INFO - '--tppagecycles', 10:07:27 INFO - '7'], 10:07:27 INFO - 'tests': ['tsvgm']}}, 10:07:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:07:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:07:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:07:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:07:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:07:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:27 INFO - 'talos_options': ['--e10s'], 10:07:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:27 INFO - 'tests': ['damp', 'tps']}, 10:07:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:27 INFO - 'talos_options': ['--e10s'], 10:07:27 INFO - 'tests': ['damp', 'tps']}, 10:07:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:07:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:27 INFO - 'other': {'tests': ['a11yr', 10:07:27 INFO - 'ts_paint', 10:07:27 INFO - 'tpaint', 10:07:27 INFO - 'sessionrestore', 10:07:27 INFO - 'sessionrestore_no_auto_restore']}, 10:07:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:07:27 INFO - 'tests': ['a11yr', 10:07:27 INFO - 'ts_paint', 10:07:27 INFO - 'tpaint', 10:07:27 INFO - 'sessionrestore', 10:07:27 INFO - 'sessionrestore_no_auto_restore']}, 10:07:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:07:27 INFO - 'tests': ['a11yr', 10:07:27 INFO - 'ts_paint', 10:07:27 INFO - 'tpaint', 10:07:27 INFO - 'sessionrestore', 10:07:27 INFO - 'sessionrestore_no_auto_restore']}, 10:07:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:07:27 INFO - 'tests': ['a11yr', 10:07:27 INFO - 'ts_paint', 10:07:27 INFO - 'tpaint', 10:07:27 INFO - 'sessionrestore', 10:07:27 INFO - 'sessionrestore_no_auto_restore']}, 10:07:27 INFO - 'other_l64': {'tests': ['a11yr', 10:07:27 INFO - 'ts_paint', 10:07:27 INFO - 'tpaint', 10:07:27 INFO - 'sessionrestore', 10:07:27 INFO - 'sessionrestore_no_auto_restore']}, 10:07:27 INFO - 'other_nol64': {'tests': ['a11yr', 10:07:27 INFO - 'ts_paint', 10:07:27 INFO - 'tpaint', 10:07:27 INFO - 'sessionrestore', 10:07:27 INFO - 'sessionrestore_no_auto_restore']}, 10:07:27 INFO - 'svgr': {'tests': ['tsvgx', 10:07:27 INFO - 'tsvgr_opacity', 10:07:27 INFO - 'tart', 10:07:27 INFO - 'tscrollx', 10:07:27 INFO - 'cart']}, 10:07:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:07:27 INFO - 'tests': ['tsvgx', 10:07:27 INFO - 'tsvgr_opacity', 10:07:27 INFO - 'tart', 10:07:27 INFO - 'tscrollx', 10:07:27 INFO - 'cart']}, 10:07:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:27 INFO - 'tests': ['tp5o']}, 10:07:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:27 INFO - 'talos_options': ['--e10s'], 10:07:27 INFO - 'tests': ['tp5o']}, 10:07:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:27 INFO - 'talos_options': ['--xperf_path', 10:07:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:27 INFO - 'tests': ['tp5n']}, 10:07:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:27 INFO - 'talos_options': ['--e10s', 10:07:27 INFO - '--xperf_path', 10:07:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:27 INFO - 'tests': ['tp5n']}}, 10:07:27 INFO - 'talos.zip': {'path': '', 10:07:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:27 INFO - Running post-action listener: _resource_record_post_action 10:07:27 INFO - ##### 10:07:27 INFO - ##### Running create-virtualenv step. 10:07:27 INFO - ##### 10:07:27 INFO - Running pre-action listener: _resource_record_pre_action 10:07:27 INFO - Running main action method: create_virtualenv 10:07:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:07:27 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 10:07:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:07:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:27 INFO - Using real prefix '/usr' 10:07:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:07:28 INFO - Installing distribute.............................................................................................................................................................................................done. 10:07:30 INFO - Installing pip.................done. 10:07:30 INFO - Return code: 0 10:07:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb6d777f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1658230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea7f0>, '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 0x16562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656760>, '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': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', '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 10:07:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:07:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:07:30 INFO - Using env: {'DISPLAY': ':0', 10:07:30 INFO - 'HOME': '/home/cltbld', 10:07:30 INFO - 'LANG': 'en_US.UTF-8', 10:07:30 INFO - 'LANGUAGE': 'en_US:en', 10:07:30 INFO - 'LOGNAME': 'cltbld', 10:07:30 INFO - 'MAIL': '/var/mail/cltbld', 10:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:30 INFO - 'MOZ_NO_REMOTE': '1', 10:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:30 INFO - 'NO_EM_RESTART': '1', 10:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:30 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:30 INFO - 'SHELL': '/bin/bash', 10:07:30 INFO - 'SHLVL': '1', 10:07:30 INFO - 'TERM': 'linux', 10:07:30 INFO - 'TMOUT': '86400', 10:07:30 INFO - 'USER': 'cltbld', 10:07:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', 10:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:30 INFO - '_': '/tools/buildbot/bin/python'} 10:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:30 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 10:07:30 INFO - Cleaning up... 10:07:30 INFO - Return code: 0 10:07:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffb6d777f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1658230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea7f0>, '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 0x16562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656760>, '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': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', '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 10:07:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:07:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:07:30 INFO - Using env: {'DISPLAY': ':0', 10:07:30 INFO - 'HOME': '/home/cltbld', 10:07:30 INFO - 'LANG': 'en_US.UTF-8', 10:07:30 INFO - 'LANGUAGE': 'en_US:en', 10:07:30 INFO - 'LOGNAME': 'cltbld', 10:07:30 INFO - 'MAIL': '/var/mail/cltbld', 10:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:30 INFO - 'MOZ_NO_REMOTE': '1', 10:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:30 INFO - 'NO_EM_RESTART': '1', 10:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:30 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:30 INFO - 'SHELL': '/bin/bash', 10:07:30 INFO - 'SHLVL': '1', 10:07:30 INFO - 'TERM': 'linux', 10:07:30 INFO - 'TMOUT': '86400', 10:07:30 INFO - 'USER': 'cltbld', 10:07:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', 10:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:30 INFO - '_': '/tools/buildbot/bin/python'} 10:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:30 INFO - Downloading/unpacking psutil>=0.7.1 10:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:32 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:07:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:07:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:07:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:32 INFO - Installing collected packages: psutil 10:07:32 INFO - Running setup.py install for psutil 10:07:32 INFO - building 'psutil._psutil_linux' extension 10:07:32 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 10:07:32 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 10:07:32 INFO - building 'psutil._psutil_posix' extension 10:07:32 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 10:07:33 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 10:07:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:33 INFO - Successfully installed psutil 10:07:33 INFO - Cleaning up... 10:07:33 INFO - Return code: 0 10:07:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:07:33 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')]} 10:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:33 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')]} 10:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:33 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 0x7ffb6d777f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1658230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea7f0>, '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 0x16562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656760>, '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': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', '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 10:07:33 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 10:07:33 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 10:07:33 INFO - Using env: {'DISPLAY': ':0', 10:07:33 INFO - 'HOME': '/home/cltbld', 10:07:33 INFO - 'LANG': 'en_US.UTF-8', 10:07:33 INFO - 'LANGUAGE': 'en_US:en', 10:07:33 INFO - 'LOGNAME': 'cltbld', 10:07:33 INFO - 'MAIL': '/var/mail/cltbld', 10:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:33 INFO - 'MOZ_NO_REMOTE': '1', 10:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:33 INFO - 'NO_EM_RESTART': '1', 10:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:33 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:33 INFO - 'SHELL': '/bin/bash', 10:07:33 INFO - 'SHLVL': '1', 10:07:33 INFO - 'TERM': 'linux', 10:07:33 INFO - 'TMOUT': '86400', 10:07:33 INFO - 'USER': 'cltbld', 10:07:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', 10:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:33 INFO - '_': '/tools/buildbot/bin/python'} 10:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:07:33 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 10:07:33 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 10:07:33 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 10:07:33 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 10:07:33 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 10:07:33 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 10:07:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:07:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:07:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:07:35 INFO - Installing collected packages: mozsystemmonitor 10:07:35 INFO - Running setup.py install for mozsystemmonitor 10:07:35 INFO - Successfully installed mozsystemmonitor 10:07:35 INFO - Cleaning up... 10:07:35 INFO - Return code: 0 10:07:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:35 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 0x7ffb6d777f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1658230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea7f0>, '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 0x16562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656760>, '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': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', '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 10:07:35 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 10:07:35 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 10:07:35 INFO - Using env: {'DISPLAY': ':0', 10:07:35 INFO - 'HOME': '/home/cltbld', 10:07:35 INFO - 'LANG': 'en_US.UTF-8', 10:07:35 INFO - 'LANGUAGE': 'en_US:en', 10:07:35 INFO - 'LOGNAME': 'cltbld', 10:07:35 INFO - 'MAIL': '/var/mail/cltbld', 10:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:35 INFO - 'MOZ_NO_REMOTE': '1', 10:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:35 INFO - 'NO_EM_RESTART': '1', 10:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:35 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:35 INFO - 'SHELL': '/bin/bash', 10:07:35 INFO - 'SHLVL': '1', 10:07:35 INFO - 'TERM': 'linux', 10:07:35 INFO - 'TMOUT': '86400', 10:07:35 INFO - 'USER': 'cltbld', 10:07:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', 10:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:35 INFO - '_': '/tools/buildbot/bin/python'} 10:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:35 INFO - Downloading/unpacking blobuploader==1.2.4 10:07:35 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 10:07:35 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 10:07:35 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 10:07:35 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 10:07:35 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 10:07:35 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 10:07:37 INFO - Downloading blobuploader-1.2.4.tar.gz 10:07:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:07:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:07:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:07:37 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 10:07:37 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 10:07:37 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 10:07:37 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 10:07:37 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 10:07:37 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 10:07:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:07:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:07:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:07:37 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 10:07:37 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 10:07:37 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 10:07:37 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 10:07:37 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 10:07:37 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 10:07:37 INFO - Downloading docopt-0.6.1.tar.gz 10:07:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:07:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:07:37 INFO - Installing collected packages: blobuploader, requests, docopt 10:07:37 INFO - Running setup.py install for blobuploader 10:07:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:07:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:07:38 INFO - Running setup.py install for requests 10:07:38 INFO - Running setup.py install for docopt 10:07:38 INFO - Successfully installed blobuploader requests docopt 10:07:38 INFO - Cleaning up... 10:07:38 INFO - Return code: 0 10:07:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:38 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 0x7ffb6d777f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1658230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea7f0>, '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 0x16562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656760>, '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': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', '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 10:07:38 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 10:07:38 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 10:07:38 INFO - Using env: {'DISPLAY': ':0', 10:07:38 INFO - 'HOME': '/home/cltbld', 10:07:38 INFO - 'LANG': 'en_US.UTF-8', 10:07:38 INFO - 'LANGUAGE': 'en_US:en', 10:07:38 INFO - 'LOGNAME': 'cltbld', 10:07:38 INFO - 'MAIL': '/var/mail/cltbld', 10:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:38 INFO - 'MOZ_NO_REMOTE': '1', 10:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:38 INFO - 'NO_EM_RESTART': '1', 10:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:38 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:38 INFO - 'SHELL': '/bin/bash', 10:07:38 INFO - 'SHLVL': '1', 10:07:38 INFO - 'TERM': 'linux', 10:07:38 INFO - 'TMOUT': '86400', 10:07:38 INFO - 'USER': 'cltbld', 10:07:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', 10:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:38 INFO - '_': '/tools/buildbot/bin/python'} 10:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:07:38 INFO - Running setup.py (path:/tmp/pip-dodhVR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:07:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:07:38 INFO - Running setup.py (path:/tmp/pip-PPYODq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:07:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:07:38 INFO - Running setup.py (path:/tmp/pip-rTXWl1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:07:39 INFO - Running setup.py (path:/tmp/pip-Q8_VLH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:07:39 INFO - Running setup.py (path:/tmp/pip-cpQDdW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:07:39 INFO - Running setup.py (path:/tmp/pip-66vr6i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:07:39 INFO - Running setup.py (path:/tmp/pip-f8o7jH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:07:39 INFO - Running setup.py (path:/tmp/pip-m808Ti-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:07:39 INFO - Running setup.py (path:/tmp/pip-KEegFN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:07:39 INFO - Running setup.py (path:/tmp/pip-fdubYA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:07:39 INFO - Running setup.py (path:/tmp/pip-fEf4Tl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:07:39 INFO - Running setup.py (path:/tmp/pip-pSp1M4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:07:39 INFO - Running setup.py (path:/tmp/pip-mlvMeN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:07:39 INFO - Running setup.py (path:/tmp/pip-kjh6_c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:07:39 INFO - Running setup.py (path:/tmp/pip-tUDe4V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:07:39 INFO - Running setup.py (path:/tmp/pip-3BrMvv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:07:39 INFO - Running setup.py (path:/tmp/pip-zTzI4d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:07:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:07:40 INFO - Running setup.py install for manifestparser 10:07:40 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:07:40 INFO - Running setup.py install for mozcrash 10:07:40 INFO - Running setup.py install for mozdebug 10:07:40 INFO - Running setup.py install for mozdevice 10:07:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:07:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:07:40 INFO - Running setup.py install for mozfile 10:07:40 INFO - Running setup.py install for mozhttpd 10:07:40 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:07:40 INFO - Running setup.py install for mozinfo 10:07:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:07:40 INFO - Running setup.py install for mozInstall 10:07:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:07:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:07:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:07:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:07:40 INFO - Running setup.py install for mozleak 10:07:40 INFO - Running setup.py install for mozlog 10:07:41 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:07:41 INFO - Running setup.py install for moznetwork 10:07:41 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:07:41 INFO - Running setup.py install for mozprocess 10:07:41 INFO - Running setup.py install for mozprofile 10:07:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:07:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:07:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:07:41 INFO - Running setup.py install for mozrunner 10:07:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:07:41 INFO - Running setup.py install for mozscreenshot 10:07:41 INFO - Running setup.py install for moztest 10:07:41 INFO - Running setup.py install for mozversion 10:07:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:07:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:07:41 INFO - Cleaning up... 10:07:41 INFO - Return code: 0 10:07:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:41 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 0x7ffb6d777f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1658230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea7f0>, '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 0x16562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656760>, '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': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', '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 10:07:41 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 10:07:41 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 10:07:41 INFO - Using env: {'DISPLAY': ':0', 10:07:41 INFO - 'HOME': '/home/cltbld', 10:07:41 INFO - 'LANG': 'en_US.UTF-8', 10:07:41 INFO - 'LANGUAGE': 'en_US:en', 10:07:41 INFO - 'LOGNAME': 'cltbld', 10:07:41 INFO - 'MAIL': '/var/mail/cltbld', 10:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:41 INFO - 'MOZ_NO_REMOTE': '1', 10:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:41 INFO - 'NO_EM_RESTART': '1', 10:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:41 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:41 INFO - 'SHELL': '/bin/bash', 10:07:41 INFO - 'SHLVL': '1', 10:07:41 INFO - 'TERM': 'linux', 10:07:41 INFO - 'TMOUT': '86400', 10:07:41 INFO - 'USER': 'cltbld', 10:07:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', 10:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:41 INFO - '_': '/tools/buildbot/bin/python'} 10:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:07:42 INFO - Running setup.py (path:/tmp/pip-Bsh2Aa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:07:42 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)) 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:07:42 INFO - Running setup.py (path:/tmp/pip-IdRPFo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:07:42 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)) 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:07:42 INFO - Running setup.py (path:/tmp/pip-viV0yu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:07:42 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)) 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:07:42 INFO - Running setup.py (path:/tmp/pip-Ra3DFb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:07:42 INFO - Running setup.py (path:/tmp/pip-D0miql-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:07:42 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)) 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:07:42 INFO - Running setup.py (path:/tmp/pip-XyV4OH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:07:42 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)) 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:07:42 INFO - Running setup.py (path:/tmp/pip-GNNtyj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:07:42 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)) 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:07:42 INFO - Running setup.py (path:/tmp/pip-6GWkwm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:07:42 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)) 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:07:42 INFO - Running setup.py (path:/tmp/pip-3FDrld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:07:42 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)) 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:07:42 INFO - Running setup.py (path:/tmp/pip-61LIzG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:07:42 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)) 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:07:42 INFO - Running setup.py (path:/tmp/pip-3iXKAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:07:42 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)) 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:07:42 INFO - Running setup.py (path:/tmp/pip-C177X6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:07:42 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)) 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:07:42 INFO - Running setup.py (path:/tmp/pip-J3Srif-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:07:42 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)) 10:07:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:07:42 INFO - Running setup.py (path:/tmp/pip-wYGcN5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:07:43 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)) 10:07:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:07:43 INFO - Running setup.py (path:/tmp/pip-aw5CZF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:07:43 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)) 10:07:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:07:43 INFO - Running setup.py (path:/tmp/pip-jMDeVX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:07:43 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)) 10:07:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:07:43 INFO - Running setup.py (path:/tmp/pip-QZDlMp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:07:43 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)) 10:07:43 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)) 10:07:43 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)) 10:07:43 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)) 10:07:43 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:07:43 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:07:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:07:43 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 10:07:43 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 10:07:43 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 10:07:43 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 10:07:43 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 10:07:43 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 10:07:45 INFO - Downloading blessings-1.5.1.tar.gz 10:07:45 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 10:07:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:07:45 INFO - Installing collected packages: blessings 10:07:45 INFO - Running setup.py install for blessings 10:07:45 INFO - Successfully installed blessings 10:07:45 INFO - Cleaning up... 10:07:45 INFO - Return code: 0 10:07:45 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:07:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:07:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:07:45 INFO - Reading from file tmpfile_stdout 10:07:45 INFO - Current package versions: 10:07:45 INFO - argparse == 1.2.1 10:07:45 INFO - blessings == 1.5.1 10:07:45 INFO - blobuploader == 1.2.4 10:07:45 INFO - docopt == 0.6.1 10:07:45 INFO - manifestparser == 1.1 10:07:45 INFO - mozInstall == 1.12 10:07:45 INFO - mozcrash == 0.16 10:07:45 INFO - mozdebug == 0.1 10:07:45 INFO - mozdevice == 0.48 10:07:45 INFO - mozfile == 1.2 10:07:45 INFO - mozhttpd == 0.7 10:07:45 INFO - mozinfo == 0.9 10:07:45 INFO - mozleak == 0.1 10:07:45 INFO - mozlog == 3.1 10:07:45 INFO - moznetwork == 0.27 10:07:45 INFO - mozprocess == 0.22 10:07:45 INFO - mozprofile == 0.28 10:07:45 INFO - mozrunner == 6.11 10:07:45 INFO - mozscreenshot == 0.1 10:07:45 INFO - mozsystemmonitor == 0.0 10:07:45 INFO - moztest == 0.7 10:07:45 INFO - mozversion == 1.4 10:07:45 INFO - psutil == 3.1.1 10:07:45 INFO - requests == 1.2.3 10:07:45 INFO - wsgiref == 0.1.2 10:07:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:07: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')]} 10:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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')]} 10:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:45 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 0x7ffb6d777f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1658230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea7f0>, '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 0x16562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656760>, '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': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', '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 10:07:45 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 10:07:45 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 10:07:45 INFO - Using env: {'DISPLAY': ':0', 10:07:45 INFO - 'HOME': '/home/cltbld', 10:07:45 INFO - 'LANG': 'en_US.UTF-8', 10:07:45 INFO - 'LANGUAGE': 'en_US:en', 10:07:45 INFO - 'LOGNAME': 'cltbld', 10:07:45 INFO - 'MAIL': '/var/mail/cltbld', 10:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:45 INFO - 'MOZ_NO_REMOTE': '1', 10:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:45 INFO - 'NO_EM_RESTART': '1', 10:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:45 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:45 INFO - 'SHELL': '/bin/bash', 10:07:45 INFO - 'SHLVL': '1', 10:07:45 INFO - 'TERM': 'linux', 10:07:45 INFO - 'TMOUT': '86400', 10:07:45 INFO - 'USER': 'cltbld', 10:07:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', 10:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:45 INFO - '_': '/tools/buildbot/bin/python'} 10:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:45 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)) 10:07:45 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)) 10:07:45 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)) 10:07:45 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)) 10:07:45 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)) 10:07:45 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)) 10:07:45 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)) 10:07:45 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)) 10:07:45 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)) 10:07:45 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)) 10:07:45 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)) 10:07:45 INFO - Cleaning up... 10:07:45 INFO - Return code: 0 10:07:45 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:07: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')]} 10:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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')]} 10:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:45 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 0x7ffb6d777f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1658230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea7f0>, '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 0x16562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656760>, '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': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', '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 10:07:45 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 10:07:45 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 10:07:45 INFO - Using env: {'DISPLAY': ':0', 10:07:45 INFO - 'HOME': '/home/cltbld', 10:07:45 INFO - 'LANG': 'en_US.UTF-8', 10:07:45 INFO - 'LANGUAGE': 'en_US:en', 10:07:45 INFO - 'LOGNAME': 'cltbld', 10:07:45 INFO - 'MAIL': '/var/mail/cltbld', 10:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:45 INFO - 'MOZ_NO_REMOTE': '1', 10:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:45 INFO - 'NO_EM_RESTART': '1', 10:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:45 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:45 INFO - 'SHELL': '/bin/bash', 10:07:45 INFO - 'SHLVL': '1', 10:07:45 INFO - 'TERM': 'linux', 10:07:45 INFO - 'TMOUT': '86400', 10:07:45 INFO - 'USER': 'cltbld', 10:07:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', 10:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:45 INFO - '_': '/tools/buildbot/bin/python'} 10:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:46 INFO - Downloading/unpacking jsonschema 10:07:46 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 10:07:46 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 10:07:46 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 10:07:46 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 10:07:46 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 10:07:46 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 10:07:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:47 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 10:07:47 INFO - Downloading/unpacking functools32 (from jsonschema) 10:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:47 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:07:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:07:48 INFO - warning: no files found matching '*.txt' 10:07:48 INFO - no previously-included directories found matching 'build' 10:07:48 INFO - no previously-included directories found matching 'dist' 10:07:48 INFO - no previously-included directories found matching '.git*' 10:07:48 INFO - Installing collected packages: jsonschema, functools32 10:07:48 INFO - Running setup.py install for functools32 10:07:48 INFO - warning: no files found matching '*.txt' 10:07:48 INFO - no previously-included directories found matching 'build' 10:07:48 INFO - no previously-included directories found matching 'dist' 10:07:48 INFO - no previously-included directories found matching '.git*' 10:07:48 INFO - Successfully installed jsonschema functools32 10:07:48 INFO - Cleaning up... 10:07:48 INFO - Return code: 0 10:07:48 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:07:48 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')]} 10:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:48 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')]} 10:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:48 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 0x7ffb6d777f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1658230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea7f0>, '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 0x16562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656760>, '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': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', '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 10:07:48 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 10:07:48 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 10:07:48 INFO - Using env: {'DISPLAY': ':0', 10:07:48 INFO - 'HOME': '/home/cltbld', 10:07:48 INFO - 'LANG': 'en_US.UTF-8', 10:07:48 INFO - 'LANGUAGE': 'en_US:en', 10:07:48 INFO - 'LOGNAME': 'cltbld', 10:07:48 INFO - 'MAIL': '/var/mail/cltbld', 10:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:48 INFO - 'MOZ_NO_REMOTE': '1', 10:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:48 INFO - 'NO_EM_RESTART': '1', 10:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:48 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:48 INFO - 'SHELL': '/bin/bash', 10:07:48 INFO - 'SHLVL': '1', 10:07:48 INFO - 'TERM': 'linux', 10:07:48 INFO - 'TMOUT': '86400', 10:07:48 INFO - 'USER': 'cltbld', 10:07:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', 10:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:48 INFO - '_': '/tools/buildbot/bin/python'} 10:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:48 INFO - Downloading/unpacking flake8 10:07:48 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 10:07:48 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 10:07:48 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 10:07:48 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 10:07:48 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 10:07:48 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 10:07:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:07:50 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 10:07:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:07:50 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 10:07:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:07:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:07:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:50 INFO - no previously-included directories found matching 'docs/_build' 10:07:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:07:50 INFO - Running setup.py install for pep8 10:07:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:50 INFO - no previously-included directories found matching 'docs/_build' 10:07:51 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:07:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:07:51 INFO - Cleaning up... 10:07:51 INFO - Return code: 0 10:07:51 INFO - Running post-action listener: _resource_record_post_action 10:07:51 INFO - Running post-action listener: _start_resource_monitoring 10:07:51 INFO - Starting resource monitoring. 10:07:51 INFO - ##### 10:07:51 INFO - ##### Running install step. 10:07:51 INFO - ##### 10:07:51 INFO - Running pre-action listener: _resource_record_pre_action 10:07:51 INFO - Running main action method: install 10:07:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:07:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:07:51 INFO - Reading from file tmpfile_stdout 10:07:51 INFO - Detecting whether we're running mozinstall >=1.0... 10:07:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:07:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:07:51 INFO - Reading from file tmpfile_stdout 10:07:51 INFO - Output received: 10:07:51 INFO - Usage: mozinstall [options] installer 10:07:51 INFO - Options: 10:07:51 INFO - -h, --help show this help message and exit 10:07:51 INFO - -d DEST, --destination=DEST 10:07:51 INFO - Directory to install application into. [default: 10:07:51 INFO - "/builds/slave/test-pgo"] 10:07:51 INFO - --app=APP Application being installed. [default: firefox] 10:07:51 INFO - mkdir: /builds/slave/test-pgo/build/application 10:07:51 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'] 10:07:51 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 10:08:07 INFO - Reading from file tmpfile_stdout 10:08:07 INFO - Output received: 10:08:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:08:07 INFO - Running post-action listener: _resource_record_post_action 10:08:07 INFO - ##### 10:08:07 INFO - ##### Running run-tests step. 10:08:07 INFO - ##### 10:08:07 INFO - Running pre-action listener: _resource_record_pre_action 10:08:07 INFO - Running main action method: run_tests 10:08:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:08:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:08:07 INFO - Python 2.7.3 10:08:07 INFO - Return code: 0 10:08:07 INFO - grabbing minidump binary from tooltool 10:08: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')]} 10:08:07 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 0x16ea7f0>, '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 0x16562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:08:07 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 10:08:07 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 10:08:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:08:07 INFO - Return code: 0 10:08:07 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:08:07 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:08:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:08:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:08:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:08:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:08:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:08:08 INFO - Return code: 0 10:08:08 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 10:08:08 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 10:08:08 INFO - Using env: {'DISPLAY': ':0', 10:08:08 INFO - 'HOME': '/home/cltbld', 10:08:08 INFO - 'LANG': 'en_US.UTF-8', 10:08:08 INFO - 'LANGUAGE': 'en_US:en', 10:08:08 INFO - 'LOGNAME': 'cltbld', 10:08:08 INFO - 'MAIL': '/var/mail/cltbld', 10:08:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:08:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:08 INFO - 'MOZ_NO_REMOTE': '1', 10:08:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:08 INFO - 'NO_EM_RESTART': '1', 10:08:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:08:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:08:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:08:08 INFO - 'SHELL': '/bin/bash', 10:08:08 INFO - 'SHLVL': '1', 10:08:08 INFO - 'TERM': 'linux', 10:08:08 INFO - 'TMOUT': '86400', 10:08:08 INFO - 'USER': 'cltbld', 10:08:08 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376', 10:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:08 INFO - '_': '/tools/buildbot/bin/python'} 10:08:08 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:08:08 INFO - mozversion application_buildid: 20160119073404 10:08:08 INFO - mozversion application_changeset: 4f090efcb1b6a8d3058cd2c0dc310e5943e9c74c 10:08:08 INFO - mozversion application_display_name: Nightly 10:08:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:08:08 INFO - mozversion application_name: Firefox 10:08:08 INFO - mozversion application_remotingname: firefox 10:08:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:08:08 INFO - mozversion application_vendor: Mozilla 10:08:08 INFO - mozversion application_version: 46.0a1 10:08:08 INFO - mozversion platform_buildid: 20160119073404 10:08:08 INFO - mozversion platform_changeset: 4f090efcb1b6a8d3058cd2c0dc310e5943e9c74c 10:08:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:08:08 INFO - mozversion platform_version: 46.0a1 10:08:08 INFO - using testdate: 1453226888 10:08:08 INFO - actual date: 1453226888 10:08:08 INFO - starting webserver on 'localhost:50943' 10:08:08 INFO - SUITE-START | Running 3 tests 10:08:08 INFO - TEST-START | dromaeo_css 10:08:08 INFO - operating with platform_type : linux_ 10:08:08 INFO - Initialising browser for dromaeo_css test... 10:08:08 INFO - TEST-INFO | started process 5203 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQtkQaL/profile http://localhost:50943/getInfo.html) 10:08:13 INFO - PROCESS | 5203 | __metrics Screen width/height:1600/1200 10:08:13 INFO - PROCESS | 5203 | colorDepth:24 10:08:13 INFO - PROCESS | 5203 | Browser inner width/height: 1024/697 10:08:13 INFO - PROCESS | 5203 | __metrics 10:08:13 INFO - PROCESS | 5203 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:08:13 INFO - PROCESS | 5203 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:08:14 INFO - TEST-INFO | 5203: exit 0 10:08:14 INFO - Browser initialized. 10:08:14 INFO - Running cycle 1/1 for dromaeo_css test... 10:08:14 INFO - TEST-INFO | started process 5296 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQtkQaL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:25 INFO - PROCESS | 5296 | RSS: Main: 148758528 10:08:25 INFO - PROCESS | 5296 | 10:09:17 INFO - PROCESS | 5296 | 1453226957624 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] 10:11:25 INFO - PROCESS | 5296 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50943/tests/dromaeo/cssquery-ext.html) 10:11:26 INFO - PROCESS | 5296 | RSS: Main: 280621056 10:11:26 INFO - PROCESS | 5296 | 10:14:28 INFO - PROCESS | 5296 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-ext.html (next: http://localhost:50943/tests/dromaeo/cssquery-jquery.html) 10:14:29 INFO - PROCESS | 5296 | RSS: Main: 234262528 10:14:29 INFO - PROCESS | 5296 | 10:17:31 INFO - PROCESS | 5296 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50943/tests/dromaeo/cssquery-mootools.html) 10:17:31 INFO - PROCESS | 5296 | RSS: Main: 243326976 10:17:31 INFO - PROCESS | 5296 | 10:20:33 INFO - PROCESS | 5296 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50943/tests/dromaeo/cssquery-prototype.html) 10:20:34 INFO - PROCESS | 5296 | RSS: Main: 214986752 10:20:34 INFO - PROCESS | 5296 | 10:23:36 INFO - PROCESS | 5296 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50943/tests/dromaeo/cssquery-yui.html) 10:23:37 INFO - PROCESS | 5296 | RSS: Main: 216428544 10:23:37 INFO - PROCESS | 5296 | 10:26:40 INFO - PROCESS | 5296 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-yui.html (next: http://localhost:50943/tests/dromaeo/cssquery-dojo.html) 10:26:40 INFO - PROCESS | 5296 | RSS: Main: 258891776 10:26:40 INFO - PROCESS | 5296 | 10:26:40 INFO - PROCESS | 5296 | __start_tp_report 10:26:40 INFO - PROCESS | 5296 | _x_x_mozilla_page_load 10:26:40 INFO - PROCESS | 5296 | _x_x_mozilla_page_load_details 10:26:40 INFO - PROCESS | 5296 | |i|pagename|runs| 10:26:40 INFO - PROCESS | 5296 | |0;dojo.html;3119.5632611434417;3126.171564535398;3176.142441540783;3177.6345720242166;3210.0690799668096;5013.14776487997;5117.360329958755;5134.768935397911;5149.716765577892;5203.791848326067;5141.485851414856;5147.38231412231;5159.767810448529;5163.922541161876;5188.896222075557;4740.26525888487;4815.036992601494;4819.662623616348;4841.370621819176;4844.854654360375;4777.163996300634;4795.736234507101;4824.662273640846;4825.493323201066;4860.781264843073;653.4878185620292;4667.836625718118;4717.811287548494;4725.574698277137;4764.452088009889;4674.11191873543;4724.267738500538;4738.881527961794;4748.833790817339;4758.809647614091;4720.834770783041;4742.241241401393;4745.881352966169;4748.050389922029;4777.331173635694;5032.798688052473;5038.874028149326;5039.496050394968;5041.445441001487;5074.264231686385;5529.391766905637;5543.36251331094;5568.972155139239;5569.220309156722;5584.664920104766;5471.316085489314;5538.47384498472;5573.554115670737;5576.888462230773;5635.408282130358;5186.688798672017;5186.948130518685;5199.766010529535;5201.011807756514;5207.791688332462;5522.447755224445;5652.9152062719095;5664.348599911063;5674.97162514193;5685.602007859493;5326.2543243945875;5476.890462190813;5525.723713814293;5527.115661494142;5544.22380866679;5552.7223638817895;5576.553875689935;5581.413951535112;5585.609007369445;5588.636738611977;5348.171033489815;5469.507744303032;5554.166874968787;5563.248961390242;5566.888662226733;5548.167774833807;5585.972070139624;5587.804426845122;5592.860178495489;5627.437256274422;4284.871453856389;4305.612494875476;4308.310670292738;4314.525402205755;4333.306670932636;3814.275287695329;3829.1767270037076;3871.922561548753;3876.6123387661573;3893.980530097331;5155.458676838878;5180.378354597397;5181.715005674649;5183.222516622537;5195.948040519622;5527.032769265363;5547.77808887648;5549.500544950974;5549.639273447294;5595.8601034973635;5086.160783470686;5150.6137039721425;5164.845054648366;5168.586513078944;5238.869028274324;4766.928496072562;4771.73755443447;4787.234042553175;4804.95195048052;4820.517948205222;5812.128180772918;5829.067349224104;5829.650220986669;5831.854203644943;5832.766689332379;5400.351957765093;5467.207254947931;5533.889322213614;5578.079616863172;5657.179708942098;5753.913691294718;5758.3090029196765;5760.308762948473;5769.68266745333;5771.105478650816;5373.704446255493;5431.918521222264;5472.890542189054;5482.0406428875585;5484.780608775604;5530.474604912527;5595.944040559542;5648.661080335193;5654.321481422256;5690.2887139107615;5410.48600382963;5418.133098704346;5421.186821976577;5434.728263586726;5435.755391007335;5295.602829787705;5369.973150134224;5396.541293990055;5402.189671549299;5449.6185267032515;5257.106291930458;5295.629305948547;5302.920456193237;5312.5218730314455;5339.546138578109;5385.676859388449;5395.973020134874;5418.349798024262;5418.674879507243;5503.284573005483;5289.973550132225;5296.841094767163;5322.387925388475;5340.092184328596;5369.785208591613 10:26:40 INFO - PROCESS | 5296 | |1;ext.html;534.9545288650464;537.4169026606135;558.5168828962949;559.3204256827954;573.9540836733062;28747.425051498958;29240.56139157912;29254.85372573137;36093.097672558135;36150.45774313381;41260.79369603156;42178;42195.78902105485;42222.366664500056;42361.152776944444;8554.05905350411;8711.869321960176;8746.256568191711;8765.693200737944;8768.167024132728;8429.199226073513;8563;8565.271951884097;8566.61450234741;8567.314614830799;8515.701950431736;8580.356473264499;8586.656533738675;8596.226339629433;8596.828063438728;8508.276796472277;8567.871481927776;8572.271356934636;8578.39951203416;8578.485290882567;8368.37237207212;8577.228049475578;8583.785405364853;8600.440971336842;8610.741677749678;38509.22981540354;38897.61102388968;38921;39026;39074.80462597697;3100.2404410919244;3145.6382516010494;3195;3548.627394123606;4039.0306326481727;29152.854235728897;29902.401951960837;29947.15502027304;30314.84842575795;30767.538486922713;3785.3754130568423;3920.7468279272007;3922.7057970652313;3969.503812023497;3993.101552150772;262055;262584;263294;263789;264924.6753766238;50926.23610645843;51859.48140518546;55562.44437555573;56025.7198714012;56080.439195608335;48982.26526602104;61910;63037.68481157565;63157.36842631607;63169.36830631635;12280.140390172603;12461.93769031149;12553.121281510206;12562.685932851751;12577.559785407468;8380.120087390858;8787.428817126995;9371.109744574254;9371.906280937239;9406.670766523139;19224.903875480533;19287.421377358703;19352;19419.51451213731;19442.70835937462;7046.6828992695455;7149.891766776158;7189;7274.418046556369;7339.082614673166;943.8914524829595;971.825071487125;1046.8586740789897;1054.1724746074294;1059.7456610413444;27937;28161;28244;28334;28560.28599284993;1041.4792603698152;1055.72551136705;1063.6808957312776;1068.0654427376046;1110.6168371911679;14811.407543698131;14819.259037048105;14850.777238341434;14961.700765984837;14975.775363369557;309873;311956;312236;313582;313645;51776.74111629418;51985.220221696705;52016.21975670368;52055.47944520582;52109;1291.0897817038965;1293.4761421624257;1304.0219835123658;1309.7838856588746;1335.2789493673308;27457.45085098247;28340.43319133647;28391;28486.287842804097;28658.713412865603;46303.76848115738;46480.30279545742;46527.76736116298;46566.30150547812;46723.53276467328;287481;289042;290418;290685;290795;28170.2957426066;29575.408491830472;31391.529127063568;31692;31715.682843171275;37051.62948370482;37088.81455592705;37527;38505.229895401375;38535.6146438532;30096.849515753158;32408.189795255308;34887.476687849194;35793;35838;29849;32120.196995075312;32342;32900.34199316048;35119.06845123543;32050.19874503156;32682.182945425604;32788.672113279514;32925.83537082299;33173.33653326872;28872.133835984954;29426.705732942395;30601.23496912595;31630.36739265156;31877.20306992344;23803.761962380155;24194.63708044416;24276.793048503572;24433.3891652703;24466.266012018958 10:26:40 INFO - PROCESS | 5296 | |2;jquery.html;353.73116431512057;366.50887810334154;366.95596528416587;369.38313017261186;374.5374462538762;13867.514636987707;13875.583732488041;15636.35818239084;16409.507714768562;17296.30814767411;15406.3837446502;15939.362425502995;16004.75992860108;16046.679066418665;17288.82711172891;5392.892142157164;5567.972160139194;5568.805091821787;5568.9443105568835;5573.052581061229;4043.1509383029597;4179.185058913513;5469.07025805612;5536.889262214753;5870.73581688825;5790.10253410722;5994.310654274749;6038.396160383948;6040.456358927696;6047.7278522466595;5934.28788545373;5958.344582095966;5958.493528050121;5968.492678122343;5986.221791167142;5112.846614601568;5280.075986702312;5414.269073675043;5420.810271640474;5428.9185662215095;19844.305449309348;20174.596508069757;20382.490437739027;20566.794332056637;20568.897155514125;2017.2536161620294;2027.1891243502569;2068.348470231872;2097.0869933982385;2260.5930932432157;8842.381033327669;9481.194098501635;9704.70885873425;12070.939645301805;12308.692282693004;1697.7283634618525;1808.9276428942826;1845.7046872500337;1871.6471289489398;1871.9532011699816;51538.22692659651;56327.71836140834;57467.13799293014;60386.39613603896;60416;9570.712878613513;9828.606855725691;9957.477852006947;10098.343607665625;10189.439580823126;13231.3384330785;13310.401031953585;13338;13342.332883355793;13362.33188340579;6775.3224677532835;6777.966110169417;6834.8633027340165;6904.896426553606;7008.684609192598;6406.2953075161695;6454.580452270681;6490.286068532458;6534.411902928759;6566.9343306566325;4281;4365.279728844768;4376.299792033259;4390.05613793036;4399.934000989988;1646.7612196231719;1684.1831711619855;1730.498155534906;1746.56335916021;1755.0698129991124;890.9688160914467;936.6862101196176;969.1665167955553;985;995.1292618958412;13907.304634768221;15543.611409714847;15994.280257388446;16687.615969354192;17673.646527069643;911.8313112074287;918.1461241045891;927.355487935878;944.3719926248967;968.6851773173747;9147.63409463614;9550.188234000048;9572.425654460616;9600.903990960001;9646.372985755903;521769;523247;551450;560130;566334;71728.2827171732;73069.26930730732;73284.63357683284;73704.63147684227;75023.24976750271;1132.4960392625203;1142.765733024728;1142.9371384573928;1149.2816989381636;1156.502703837358;14759.631009224855;14912.7763083556;15050.322735476711;15182.696346073237;15201.315940782912;32502.674973250912;32941.67058329482;32985.83507082449;34085.82957085199;34184;42553;42601.36097958595;43359.34960975651;43467.782661086494;43693.344599830394;7165.211826699163;7397.556146631219;7437.925620743939;7533.209013053551;7622.161562228262;7714.382849371925;10296.485175741333;10356.844647330447;10944.23390362667;11287.43562821872;9027.36808423404;9162.26701863836;9383;9390.859137113086;9633.470159141314;9490.240780737662;9577.329586928849;9613.90386096158;9918.504074796376;9925.602975881173;9118.863217051883;9738.951305243429;9800.019998000143;9989.300748947504;10227.84658230142;7204.243554426919;7280.890786638099;7348.56702942921;7437.962810185914;7522.511036782592;9497.905020949978;10098.19214462856;10156.39061656303;10200.846987295345;10349.482525873827 10:26:40 INFO - PROCESS | 5296 | |3;mootools.html;1363.5363976248086;1453.4622189789777;1466.1862666220247;1625.1305551529927;1806.5303021214488;6619.801405957823;7303.744368947081;7432.851342973137;7440.627968601575;7462.738804141856;7167.139943206823;7346.816329591763;7358.080239970004;7361.4110871130315;7371.778846634609;1938.8642795004355;1991.1736629298896;1991.920323187078;2265.139247086109;2304.193532263711;2022.0294258755805;2272.6136556785386;2330.2310237621627;2332.11379675723;2332.895019724108;2246.067881829039;2270.2735124760084;2281.8973146208377;2285.462916214688;2288.336382449088;2253.188852013274;2294.6443301288327;2300.413394584387;2303.2514432809403;2308.0306271366067;2230.531588366445;2231.029502166563;2237.966430503544;2242.9102835886547;2247.752747197807;7576.772696819049;7623.733169339046;7627.923720762832;7638.770836874847;7638.961805190994;4555.111753208126;4618.237990731525;4645.256758918591;4646.163690535702;4651.139539185261;2978.538326559387;3100.5989681143437;3180.3003339265324;3194.185482701919;3205.246767009751;1014.5485259059722;1020.7193021918957;1043.207162556455;1054.1672079057535;1076.9030787229187;10101.393916365041;10108.64619738313;10113.089821916063;10114.848277275847;10123.29136960413;4138.710290279651;4183.372494125844;4209.705320627588;4221.733479956062;4292.678049146264;8773.42972706772;8777.122287771172;8793.428427152214;8804.295656347476;8804.691835785718;4649.442066951988;4660.13787449323;4661.557152070548;4662.860114196579;4662.930056049162;4212.304969679968;4241.109367032957;4246.171996460661;4251.87244382669;4252.914941701149;3377.611574668895;3434;3671.687906527975;3688.0595448160548;3706.2031663192543;1171.9824202636967;1194.0686264713538;1205.5117677340515;1205.7287110400089;1207.643745095199;1291.464042422403;1298.3897568142959;1298.9740205196033;1314.1786383510307;1320.610419926124;6887.414569761627;6902.8619427612175;6973.5118541701595;6973.6164510952385;6977.546459480118;1088.983665245022;1098.3629494892944;1104.2601457023814;1113.3876367997568;1132.1395739238237;5597.160425936061;5685.715714214272;5696.857578560569;5698.572607054488;5707.514861236841;9067.863982040275;9212.355135140477;9354.438733676001;9427.434353938786;9450.480223587769;9248.30637702175;9332.626694932127;9336.439813611205;9343.532823358804;9356.204722598519;7156.248593897566;7176.856462870818;7244.058272424551;7246.49274550787;7305.634718264172;6966.721331146698;6967.581945083109;6990;7021.332973367522;7022.473314501331;8245.299149572353;8509.659613615386;8518.574071296534;8529.87205191935;8530.530820804915;7881.093674227537;8027.0367555891335;8050.436469447082;8054.073781515201;8201.589920503831;6457.160569125984;6578.046183303299;6606.8017959461295;6620.900686489803;6678.198616166092;6221.191245138103;6415.422611964946;6903.792886213421;6959.8956015660815;7060.505764596429;6579.572327798678;6619.172603424572;6673.299303573249;6701.564398314094;6736.6968486417245;6544;6601.471882249504;6633.668316584248;6695.665216739046;6713.832154196184;6661.067450556829;6661.700223490052;6665;6667.799966001027;6669.7665581704405;6073.240844894388;6105.969470152799;6115.4190351916495;6117.816465506042;6125.816225513242;6130.233720784902;6226.62640241587;6252.124702541739;6261.65560894137;6276 10:26:40 INFO - PROCESS | 5296 | |4;prototype.html;339.62980351416957;341.13692358333424;341.30714649262006;347.8452088820474;351.3938456163118;5860.853478663035;5927.762889484421;5932.881342373155;5953.821385358447;5987.371326010772;5882.764689412429;5886;5891.617044892079;5902.321233058199;5914.526837852972;4505.189065968125;4582.358469814237;4590.357349971006;4594.379758732578;4599.517050709677;4562.794674239667;4583.839565615204;4585.2663573828195;4594.609458196041;4598.287265473857;4531.886702832423;4533.5013148553635;4534.6825722199455;4537.455505339364;4553.453585569736;4325.48094228693;4453.554644535553;4483.753393563353;4544.590986811187;4554.772261386934;4003.5195776507007;4032.495938007749;4032.5967403259733;4034.737742046787;4038.1116154445976;5607;5615.691136987464;5624.184493248497;5624.3531993820825;5636.070048442002;5030.195168773015;5111.591072714174;5121.923171152435;5172.870678233036;5324.387695414999;6222.160008398899;6229.906551401733;6236.376362363772;6246.219222597176;6247.562670613059;4465.24090904547;4466.240739074333;4467.508574056851;4470.8435204767675;4477.3731677565165;6380.744770209232;6538.378854008862;6540.574862633914;6542.574732642363;6546.312637173076;4543.704659197141;4587.449506059294;4589.793459294273;4595.724256544618;4603.700759450625;4645.558671926162;4647.233206520887;4655.976720116378;4656.790444430008;4656.837010704609;5303.257543943851;5308.442613525602;5311.601629877775;5316.787328506816;5317.41508434072;6152.477039451696;6300.21247344082;6309.369063093745;6328.430441260309;6333.240011198685;1572.606848287928;1591.8646915012123;1595.5133684226191;1596.361455417842;1597.5686564627717;1062.7396287909512;1072.051234657334;1078.3853203673987;1089.242976131581;1093.327603523827;5941.821745347646;5962.165296858443;5963.522918166536;5965.433283838029;5967;6450.9354906450335;6450.967745161244;6463.06285588587;6467.062275969958;6473;5961.4038596140035;5966.045432730829;5970.492508136857;5973.1936188614845;6005.159277701126;3393.6606339365867;3474.4614584739406;3480.269143479847;3481.408160612702;3481.56480439945;6691.698873550702;6730.629815360105;6792.728290868409;6800.625965571842;6806.18325800907;6449.774257900951;6487.318831522716;6604.834879127964;6698;6703.93296067033;6761.763338283136;6790.8641827164165;6791.57376950836;6801.251862295144;6806.863862722717;6485.027245913151;6493.902591461037;6497.610143391412;6502.512311576556;6504.349565043647;6268.874622507433;6415.486761059197;6432.13166222554;6460.935390646221;6465.838354041187;6789.660516974231;6793.048973143863;6793.966030170015;6794.558353706993;6796.932030679828;4480.1039792042375;4497.437820272466;4527.4340707411575;4531.864044078683;4532.9347603312535;6385.393387628168;6539.346065393613;6541.6402097885075;6543.640099794557;6551.770688026087;6359.618422894641;6367;6419.807405777834;6432.581882177644;6435.4529864962005;6331.430171284606;6336.683165841781;6336.778212762531;6340.651264180515;6344.587601805868;6064.4541991221;6228.813135605939;6241.407066328691;6245.594036387621;6309.242890853127;6357.650329231937;6366.045093236052;6366.64983425916;6372.936270637234;6403.487720982217;6212.502999760099;6213;6222.377762223922;6227.283862355887;6228.844278893064 10:26:40 INFO - PROCESS | 5296 | |5;yui.html;830.6220669595334;837.1168417319733;838.9748307550772;846.5301757524576;849.6686292345986;13327.133736307145;13461.596152115428;13489.39297731602;13492.055556111063;13494.325283735798;12712.555060572882;12727.809082863765;12732.872671273284;12797;12803.231806091619;667.3393340592802;676.6312359763916;792.0258082558471;798.972035978738;805.9355251579859;806.2783808491397;807.5114555693809;809.4981111710719;810.4529442626233;810.5136917849272;830.4726498673356;834.6244190114443;835.1815221083342;835.3233880556738;835.3484282259817;829.0341751859077;831.7380025292044;832.0223737108903;832.4464231286217;833.2334252487726;615.5629503052838;615.9876802463925;616.0605077257219;617.0189398855796;617.8177437655858;13542.661433464144;13703;13724.65688357789;13726.382312795948;13730.313484325743;13285.202887826761;13318.733625327439;13423.731525369536;13603.183808971493;13701;10510.947445262802;10721.249512534127;10739.40933248671;10876.728081797939;10931.781364372668;3524.312759011994;3527.4532447470683;3528.2943411317583;3538.2039041215776;3611.4402267648557;43506;47370.76314618405;47643.285350719765;50831;51220.487795121946;10176.185905127571;10180.23648226386;10185.694429167137;10326.122279606167;10535.315204511682;17679.823201768075;17842.732359014626;17899.821001789816;17928.372506962194;17932.9103354485;6362.9045564316575;7560.58416787082;7626.618669066635;7738.845223095506;7808.453408261481;4079.5104587449696;4121.443605113272;4127.855525056609;4183.811728472226;4188.518320393194;2878.8848446062343;2886.6865576162795;2889;2893.103138027176;2899.739023487854;555.2615022020783;566.829951014694;572.5591294703055;582.4699523433655;589.6609449566516;504.1278588042633;506.3366989244102;513.1558586125876;557.7685260616798;653.8626888353499;7915.248051435105;8225.876611850827;8435.409521333571;8446.61990210442;8527.829443411098;617.8137975087842;621.6674079367607;654.2247436787422;673.397309408077;676.7698982346026;3833.555984364939;3991.0621004064024;4001.6998725095737;4043.7978101094827;4104.507459104927;52972.735136324074;55873.72063139658;57547.424525754206;57554;57609.42390576124;49155.754221228664;49575.752121239886;49688;49691;49731.50268497341;45387.54612453899;45835.31247031297;45946;46069.76965115153;47199.76400118046;7981.840363192588;8010.198980101944;8160.183981601793;8176.264136227768;8306.750797476085;31205.68794312028;31730.841345794048;35711.10722231965;35897.28205435929;36622.45066323954;46818.06363872635;47906;48272.75863620659;52802;52849.735751322536;10923.563057477611;10975.890241097486;11026.117910566974;11119.221654484109;11169.72075698114;11534.192606517463;11686.883131168579;11779;11864.050875929732;12255.448504817483;10318.587256509656;10385.055506843699;10826.188035897181;10893.945530272298;11139.554417823521;10244.282900197213;10428.113610343205;10436.112930401001;10587.682369528618;10636.84044739345;10413;10490.213234007633;10520.473976301308;10719.088877445505;11212.25400366519;9026.954865225633;9134.725958221265;9173.44959302444;9211.953940230256;9569.473678947725;8626.870596940926;8887.422317549339;8938.955305223431;9075.228605568336;9543.379680320757 10:26:40 INFO - PROCESS | 5296 | __end_tp_report 10:26:40 INFO - PROCESS | 5296 | __start_cc_report 10:26:40 INFO - PROCESS | 5296 | _x_x_mozilla_cycle_collect,852 10:26:40 INFO - PROCESS | 5296 | __end_cc_report 10:26:40 INFO - PROCESS | 5296 | __startTimestamp1453228000268__endTimestamp 10:26:40 INFO - PROCESS | 5296 | 10:26:40 INFO - PROCESS | 5296 | ------- Summary: start ------- 10:26:40 INFO - PROCESS | 5296 | Number of tests: 6 10:26:40 INFO - PROCESS | 5296 | 10:26:40 INFO - PROCESS | 5296 | [#0] dojo.html Cycles:165 Average:5136.40 Median:5326.25 stddev:657.35 (12.3%) stddev-sans-first:640.04 10:26:40 INFO - PROCESS | 5296 | Values: 3119.6 3126.2 3176.1 3177.6 3210.1 5013.1 5117.4 5134.8 5149.7 5203.8 5141.5 5147.4 5159.8 5163.9 5188.9 4740.3 4815.0 4819.7 4841.4 4844.9 4777.2 4795.7 4824.7 4825.5 4860.8 653.5 4667.8 4717.8 4725.6 4764.5 4674.1 4724.3 4738.9 4748.8 4758.8 4720.8 4742.2 4745.9 4748.1 4777.3 5032.8 5038.9 5039.5 5041.4 5074.3 5529.4 5543.4 5569.0 5569.2 5584.7 5471.3 5538.5 5573.6 5576.9 5635.4 5186.7 5186.9 5199.8 5201.0 5207.8 5522.4 5652.9 5664.3 5675.0 5685.6 5326.3 5476.9 5525.7 5527.1 5544.2 5552.7 5576.6 5581.4 5585.6 5588.6 5348.2 5469.5 5554.2 5563.2 5566.9 5548.2 5586.0 5587.8 5592.9 5627.4 4284.9 4305.6 4308.3 4314.5 4333.3 3814.3 3829.2 3871.9 3876.6 3894.0 5155.5 5180.4 5181.7 5183.2 5195.9 5527.0 5547.8 5549.5 5549.6 5595.9 5086.2 5150.6 5164.8 5168.6 5238.9 4766.9 4771.7 4787.2 4805.0 4820.5 5812.1 5829.1 5829.7 5831.9 5832.8 5400.4 5467.2 5533.9 5578.1 5657.2 5753.9 5758.3 5760.3 5769.7 5771.1 5373.7 5431.9 5472.9 5482.0 5484.8 5530.5 5595.9 5648.7 5654.3 5690.3 5410.5 5418.1 5421.2 5434.7 5435.8 5295.6 5370.0 5396.5 5402.2 5449.6 5257.1 5295.6 5302.9 5312.5 5339.5 5385.7 5396.0 5418.3 5418.7 5503.3 5290.0 5296.8 5322.4 5340.1 5369.8 10:26:40 INFO - PROCESS | 5296 | 10:26:40 INFO - PROCESS | 5296 | [#1] ext.html Cycles:180 Average:44900.57 Median:35003.27 stddev:75648.12 (216.1%) stddev-sans-first:75786.99 10:26:40 INFO - PROCESS | 5296 | Values: 535.0 537.4 558.5 559.3 574.0 28747.4 29240.6 29254.9 36093.1 36150.5 41260.8 42178.0 42195.8 42222.4 42361.2 8554.1 8711.9 8746.3 8765.7 8768.2 8429.2 8563.0 8565.3 8566.6 8567.3 8515.7 8580.4 8586.7 8596.2 8596.8 8508.3 8567.9 8572.3 8578.4 8578.5 8368.4 8577.2 8583.8 8600.4 8610.7 38509.2 38897.6 38921.0 39026.0 39074.8 3100.2 3145.6 3195.0 3548.6 4039.0 29152.9 29902.4 29947.2 30314.8 30767.5 3785.4 3920.7 3922.7 3969.5 3993.1 262055.0 262584.0 263294.0 263789.0 264924.7 50926.2 51859.5 55562.4 56025.7 56080.4 48982.3 61910.0 63037.7 63157.4 63169.4 12280.1 12461.9 12553.1 12562.7 12577.6 8380.1 8787.4 9371.1 9371.9 9406.7 19224.9 19287.4 19352.0 19419.5 19442.7 7046.7 7149.9 7189.0 7274.4 7339.1 943.9 971.8 1046.9 1054.2 1059.7 27937.0 28161.0 28244.0 28334.0 28560.3 1041.5 1055.7 1063.7 1068.1 1110.6 14811.4 14819.3 14850.8 14961.7 14975.8 309873.0 311956.0 312236.0 313582.0 313645.0 51776.7 51985.2 52016.2 52055.5 52109.0 1291.1 1293.5 1304.0 1309.8 1335.3 27457.5 28340.4 28391.0 28486.3 28658.7 46303.8 46480.3 46527.8 46566.3 46723.5 287481.0 289042.0 290418.0 290685.0 290795.0 28170.3 29575.4 31391.5 31692.0 31715.7 37051.6 37088.8 37527.0 38505.2 38535.6 30096.8 32408.2 34887.5 35793.0 35838.0 29849.0 32120.2 32342.0 32900.3 35119.1 32050.2 32682.2 32788.7 32925.8 33173.3 28872.1 29426.7 30601.2 31630.4 31877.2 23803.8 24194.6 24276.8 24433.4 24466.3 10:26:40 INFO - PROCESS | 5296 | 10:26:40 INFO - PROCESS | 5296 | [#2] jquery.html Cycles:180 Average:27668.44 Median:5403.58 stddev:89027.38 (1647.6%) stddev-sans-first:89253.50 10:26:40 INFO - PROCESS | 5296 | Values: 353.7 366.5 367.0 369.4 374.5 13867.5 13875.6 15636.4 16409.5 17296.3 15406.4 15939.4 16004.8 16046.7 17288.8 5392.9 5568.0 5568.8 5568.9 5573.1 4043.2 4179.2 5469.1 5536.9 5870.7 5790.1 5994.3 6038.4 6040.5 6047.7 5934.3 5958.3 5958.5 5968.5 5986.2 5112.8 5280.1 5414.3 5420.8 5428.9 19844.3 20174.6 20382.5 20566.8 20568.9 2017.3 2027.2 2068.3 2097.1 2260.6 8842.4 9481.2 9704.7 12070.9 12308.7 1697.7 1808.9 1845.7 1871.6 1872.0 51538.2 56327.7 57467.1 60386.4 60416.0 9570.7 9828.6 9957.5 10098.3 10189.4 13231.3 13310.4 13338.0 13342.3 13362.3 6775.3 6778.0 6834.9 6904.9 7008.7 6406.3 6454.6 6490.3 6534.4 6566.9 4281.0 4365.3 4376.3 4390.1 4399.9 1646.8 1684.2 1730.5 1746.6 1755.1 891.0 936.7 969.2 985.0 995.1 13907.3 15543.6 15994.3 16687.6 17673.6 911.8 918.1 927.4 944.4 968.7 9147.6 9550.2 9572.4 9600.9 9646.4 521769.0 523247.0 551450.0 560130.0 566334.0 71728.3 73069.3 73284.6 73704.6 75023.2 1132.5 1142.8 1142.9 1149.3 1156.5 14759.6 14912.8 15050.3 15182.7 15201.3 32502.7 32941.7 32985.8 34085.8 34184.0 42553.0 42601.4 43359.3 43467.8 43693.3 7165.2 7397.6 7437.9 7533.2 7622.2 7714.4 10296.5 10356.8 10944.2 11287.4 9027.4 9162.3 9383.0 9390.9 9633.5 9490.2 9577.3 9613.9 9918.5 9925.6 9118.9 9739.0 9800.0 9989.3 10227.8 7204.2 7280.9 7348.6 7438.0 7522.5 9497.9 10098.2 10156.4 10200.8 10349.5 10:26:40 INFO - PROCESS | 5296 | 10:26:40 INFO - PROCESS | 5296 | [#3] mootools.html Cycles:180 Average:5290.81 Median:6089.61 stddev:2691.91 (44.2%) stddev-sans-first:2683.27 10:26:40 INFO - PROCESS | 5296 | Values: 1363.5 1453.5 1466.2 1625.1 1806.5 6619.8 7303.7 7432.9 7440.6 7462.7 7167.1 7346.8 7358.1 7361.4 7371.8 1938.9 1991.2 1991.9 2265.1 2304.2 2022.0 2272.6 2330.2 2332.1 2332.9 2246.1 2270.3 2281.9 2285.5 2288.3 2253.2 2294.6 2300.4 2303.3 2308.0 2230.5 2231.0 2238.0 2242.9 2247.8 7576.8 7623.7 7627.9 7638.8 7639.0 4555.1 4618.2 4645.3 4646.2 4651.1 2978.5 3100.6 3180.3 3194.2 3205.2 1014.5 1020.7 1043.2 1054.2 1076.9 10101.4 10108.6 10113.1 10114.8 10123.3 4138.7 4183.4 4209.7 4221.7 4292.7 8773.4 8777.1 8793.4 8804.3 8804.7 4649.4 4660.1 4661.6 4662.9 4662.9 4212.3 4241.1 4246.2 4251.9 4252.9 3377.6 3434.0 3671.7 3688.1 3706.2 1172.0 1194.1 1205.5 1205.7 1207.6 1291.5 1298.4 1299.0 1314.2 1320.6 6887.4 6902.9 6973.5 6973.6 6977.5 1089.0 1098.4 1104.3 1113.4 1132.1 5597.2 5685.7 5696.9 5698.6 5707.5 9067.9 9212.4 9354.4 9427.4 9450.5 9248.3 9332.6 9336.4 9343.5 9356.2 7156.2 7176.9 7244.1 7246.5 7305.6 6966.7 6967.6 6990.0 7021.3 7022.5 8245.3 8509.7 8518.6 8529.9 8530.5 7881.1 8027.0 8050.4 8054.1 8201.6 6457.2 6578.0 6606.8 6620.9 6678.2 6221.2 6415.4 6903.8 6959.9 7060.5 6579.6 6619.2 6673.3 6701.6 6736.7 6544.0 6601.5 6633.7 6695.7 6713.8 6661.1 6661.7 6665.0 6667.8 6669.8 6073.2 6106.0 6115.4 6117.8 6125.8 6130.2 6226.6 6252.1 6261.7 6276.0 10:26:40 INFO - PROCESS | 5296 | 10:26:40 INFO - PROCESS | 5296 | [#4] prototype.html Cycles:180 Average:5281.75 Median:5961.78 stddev:1582.68 (26.5%) stddev-sans-first:1543.04 10:26:40 INFO - PROCESS | 5296 | Values: 339.6 341.1 341.3 347.8 351.4 5860.9 5927.8 5932.9 5953.8 5987.4 5882.8 5886.0 5891.6 5902.3 5914.5 4505.2 4582.4 4590.4 4594.4 4599.5 4562.8 4583.8 4585.3 4594.6 4598.3 4531.9 4533.5 4534.7 4537.5 4553.5 4325.5 4453.6 4483.8 4544.6 4554.8 4003.5 4032.5 4032.6 4034.7 4038.1 5607.0 5615.7 5624.2 5624.4 5636.1 5030.2 5111.6 5121.9 5172.9 5324.4 6222.2 6229.9 6236.4 6246.2 6247.6 4465.2 4466.2 4467.5 4470.8 4477.4 6380.7 6538.4 6540.6 6542.6 6546.3 4543.7 4587.4 4589.8 4595.7 4603.7 4645.6 4647.2 4656.0 4656.8 4656.8 5303.3 5308.4 5311.6 5316.8 5317.4 6152.5 6300.2 6309.4 6328.4 6333.2 1572.6 1591.9 1595.5 1596.4 1597.6 1062.7 1072.1 1078.4 1089.2 1093.3 5941.8 5962.2 5963.5 5965.4 5967.0 6450.9 6451.0 6463.1 6467.1 6473.0 5961.4 5966.0 5970.5 5973.2 6005.2 3393.7 3474.5 3480.3 3481.4 3481.6 6691.7 6730.6 6792.7 6800.6 6806.2 6449.8 6487.3 6604.8 6698.0 6703.9 6761.8 6790.9 6791.6 6801.3 6806.9 6485.0 6493.9 6497.6 6502.5 6504.3 6268.9 6415.5 6432.1 6460.9 6465.8 6789.7 6793.0 6794.0 6794.6 6796.9 4480.1 4497.4 4527.4 4531.9 4532.9 6385.4 6539.3 6541.6 6543.6 6551.8 6359.6 6367.0 6419.8 6432.6 6435.5 6331.4 6336.7 6336.8 6340.7 6344.6 6064.5 6228.8 6241.4 6245.6 6309.2 6357.7 6366.0 6366.6 6372.9 6403.5 6212.5 6213.0 6222.4 6227.3 6228.8 10:26:40 INFO - PROCESS | 5296 | 10:26:40 INFO - PROCESS | 5296 | [#5] yui.html Cycles:180 Average:13725.81 Median:47008.91 stddev:16049.47 (34.1%) stddev-sans-first:16065.28 10:26:40 INFO - PROCESS | 5296 | Values: 830.6 837.1 839.0 846.5 849.7 13327.1 13461.6 13489.4 13492.1 13494.3 12712.6 12727.8 12732.9 12797.0 12803.2 667.3 676.6 792.0 799.0 805.9 806.3 807.5 809.5 810.5 810.5 830.5 834.6 835.2 835.3 835.3 829.0 831.7 832.0 832.4 833.2 615.6 616.0 616.1 617.0 617.8 13542.7 13703.0 13724.7 13726.4 13730.3 13285.2 13318.7 13423.7 13603.2 13701.0 10510.9 10721.2 10739.4 10876.7 10931.8 3524.3 3527.5 3528.3 3538.2 3611.4 43506.0 47370.8 47643.3 50831.0 51220.5 10176.2 10180.2 10185.7 10326.1 10535.3 17679.8 17842.7 17899.8 17928.4 17932.9 6362.9 7560.6 7626.6 7738.8 7808.5 4079.5 4121.4 4127.9 4183.8 4188.5 2878.9 2886.7 2889.0 2893.1 2899.7 555.3 566.8 572.6 582.5 589.7 504.1 506.3 513.2 557.8 653.9 7915.2 8225.9 8435.4 8446.6 8527.8 617.8 621.7 654.2 673.4 676.8 3833.6 3991.1 4001.7 4043.8 4104.5 52972.7 55873.7 57547.4 57554.0 57609.4 49155.8 49575.8 49688.0 49691.0 49731.5 45387.5 45835.3 45946.0 46069.8 47199.8 7981.8 8010.2 8160.2 8176.3 8306.8 31205.7 31730.8 35711.1 35897.3 36622.5 46818.1 47906.0 48272.8 52802.0 52849.7 10923.6 10975.9 11026.1 11119.2 11169.7 11534.2 11686.9 11779.0 11864.1 12255.4 10318.6 10385.1 10826.2 10893.9 11139.6 10244.3 10428.1 10436.1 10587.7 10636.8 10413.0 10490.2 10520.5 10719.1 11212.3 9027.0 9134.7 9173.4 9212.0 9569.5 8626.9 8887.4 8939.0 9075.2 9543.4 10:26:40 INFO - PROCESS | 5296 | -------- Summary: end -------- 10:26:40 INFO - PROCESS | 5296 | 10:26:41 INFO - TEST-INFO | 5296: exit 0 10:26:41 INFO - TEST-OK | dromaeo_css | took 1112328ms 10:26:41 INFO - TEST-START | kraken 10:26:41 INFO - operating with platform_type : linux_ 10:26:41 INFO - Initialising browser for kraken test... 10:26:41 INFO - TEST-INFO | started process 5500 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpf5yyir/profile http://localhost:50943/getInfo.html) 10:26:45 INFO - PROCESS | 5500 | __metrics Screen width/height:1600/1200 10:26:45 INFO - PROCESS | 5500 | colorDepth:24 10:26:45 INFO - PROCESS | 5500 | Browser inner width/height: 1024/697 10:26:45 INFO - PROCESS | 5500 | __metrics 10:26:45 INFO - PROCESS | 5500 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:26:45 INFO - PROCESS | 5500 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:26:46 INFO - TEST-INFO | 5500: exit 0 10:26:46 INFO - Browser initialized. 10:26:46 INFO - Running cycle 1/1 for kraken test... 10:26:46 INFO - TEST-INFO | started process 5584 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpf5yyir/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:58 INFO - PROCESS | 5584 | RSS: Main: 149303296 10:26:58 INFO - PROCESS | 5584 | 10:27:00 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50943/tests/kraken/driver.html?testName=audio-beat-detection) 10:27:01 INFO - PROCESS | 5584 | RSS: Main: 186232832 10:27:01 INFO - PROCESS | 5584 | 10:27:04 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50943/tests/kraken/driver.html?testName=audio-dft) 10:27:04 INFO - PROCESS | 5584 | RSS: Main: 177582080 10:27:04 INFO - PROCESS | 5584 | 10:27:07 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50943/tests/kraken/driver.html?testName=audio-fft) 10:27:08 INFO - PROCESS | 5584 | RSS: Main: 161345536 10:27:08 INFO - PROCESS | 5584 | 10:27:10 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50943/tests/kraken/driver.html?testName=audio-oscillator) 10:27:10 INFO - PROCESS | 5584 | RSS: Main: 162553856 10:27:10 INFO - PROCESS | 5584 | 10:27:12 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50943/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:27:13 INFO - PROCESS | 5584 | RSS: Main: 164786176 10:27:13 INFO - PROCESS | 5584 | 10:27:16 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50943/tests/kraken/driver.html?testName=imaging-darkroom) 10:27:16 INFO - PROCESS | 5584 | RSS: Main: 165617664 10:27:16 INFO - PROCESS | 5584 | 10:27:20 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50943/tests/kraken/driver.html?testName=imaging-desaturate) 10:27:20 INFO - PROCESS | 5584 | RSS: Main: 167034880 10:27:20 INFO - PROCESS | 5584 | 10:27:23 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50943/tests/kraken/driver.html?testName=json-parse-financial) 10:27:24 INFO - PROCESS | 5584 | RSS: Main: 166449152 10:27:24 INFO - PROCESS | 5584 | 10:27:25 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50943/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:27:26 INFO - PROCESS | 5584 | RSS: Main: 181280768 10:27:26 INFO - PROCESS | 5584 | 10:27:28 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:27:28 INFO - PROCESS | 5584 | RSS: Main: 175898624 10:27:28 INFO - PROCESS | 5584 | 10:27:30 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:27:31 INFO - PROCESS | 5584 | RSS: Main: 187060224 10:27:31 INFO - PROCESS | 5584 | 10:27:33 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:27:34 INFO - PROCESS | 5584 | RSS: Main: 193454080 10:27:34 INFO - PROCESS | 5584 | 10:27:36 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:27:37 INFO - PROCESS | 5584 | RSS: Main: 190693376 10:27:37 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50943/tests/kraken/driver.html?testName=ai-astar) 10:27:39 INFO - PROCESS | 5584 | RSS: Main: 247955456 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | __start_tp_report 10:27:39 INFO - PROCESS | 5584 | _x_x_mozilla_page_load 10:27:39 INFO - PROCESS | 5584 | _x_x_mozilla_page_load_details 10:27:39 INFO - PROCESS | 5584 | |i|pagename|runs| 10:27:39 INFO - PROCESS | 5584 | |0;ai-astar;112;111;108;111;111;111;112;112;107;111 10:27:39 INFO - PROCESS | 5584 | |1;audio-beat-detection;155;138;161;162;129;154;160;128;167;129 10:27:39 INFO - PROCESS | 5584 | |2;audio-dft;165;164;163;162;162;164;162;162;164;163 10:27:39 INFO - PROCESS | 5584 | |3;audio-fft;75;74;95;100;76;76;74;114;95;74 10:27:39 INFO - PROCESS | 5584 | |4;audio-oscillator;98;96;142;96;97;96;136;97;97;151 10:27:39 INFO - PROCESS | 5584 | |5;imaging-gaussian-blur;110;110;109;110;110;109;110;109;110;110 10:27:39 INFO - PROCESS | 5584 | |6;imaging-darkroom;147;145;145;146;146;146;146;146;146;146 10:27:39 INFO - PROCESS | 5584 | |7;imaging-desaturate;96;96;96;96;97;96;96;97;96;97 10:27:39 INFO - PROCESS | 5584 | |8;json-parse-financial;63;57;59;56;58;57;57;58;58;55 10:27:39 INFO - PROCESS | 5584 | |9;json-stringify-tinderbox;68;69;68;70;68;70;68;67;70;69 10:27:39 INFO - PROCESS | 5584 | |10;stanford-crypto-aes;81;82;83;84;84;84;83;84;84;83 10:27:39 INFO - PROCESS | 5584 | |11;stanford-crypto-ccm;114;125;119;115;123;132;115;111;113;123 10:27:39 INFO - PROCESS | 5584 | |12;stanford-crypto-pbkdf2;145;142;143;146;136;143;142;140;143;143 10:27:39 INFO - PROCESS | 5584 | |13;stanford-crypto-sha256-iterative;66;72;69;67;66;69;68;68;68;65 10:27:39 INFO - PROCESS | 5584 | __end_tp_report 10:27:39 INFO - PROCESS | 5584 | __start_cc_report 10:27:39 INFO - PROCESS | 5584 | _x_x_mozilla_cycle_collect,961 10:27:39 INFO - PROCESS | 5584 | __end_cc_report 10:27:39 INFO - PROCESS | 5584 | __startTimestamp1453228059376__endTimestamp 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | ------- Summary: start ------- 10:27:39 INFO - PROCESS | 5584 | Number of tests: 14 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.71 (1.5%) stddev-sans-first:1.74 10:27:39 INFO - PROCESS | 5584 | Values: 112.0 111.0 108.0 111.0 111.0 111.0 112.0 112.0 107.0 111.0 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:157.50 stddev:15.55 (9.9%) stddev-sans-first:16.30 10:27:39 INFO - PROCESS | 5584 | Values: 155.0 138.0 161.0 162.0 129.0 154.0 160.0 128.0 167.0 129.0 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:1.10 (0.7%) stddev-sans-first:0.93 10:27:39 INFO - PROCESS | 5584 | Values: 165.0 164.0 163.0 162.0 162.0 164.0 162.0 162.0 164.0 163.0 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#3] audio-fft Cycles:10 Average:85.30 Median:75.50 stddev:14.49 (19.2%) stddev-sans-first:14.88 10:27:39 INFO - PROCESS | 5584 | Values: 75.0 74.0 95.0 100.0 76.0 76.0 74.0 114.0 95.0 74.0 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:96.50 stddev:22.65 (23.5%) stddev-sans-first:23.56 10:27:39 INFO - PROCESS | 5584 | Values: 98.0 96.0 142.0 96.0 97.0 96.0 136.0 97.0 97.0 151.0 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:27:39 INFO - PROCESS | 5584 | Values: 110.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 110.0 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 10:27:39 INFO - PROCESS | 5584 | Values: 147.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:27:39 INFO - PROCESS | 5584 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 97.0 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:2.15 (3.7%) stddev-sans-first:1.20 10:27:39 INFO - PROCESS | 5584 | Values: 63.0 57.0 59.0 56.0 58.0 57.0 57.0 58.0 58.0 55.0 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:1.06 (1.5%) stddev-sans-first:1.09 10:27:39 INFO - PROCESS | 5584 | Values: 68.0 69.0 68.0 70.0 68.0 70.0 68.0 67.0 70.0 69.0 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:84.00 stddev:1.03 (1.2%) stddev-sans-first:0.73 10:27:39 INFO - PROCESS | 5584 | Values: 81.0 82.0 83.0 84.0 84.0 84.0 83.0 84.0 84.0 83.0 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:121.00 stddev:6.62 (5.5%) stddev-sans-first:6.77 10:27:39 INFO - PROCESS | 5584 | Values: 114.0 125.0 119.0 115.0 123.0 132.0 115.0 111.0 113.0 123.0 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:143.00 stddev:2.75 (1.9%) stddev-sans-first:2.74 10:27:39 INFO - PROCESS | 5584 | Values: 145.0 142.0 143.0 146.0 136.0 143.0 142.0 140.0 143.0 143.0 10:27:39 INFO - PROCESS | 5584 | 10:27:39 INFO - PROCESS | 5584 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.99 (2.9%) stddev-sans-first:2.00 10:27:39 INFO - PROCESS | 5584 | Values: 66.0 72.0 69.0 67.0 66.0 69.0 68.0 68.0 68.0 65.0 10:27:39 INFO - PROCESS | 5584 | -------- Summary: end -------- 10:27:39 INFO - PROCESS | 5584 | 10:27:40 INFO - TEST-INFO | 5584: exit 0 10:27:40 INFO - TEST-OK | kraken | took 59243ms 10:27:40 INFO - TEST-START | v8_7 10:27:40 INFO - operating with platform_type : linux_ 10:27:40 INFO - Initialising browser for v8_7 test... 10:27:40 INFO - TEST-INFO | started process 5832 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIL70T6/profile http://localhost:50943/getInfo.html) 10:27:44 INFO - PROCESS | 5832 | __metrics Screen width/height:1600/1200 10:27:44 INFO - PROCESS | 5832 | colorDepth:24 10:27:44 INFO - PROCESS | 5832 | Browser inner width/height: 1024/697 10:27:44 INFO - PROCESS | 5832 | __metrics 10:27:44 INFO - PROCESS | 5832 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:27:44 INFO - PROCESS | 5832 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:27:45 INFO - TEST-INFO | 5832: exit 0 10:27:45 INFO - Browser initialized. 10:27:45 INFO - Running cycle 1/1 for v8_7 test... 10:27:45 INFO - TEST-INFO | started process 5914 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIL70T6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:57 INFO - PROCESS | 5914 | RSS: Main: 149254144 10:27:57 INFO - PROCESS | 5914 | 10:28:19 INFO - PROCESS | 5914 | Cycle 1(1): loaded http://localhost:50943/tests/v8_7/run.html (next: http://localhost:50943/tests/v8_7/run.html) 10:28:20 INFO - PROCESS | 5914 | RSS: Main: 476237824 10:28:20 INFO - PROCESS | 5914 | 10:28:20 INFO - PROCESS | 5914 | __start_tp_report 10:28:20 INFO - PROCESS | 5914 | _x_x_mozilla_page_load 10:28:20 INFO - PROCESS | 5914 | _x_x_mozilla_page_load_details 10:28:20 INFO - PROCESS | 5914 | |i|pagename|runs| 10:28:20 INFO - PROCESS | 5914 | |0;Richards;167.81339150864238 10:28:20 INFO - PROCESS | 5914 | |1;DeltaBlue;188.5369532428356 10:28:20 INFO - PROCESS | 5914 | |2;Encrypt;281.928390188892 10:28:20 INFO - PROCESS | 5914 | |3;Decrypt;5256.544502617801 10:28:20 INFO - PROCESS | 5914 | |4;RayTrace;1117.31843575419 10:28:20 INFO - PROCESS | 5914 | |5;Earley;788.0220646178093 10:28:20 INFO - PROCESS | 5914 | |6;Boyer;12493.827160493827 10:28:20 INFO - PROCESS | 5914 | |7;RegExp;41734.69387755102 10:28:20 INFO - PROCESS | 5914 | |8;Splay;619.1950464396285 10:28:20 INFO - PROCESS | 5914 | |9;NavierStokes;4830.917874396136 10:28:20 INFO - PROCESS | 5914 | __end_tp_report 10:28:20 INFO - PROCESS | 5914 | __startTimestamp1453228100229__endTimestamp 10:28:20 INFO - PROCESS | 5914 | 10:28:20 INFO - PROCESS | 5914 | ------- Summary: start ------- 10:28:20 INFO - PROCESS | 5914 | Number of tests: 10 10:28:20 INFO - PROCESS | 5914 | 10:28:20 INFO - PROCESS | 5914 | [#0] Richards Cycles:1 Average:167.81 Median:167.81 stddev:0.00 (0.0%) 10:28:20 INFO - PROCESS | 5914 | Values: 167.8 10:28:20 INFO - PROCESS | 5914 | 10:28:20 INFO - PROCESS | 5914 | [#1] DeltaBlue Cycles:1 Average:188.54 Median:188.54 stddev:0.00 (0.0%) 10:28:20 INFO - PROCESS | 5914 | Values: 188.5 10:28:20 INFO - PROCESS | 5914 | 10:28:20 INFO - PROCESS | 5914 | [#2] Encrypt Cycles:1 Average:281.93 Median:281.93 stddev:0.00 (0.0%) 10:28:20 INFO - PROCESS | 5914 | Values: 281.9 10:28:20 INFO - PROCESS | 5914 | 10:28:20 INFO - PROCESS | 5914 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 10:28:20 INFO - PROCESS | 5914 | Values: 5256.5 10:28:20 INFO - PROCESS | 5914 | 10:28:20 INFO - PROCESS | 5914 | [#4] RayTrace Cycles:1 Average:1117.32 Median:1117.32 stddev:0.00 (0.0%) 10:28:20 INFO - PROCESS | 5914 | Values: 1117.3 10:28:20 INFO - PROCESS | 5914 | 10:28:20 INFO - PROCESS | 5914 | [#5] Earley Cycles:1 Average:788.02 Median:788.02 stddev:0.00 (0.0%) 10:28:20 INFO - PROCESS | 5914 | Values: 788.0 10:28:20 INFO - PROCESS | 5914 | 10:28:20 INFO - PROCESS | 5914 | [#6] Boyer Cycles:1 Average:12493.83 Median:12493.83 stddev:0.00 (0.0%) 10:28:20 INFO - PROCESS | 5914 | Values: 12493.8 10:28:20 INFO - PROCESS | 5914 | 10:28:20 INFO - PROCESS | 5914 | [#7] RegExp Cycles:1 Average:41734.69 Median:41734.69 stddev:0.00 (0.0%) 10:28:20 INFO - PROCESS | 5914 | Values: 41734.7 10:28:20 INFO - PROCESS | 5914 | 10:28:20 INFO - PROCESS | 5914 | [#8] Splay Cycles:1 Average:619.20 Median:619.20 stddev:0.00 (0.0%) 10:28:20 INFO - PROCESS | 5914 | Values: 619.2 10:28:20 INFO - PROCESS | 5914 | 10:28:20 INFO - PROCESS | 5914 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:28:20 INFO - PROCESS | 5914 | Values: 4830.9 10:28:20 INFO - PROCESS | 5914 | -------- Summary: end -------- 10:28:20 INFO - PROCESS | 5914 | 10:28:21 INFO - TEST-INFO | 5914: exit 0 10:28:21 INFO - TEST-OK | v8_7 | took 40883ms 10:28:21 INFO - SUITE-END | took 1212s 10:28:21 INFO - Completed test suite (00:20:12) 10:28:21 INFO - Working with test: dromaeo_css 10:28:21 INFO - Generating results file: dromaeo_css 10:28:21 INFO - Working with test: kraken 10:28:21 INFO - Generating results file: kraken 10:28:21 INFO - javascript benchmark 10:28:21 INFO - Working with test: v8_7 10:28:21 INFO - Generating results file: v8_7 10:28:21 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:28:21 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 10:28:21 INFO - process_Request line: dromaeo_css 6760.32 graph.html#tests=[[72,63,35]] 10:28:21 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:28:21 INFO - process_Request line: kraken 1508.60 graph.html#tests=[[232,63,35]] 10:28:21 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:28:21 INFO - process_Request line: v8_7 19917.57 graph.html#tests=[[230,63,35]] 10:28:21 INFO - RETURN: dromaeo_css: 6760.32 10:28:21 INFO - RETURN: kraken: 1508.60 10:28:21 INFO - RETURN: v8_7: 19917.57 10:28:21 INFO - javascript benchmark 10:28:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3119.5632611434417, 3126.171564535398, 3176.142441540783, 3177.6345720242166, 3210.0690799668096, 5013.14776487997, 5117.360329958755, 5134.768935397911, 5149.716765577892, 5203.791848326067, 5141.485851414856, 5147.38231412231, 5159.767810448529, 5163.922541161876, 5188.896222075557, 4740.26525888487, 4815.036992601494, 4819.662623616348, 4841.370621819176, 4844.854654360375, 4777.163996300634, 4795.736234507101, 4824.662273640846, 4825.493323201066, 4860.781264843073, 653.4878185620292, 4667.836625718118, 4717.811287548494, 4725.574698277137, 4764.452088009889, 4674.11191873543, 4724.267738500538, 4738.881527961794, 4748.833790817339, 4758.809647614091, 4720.834770783041, 4742.241241401393, 4745.881352966169, 4748.050389922029, 4777.331173635694, 5032.798688052473, 5038.874028149326, 5039.496050394968, 5041.445441001487, 5074.264231686385, 5529.391766905637, 5543.36251331094, 5568.972155139239, 5569.220309156722, 5584.664920104766, 5471.316085489314, 5538.47384498472, 5573.554115670737, 5576.888462230773, 5635.408282130358, 5186.688798672017, 5186.948130518685, 5199.766010529535, 5201.011807756514, 5207.791688332462, 5522.447755224445, 5652.9152062719095, 5664.348599911063, 5674.97162514193, 5685.602007859493, 5326.2543243945875, 5476.890462190813, 5525.723713814293, 5527.115661494142, 5544.22380866679, 5552.7223638817895, 5576.553875689935, 5581.413951535112, 5585.609007369445, 5588.636738611977, 5348.171033489815, 5469.507744303032, 5554.166874968787, 5563.248961390242, 5566.888662226733, 5548.167774833807, 5585.972070139624, 5587.804426845122, 5592.860178495489, 5627.437256274422, 4284.871453856389, 4305.612494875476, 4308.310670292738, 4314.525402205755, 4333.306670932636, 3814.275287695329, 3829.1767270037076, 3871.922561548753, 3876.6123387661573, 3893.980530097331, 5155.458676838878, 5180.378354597397, 5181.715005674649, 5183.222516622537, 5195.948040519622, 5527.032769265363, 5547.77808887648, 5549.500544950974, 5549.639273447294, 5595.8601034973635, 5086.160783470686, 5150.6137039721425, 5164.845054648366, 5168.586513078944, 5238.869028274324, 4766.928496072562, 4771.73755443447, 4787.234042553175, 4804.95195048052, 4820.517948205222, 5812.128180772918, 5829.067349224104, 5829.650220986669, 5831.854203644943, 5832.766689332379, 5400.351957765093, 5467.207254947931, 5533.889322213614, 5578.079616863172, 5657.179708942098, 5753.913691294718, 5758.3090029196765, 5760.308762948473, 5769.68266745333, 5771.105478650816, 5373.704446255493, 5431.918521222264, 5472.890542189054, 5482.0406428875585, 5484.780608775604, 5530.474604912527, 5595.944040559542, 5648.661080335193, 5654.321481422256, 5690.2887139107615, 5410.48600382963, 5418.133098704346, 5421.186821976577, 5434.728263586726, 5435.755391007335, 5295.602829787705, 5369.973150134224, 5396.541293990055, 5402.189671549299, 5449.6185267032515, 5257.106291930458, 5295.629305948547, 5302.920456193237, 5312.5218730314455, 5339.546138578109, 5385.676859388449, 5395.973020134874, 5418.349798024262, 5418.674879507243, 5503.284573005483, 5289.973550132225, 5296.841094767163, 5322.387925388475, 5340.092184328596, 5369.785208591613], "unit": "score", "name": "dojo.html", "value": 5096.856045552309}, {"lowerIsBetter": false, "replicates": [534.9545288650464, 537.4169026606135, 558.5168828962949, 559.3204256827954, 573.9540836733062, 28747.425051498958, 29240.56139157912, 29254.85372573137, 36093.097672558135, 36150.45774313381, 41260.79369603156, 42178.0, 42195.78902105485, 42222.366664500056, 42361.152776944444, 8554.05905350411, 8711.869321960176, 8746.256568191711, 8765.693200737944, 8768.167024132728, 8429.199226073513, 8563.0, 8565.271951884097, 8566.61450234741, 8567.314614830799, 8515.701950431736, 8580.356473264499, 8586.656533738675, 8596.226339629433, 8596.828063438728, 8508.276796472277, 8567.871481927776, 8572.271356934636, 8578.39951203416, 8578.485290882567, 8368.37237207212, 8577.228049475578, 8583.785405364853, 8600.440971336842, 8610.741677749678, 38509.22981540354, 38897.61102388968, 38921.0, 39026.0, 39074.80462597697, 3100.2404410919244, 3145.6382516010494, 3195.0, 3548.627394123606, 4039.0306326481727, 29152.854235728897, 29902.401951960837, 29947.15502027304, 30314.84842575795, 30767.538486922713, 3785.3754130568423, 3920.7468279272007, 3922.7057970652313, 3969.503812023497, 3993.101552150772, 262055.0, 262584.0, 263294.0, 263789.0, 264924.6753766238, 50926.23610645843, 51859.48140518546, 55562.44437555573, 56025.7198714012, 56080.439195608335, 48982.26526602104, 61910.0, 63037.68481157565, 63157.36842631607, 63169.36830631635, 12280.140390172603, 12461.93769031149, 12553.121281510206, 12562.685932851751, 12577.559785407468, 8380.120087390858, 8787.428817126995, 9371.109744574254, 9371.906280937239, 9406.670766523139, 19224.903875480533, 19287.421377358703, 19352.0, 19419.51451213731, 19442.70835937462, 7046.6828992695455, 7149.891766776158, 7189.0, 7274.418046556369, 7339.082614673166, 943.8914524829595, 971.825071487125, 1046.8586740789897, 1054.1724746074294, 1059.7456610413444, 27937.0, 28161.0, 28244.0, 28334.0, 28560.28599284993, 1041.4792603698152, 1055.72551136705, 1063.6808957312776, 1068.0654427376046, 1110.6168371911679, 14811.407543698131, 14819.259037048105, 14850.777238341434, 14961.700765984837, 14975.775363369557, 309873.0, 311956.0, 312236.0, 313582.0, 313645.0, 51776.74111629418, 51985.220221696705, 52016.21975670368, 52055.47944520582, 52109.0, 1291.0897817038965, 1293.4761421624257, 1304.0219835123658, 1309.7838856588746, 1335.2789493673308, 27457.45085098247, 28340.43319133647, 28391.0, 28486.287842804097, 28658.713412865603, 46303.76848115738, 46480.30279545742, 46527.76736116298, 46566.30150547812, 46723.53276467328, 287481.0, 289042.0, 290418.0, 290685.0, 290795.0, 28170.2957426066, 29575.408491830472, 31391.529127063568, 31692.0, 31715.682843171275, 37051.62948370482, 37088.81455592705, 37527.0, 38505.229895401375, 38535.6146438532, 30096.849515753158, 32408.189795255308, 34887.476687849194, 35793.0, 35838.0, 29849.0, 32120.196995075312, 32342.0, 32900.34199316048, 35119.06845123543, 32050.19874503156, 32682.182945425604, 32788.672113279514, 32925.83537082299, 33173.33653326872, 28872.133835984954, 29426.705732942395, 30601.23496912595, 31630.36739265156, 31877.20306992344, 23803.761962380155, 24194.63708044416, 24276.793048503572, 24433.3891652703, 24466.266012018958], "unit": "score", "name": "ext.html", "value": 17685.852538105213}, {"lowerIsBetter": false, "replicates": [353.73116431512057, 366.50887810334154, 366.95596528416587, 369.38313017261186, 374.5374462538762, 13867.514636987707, 13875.583732488041, 15636.35818239084, 16409.507714768562, 17296.30814767411, 15406.3837446502, 15939.362425502995, 16004.75992860108, 16046.679066418665, 17288.82711172891, 5392.892142157164, 5567.972160139194, 5568.805091821787, 5568.9443105568835, 5573.052581061229, 4043.1509383029597, 4179.185058913513, 5469.07025805612, 5536.889262214753, 5870.73581688825, 5790.10253410722, 5994.310654274749, 6038.396160383948, 6040.456358927696, 6047.7278522466595, 5934.28788545373, 5958.344582095966, 5958.493528050121, 5968.492678122343, 5986.221791167142, 5112.846614601568, 5280.075986702312, 5414.269073675043, 5420.810271640474, 5428.9185662215095, 19844.305449309348, 20174.596508069757, 20382.490437739027, 20566.794332056637, 20568.897155514125, 2017.2536161620294, 2027.1891243502569, 2068.348470231872, 2097.0869933982385, 2260.5930932432157, 8842.381033327669, 9481.194098501635, 9704.70885873425, 12070.939645301805, 12308.692282693004, 1697.7283634618525, 1808.9276428942826, 1845.7046872500337, 1871.6471289489398, 1871.9532011699816, 51538.22692659651, 56327.71836140834, 57467.13799293014, 60386.39613603896, 60416.0, 9570.712878613513, 9828.606855725691, 9957.477852006947, 10098.343607665625, 10189.439580823126, 13231.3384330785, 13310.401031953585, 13338.0, 13342.332883355793, 13362.33188340579, 6775.3224677532835, 6777.966110169417, 6834.8633027340165, 6904.896426553606, 7008.684609192598, 6406.2953075161695, 6454.580452270681, 6490.286068532458, 6534.411902928759, 6566.9343306566325, 4281.0, 4365.279728844768, 4376.299792033259, 4390.05613793036, 4399.934000989988, 1646.7612196231719, 1684.1831711619855, 1730.498155534906, 1746.56335916021, 1755.0698129991124, 890.9688160914467, 936.6862101196176, 969.1665167955553, 985.0, 995.1292618958412, 13907.304634768221, 15543.611409714847, 15994.280257388446, 16687.615969354192, 17673.646527069643, 911.8313112074287, 918.1461241045891, 927.355487935878, 944.3719926248967, 968.6851773173747, 9147.63409463614, 9550.188234000048, 9572.425654460616, 9600.903990960001, 9646.372985755903, 521769.0, 523247.0, 551450.0, 560130.0, 566334.0, 71728.2827171732, 73069.26930730732, 73284.63357683284, 73704.63147684227, 75023.24976750271, 1132.4960392625203, 1142.765733024728, 1142.9371384573928, 1149.2816989381636, 1156.502703837358, 14759.631009224855, 14912.7763083556, 15050.322735476711, 15182.696346073237, 15201.315940782912, 32502.674973250912, 32941.67058329482, 32985.83507082449, 34085.82957085199, 34184.0, 42553.0, 42601.36097958595, 43359.34960975651, 43467.782661086494, 43693.344599830394, 7165.211826699163, 7397.556146631219, 7437.925620743939, 7533.209013053551, 7622.161562228262, 7714.382849371925, 10296.485175741333, 10356.844647330447, 10944.23390362667, 11287.43562821872, 9027.36808423404, 9162.26701863836, 9383.0, 9390.859137113086, 9633.470159141314, 9490.240780737662, 9577.329586928849, 9613.90386096158, 9918.504074796376, 9925.602975881173, 9118.863217051883, 9738.951305243429, 9800.019998000143, 9989.300748947504, 10227.84658230142, 7204.243554426919, 7280.890786638099, 7348.56702942921, 7437.962810185914, 7522.511036782592, 9497.905020949978, 10098.19214462856, 10156.39061656303, 10200.846987295345, 10349.482525873827], "unit": "score", "name": "jquery.html", "value": 8156.041890154297}, {"lowerIsBetter": false, "replicates": [1363.5363976248086, 1453.4622189789777, 1466.1862666220247, 1625.1305551529927, 1806.5303021214488, 6619.801405957823, 7303.744368947081, 7432.851342973137, 7440.627968601575, 7462.738804141856, 7167.139943206823, 7346.816329591763, 7358.080239970004, 7361.4110871130315, 7371.778846634609, 1938.8642795004355, 1991.1736629298896, 1991.920323187078, 2265.139247086109, 2304.193532263711, 2022.0294258755805, 2272.6136556785386, 2330.2310237621627, 2332.11379675723, 2332.895019724108, 2246.067881829039, 2270.2735124760084, 2281.8973146208377, 2285.462916214688, 2288.336382449088, 2253.188852013274, 2294.6443301288327, 2300.413394584387, 2303.2514432809403, 2308.0306271366067, 2230.531588366445, 2231.029502166563, 2237.966430503544, 2242.9102835886547, 2247.752747197807, 7576.772696819049, 7623.733169339046, 7627.923720762832, 7638.770836874847, 7638.961805190994, 4555.111753208126, 4618.237990731525, 4645.256758918591, 4646.163690535702, 4651.139539185261, 2978.538326559387, 3100.5989681143437, 3180.3003339265324, 3194.185482701919, 3205.246767009751, 1014.5485259059722, 1020.7193021918957, 1043.207162556455, 1054.1672079057535, 1076.9030787229187, 10101.393916365041, 10108.64619738313, 10113.089821916063, 10114.848277275847, 10123.29136960413, 4138.710290279651, 4183.372494125844, 4209.705320627588, 4221.733479956062, 4292.678049146264, 8773.42972706772, 8777.122287771172, 8793.428427152214, 8804.295656347476, 8804.691835785718, 4649.442066951988, 4660.13787449323, 4661.557152070548, 4662.860114196579, 4662.930056049162, 4212.304969679968, 4241.109367032957, 4246.171996460661, 4251.87244382669, 4252.914941701149, 3377.611574668895, 3434.0, 3671.687906527975, 3688.0595448160548, 3706.2031663192543, 1171.9824202636967, 1194.0686264713538, 1205.5117677340515, 1205.7287110400089, 1207.643745095199, 1291.464042422403, 1298.3897568142959, 1298.9740205196033, 1314.1786383510307, 1320.610419926124, 6887.414569761627, 6902.8619427612175, 6973.5118541701595, 6973.6164510952385, 6977.546459480118, 1088.983665245022, 1098.3629494892944, 1104.2601457023814, 1113.3876367997568, 1132.1395739238237, 5597.160425936061, 5685.715714214272, 5696.857578560569, 5698.572607054488, 5707.514861236841, 9067.863982040275, 9212.355135140477, 9354.438733676001, 9427.434353938786, 9450.480223587769, 9248.30637702175, 9332.626694932127, 9336.439813611205, 9343.532823358804, 9356.204722598519, 7156.248593897566, 7176.856462870818, 7244.058272424551, 7246.49274550787, 7305.634718264172, 6966.721331146698, 6967.581945083109, 6990.0, 7021.332973367522, 7022.473314501331, 8245.299149572353, 8509.659613615386, 8518.574071296534, 8529.87205191935, 8530.530820804915, 7881.093674227537, 8027.0367555891335, 8050.436469447082, 8054.073781515201, 8201.589920503831, 6457.160569125984, 6578.046183303299, 6606.8017959461295, 6620.900686489803, 6678.198616166092, 6221.191245138103, 6415.422611964946, 6903.792886213421, 6959.8956015660815, 7060.505764596429, 6579.572327798678, 6619.172603424572, 6673.299303573249, 6701.564398314094, 6736.6968486417245, 6544.0, 6601.471882249504, 6633.668316584248, 6695.665216739046, 6713.832154196184, 6661.067450556829, 6661.700223490052, 6665.0, 6667.799966001027, 6669.7665581704405, 6073.240844894388, 6105.969470152799, 6115.4190351916495, 6117.816465506042, 6125.816225513242, 6130.233720784902, 6226.62640241587, 6252.124702541739, 6261.65560894137, 6276.0], "unit": "score", "name": "mootools.html", "value": 4394.179272915576}, {"lowerIsBetter": false, "replicates": [339.62980351416957, 341.13692358333424, 341.30714649262006, 347.8452088820474, 351.3938456163118, 5860.853478663035, 5927.762889484421, 5932.881342373155, 5953.821385358447, 5987.371326010772, 5882.764689412429, 5886.0, 5891.617044892079, 5902.321233058199, 5914.526837852972, 4505.189065968125, 4582.358469814237, 4590.357349971006, 4594.379758732578, 4599.517050709677, 4562.794674239667, 4583.839565615204, 4585.2663573828195, 4594.609458196041, 4598.287265473857, 4531.886702832423, 4533.5013148553635, 4534.6825722199455, 4537.455505339364, 4553.453585569736, 4325.48094228693, 4453.554644535553, 4483.753393563353, 4544.590986811187, 4554.772261386934, 4003.5195776507007, 4032.495938007749, 4032.5967403259733, 4034.737742046787, 4038.1116154445976, 5607.0, 5615.691136987464, 5624.184493248497, 5624.3531993820825, 5636.070048442002, 5030.195168773015, 5111.591072714174, 5121.923171152435, 5172.870678233036, 5324.387695414999, 6222.160008398899, 6229.906551401733, 6236.376362363772, 6246.219222597176, 6247.562670613059, 4465.24090904547, 4466.240739074333, 4467.508574056851, 4470.8435204767675, 4477.3731677565165, 6380.744770209232, 6538.378854008862, 6540.574862633914, 6542.574732642363, 6546.312637173076, 4543.704659197141, 4587.449506059294, 4589.793459294273, 4595.724256544618, 4603.700759450625, 4645.558671926162, 4647.233206520887, 4655.976720116378, 4656.790444430008, 4656.837010704609, 5303.257543943851, 5308.442613525602, 5311.601629877775, 5316.787328506816, 5317.41508434072, 6152.477039451696, 6300.21247344082, 6309.369063093745, 6328.430441260309, 6333.240011198685, 1572.606848287928, 1591.8646915012123, 1595.5133684226191, 1596.361455417842, 1597.5686564627717, 1062.7396287909512, 1072.051234657334, 1078.3853203673987, 1089.242976131581, 1093.327603523827, 5941.821745347646, 5962.165296858443, 5963.522918166536, 5965.433283838029, 5967.0, 6450.9354906450335, 6450.967745161244, 6463.06285588587, 6467.062275969958, 6473.0, 5961.4038596140035, 5966.045432730829, 5970.492508136857, 5973.1936188614845, 6005.159277701126, 3393.6606339365867, 3474.4614584739406, 3480.269143479847, 3481.408160612702, 3481.56480439945, 6691.698873550702, 6730.629815360105, 6792.728290868409, 6800.625965571842, 6806.18325800907, 6449.774257900951, 6487.318831522716, 6604.834879127964, 6698.0, 6703.93296067033, 6761.763338283136, 6790.8641827164165, 6791.57376950836, 6801.251862295144, 6806.863862722717, 6485.027245913151, 6493.902591461037, 6497.610143391412, 6502.512311576556, 6504.349565043647, 6268.874622507433, 6415.486761059197, 6432.13166222554, 6460.935390646221, 6465.838354041187, 6789.660516974231, 6793.048973143863, 6793.966030170015, 6794.558353706993, 6796.932030679828, 4480.1039792042375, 4497.437820272466, 4527.4340707411575, 4531.864044078683, 4532.9347603312535, 6385.393387628168, 6539.346065393613, 6541.6402097885075, 6543.640099794557, 6551.770688026087, 6359.618422894641, 6367.0, 6419.807405777834, 6432.581882177644, 6435.4529864962005, 6331.430171284606, 6336.683165841781, 6336.778212762531, 6340.651264180515, 6344.587601805868, 6064.4541991221, 6228.813135605939, 6241.407066328691, 6245.594036387621, 6309.242890853127, 6357.650329231937, 6366.045093236052, 6366.64983425916, 6372.936270637234, 6403.487720982217, 6212.502999760099, 6213.0, 6222.377762223922, 6227.283862355887, 6228.844278893064], "unit": "score", "name": "prototype.html", "value": 4769.8267063184985}, {"lowerIsBetter": false, "replicates": [830.6220669595334, 837.1168417319733, 838.9748307550772, 846.5301757524576, 849.6686292345986, 13327.133736307145, 13461.596152115428, 13489.39297731602, 13492.055556111063, 13494.325283735798, 12712.555060572882, 12727.809082863765, 12732.872671273284, 12797.0, 12803.231806091619, 667.3393340592802, 676.6312359763916, 792.0258082558471, 798.972035978738, 805.9355251579859, 806.2783808491397, 807.5114555693809, 809.4981111710719, 810.4529442626233, 810.5136917849272, 830.4726498673356, 834.6244190114443, 835.1815221083342, 835.3233880556738, 835.3484282259817, 829.0341751859077, 831.7380025292044, 832.0223737108903, 832.4464231286217, 833.2334252487726, 615.5629503052838, 615.9876802463925, 616.0605077257219, 617.0189398855796, 617.8177437655858, 13542.661433464144, 13703.0, 13724.65688357789, 13726.382312795948, 13730.313484325743, 13285.202887826761, 13318.733625327439, 13423.731525369536, 13603.183808971493, 13701.0, 10510.947445262802, 10721.249512534127, 10739.40933248671, 10876.728081797939, 10931.781364372668, 3524.312759011994, 3527.4532447470683, 3528.2943411317583, 3538.2039041215776, 3611.4402267648557, 43506.0, 47370.76314618405, 47643.285350719765, 50831.0, 51220.487795121946, 10176.185905127571, 10180.23648226386, 10185.694429167137, 10326.122279606167, 10535.315204511682, 17679.823201768075, 17842.732359014626, 17899.821001789816, 17928.372506962194, 17932.9103354485, 6362.9045564316575, 7560.58416787082, 7626.618669066635, 7738.845223095506, 7808.453408261481, 4079.5104587449696, 4121.443605113272, 4127.855525056609, 4183.811728472226, 4188.518320393194, 2878.8848446062343, 2886.6865576162795, 2889.0, 2893.103138027176, 2899.739023487854, 555.2615022020783, 566.829951014694, 572.5591294703055, 582.4699523433655, 589.6609449566516, 504.1278588042633, 506.3366989244102, 513.1558586125876, 557.7685260616798, 653.8626888353499, 7915.248051435105, 8225.876611850827, 8435.409521333571, 8446.61990210442, 8527.829443411098, 617.8137975087842, 621.6674079367607, 654.2247436787422, 673.397309408077, 676.7698982346026, 3833.555984364939, 3991.0621004064024, 4001.6998725095737, 4043.7978101094827, 4104.507459104927, 52972.735136324074, 55873.72063139658, 57547.424525754206, 57554.0, 57609.42390576124, 49155.754221228664, 49575.752121239886, 49688.0, 49691.0, 49731.50268497341, 45387.54612453899, 45835.31247031297, 45946.0, 46069.76965115153, 47199.76400118046, 7981.840363192588, 8010.198980101944, 8160.183981601793, 8176.264136227768, 8306.750797476085, 31205.68794312028, 31730.841345794048, 35711.10722231965, 35897.28205435929, 36622.45066323954, 46818.06363872635, 47906.0, 48272.75863620659, 52802.0, 52849.735751322536, 10923.563057477611, 10975.890241097486, 11026.117910566974, 11119.221654484109, 11169.72075698114, 11534.192606517463, 11686.883131168579, 11779.0, 11864.050875929732, 12255.448504817483, 10318.587256509656, 10385.055506843699, 10826.188035897181, 10893.945530272298, 11139.554417823521, 10244.282900197213, 10428.113610343205, 10436.112930401001, 10587.682369528618, 10636.84044739345, 10413.0, 10490.213234007633, 10520.473976301308, 10719.088877445505, 11212.25400366519, 9026.954865225633, 9134.725958221265, 9173.44959302444, 9211.953940230256, 9569.473678947725, 8626.870596940926, 8887.422317549339, 8938.955305223431, 9075.228605568336, 9543.379680320757], "unit": "score", "name": "yui.html", "value": 6194.111446129008}], "name": "dromaeo_css", "value": 6760.323191480937}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 108.0, 111.0, 111.0, 111.0, 112.0, 112.0, 107.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [155.0, 138.0, 161.0, 162.0, 129.0, 154.0, 160.0, 128.0, 167.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [165.0, 164.0, 163.0, 162.0, 162.0, 164.0, 162.0, 162.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 95.0, 100.0, 76.0, 76.0, 74.0, 114.0, 95.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.3}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 142.0, 96.0, 97.0, 96.0, 136.0, 97.0, 97.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [63.0, 57.0, 59.0, 56.0, 58.0, 57.0, 57.0, 58.0, 58.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 70.0, 68.0, 70.0, 68.0, 67.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 83.0, 84.0, 84.0, 84.0, 83.0, 84.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [114.0, 125.0, 119.0, 115.0, 123.0, 132.0, 115.0, 111.0, 113.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [145.0, 142.0, 143.0, 146.0, 136.0, 143.0, 142.0, 140.0, 143.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [66.0, 72.0, 69.0, 67.0, 66.0, 69.0, 68.0, 68.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1508.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.81339150864238], "unit": "score", "name": "Richards", "value": 210.36461799999995}, {"lowerIsBetter": false, "replicates": [188.5369532428356], "unit": "score", "name": "DeltaBlue", "value": 350.689872}, {"lowerIsBetter": false, "replicates": [281.928390188892], "unit": "score", "name": "Encrypt", "value": 944.1440070000003}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1117.31843575419], "unit": "score", "name": "RayTrace", "value": 662.290155}, {"lowerIsBetter": false, "replicates": [788.0220646178093], "unit": "score", "name": "Earley", "value": 845.7415470000001}, {"lowerIsBetter": false, "replicates": [12493.827160493827], "unit": "score", "name": "Boyer", "value": 53.34338241106715}, {"lowerIsBetter": false, "replicates": [41734.69387755102], "unit": "score", "name": "RegExp", "value": 21.82800244498778}, {"lowerIsBetter": false, "replicates": [619.1950464396285], "unit": "score", "name": "Splay", "value": 131.60796499999995}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19917.572219479178}]} 10:28:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "19917.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1508.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6760.32"}}} 10:28:21 INFO - Return code: 0 10:28:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:28:21 INFO - # TBPL SUCCESS # 10:28:21 INFO - Running post-action listener: _resource_record_post_action 10:28:21 INFO - Running post-run listener: _resource_record_post_run 10:28:22 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 557338624; Read time: 0; Write time: 593836 10:28:22 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244002816; Read time: 0; Write time: 326812 10:28:22 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 313335808; Read time: 0; Write time: 267024 10:28:22 INFO - Running post-run listener: _upload_blobber_files 10:28:22 INFO - Blob upload gear active. 10:28:22 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:28:22 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 10:28:22 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'] 10:28:22 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 10:28:22 INFO - (blobuploader) - INFO - Open directory for files ... 10:28:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 10:28:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:28:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:24 INFO - (blobuploader) - INFO - Done attempting. 10:28:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:28:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:28:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:24 INFO - (blobuploader) - INFO - Done attempting. 10:28:24 INFO - (blobuploader) - INFO - Iteration through files over. 10:28:24 INFO - Return code: 0 10:28:24 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:28:24 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:28:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/735d5c14efcc3a25421a4480eda0b7433faf9d528f97786037fa6613ce132f0b46e2658517c3f72dc5c9d1f5c746684f3b8dd825a549470d3f0bf1d61641c6d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c6d5bba6655e1cceef55673ffe561b55e66262bbf71f9ee2dbac00f578c66d8456a23ee7d866018bca7587d8c5465408eb4b08f03b61b5934eb725fc5a4d6d8"} 10:28:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:28:24 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:28:24 INFO - Contents: 10:28:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/735d5c14efcc3a25421a4480eda0b7433faf9d528f97786037fa6613ce132f0b46e2658517c3f72dc5c9d1f5c746684f3b8dd825a549470d3f0bf1d61641c6d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c6d5bba6655e1cceef55673ffe561b55e66262bbf71f9ee2dbac00f578c66d8456a23ee7d866018bca7587d8c5465408eb4b08f03b61b5934eb725fc5a4d6d8"} 10:28:24 INFO - Running post-run listener: copy_logs_to_upload_dir 10:28:24 INFO - Copying logs to upload dir... 10:28:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:28:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.106419 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-19 10:28:24.625334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 10:28:24.629309) ========= 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=52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/735d5c14efcc3a25421a4480eda0b7433faf9d528f97786037fa6613ce132f0b46e2658517c3f72dc5c9d1f5c746684f3b8dd825a549470d3f0bf1d61641c6d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c6d5bba6655e1cceef55673ffe561b55e66262bbf71f9ee2dbac00f578c66d8456a23ee7d866018bca7587d8c5465408eb4b08f03b61b5934eb725fc5a4d6d8"} build_url:https://queue.taskcluster.net/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/U8Psque-SpyIfYCNT98zgg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/735d5c14efcc3a25421a4480eda0b7433faf9d528f97786037fa6613ce132f0b46e2658517c3f72dc5c9d1f5c746684f3b8dd825a549470d3f0bf1d61641c6d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c6d5bba6655e1cceef55673ffe561b55e66262bbf71f9ee2dbac00f578c66d8456a23ee7d866018bca7587d8c5465408eb4b08f03b61b5934eb725fc5a4d6d8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 10:28:24.656907) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 10:28:24.657446) ========= 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=52faae308a556c440401f8e5000001e8-1453225245.84439-1692054376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004671 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 10:28:24.739033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 10:28:24.739378) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 10:28:24.739715) ========= ========= Total master_lag: 0.28 =========