builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1453780152.59 results: success (0) buildid: 20160125173002 builduid: fc643be3f7164d1ebe33c567d9da5c52 revision: 5ca0ea5a98e78842dacb9ef90854c635eab2022c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:12.590808) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:12.591345) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:12.591694) ========= 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-1453778987.303789-459354999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006444 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:12.616122) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:12.616403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:12.634117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:12.634434) ========= 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-1453778987.303789-459354999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004703 ========= master_lag: 0.16 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:12.802232) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:12.802509) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:12.802870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:12.803138) ========= 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-1453778987.303789-459354999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 19:49: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% 35.3M=0s 2016-01-25 19:49:13 (35.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108092 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:12.947575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:12.947871) ========= 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-1453778987.303789-459354999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013737 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:13.057733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:13.058050) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 5ca0ea5a98e78842dacb9ef90854c635eab2022c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 5ca0ea5a98e78842dacb9ef90854c635eab2022c --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-1453778987.303789-459354999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 19:49:13,608 truncating revision to first 12 chars 2016-01-25 19:49:13,608 Setting DEBUG logging. 2016-01-25 19:49:13,608 attempt 1/10 2016-01-25 19:49:13,608 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/5ca0ea5a98e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 19:49:13,875 unpacking tar archive at: b2g-inbound-5ca0ea5a98e7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.570991 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:13.642540) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:13.642873) ========= echo 5ca0ea5a98e78842dacb9ef90854c635eab2022c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5ca0ea5a98e78842dacb9ef90854c635eab2022c'] 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-1453778987.303789-459354999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5ca0ea5a98e78842dacb9ef90854c635eab2022c program finished with exit code 0 elapsedTime=0.003825 script_repo_revision: '5ca0ea5a98e78842dacb9ef90854c635eab2022c' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:13.690984) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:13.691313) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 19:49:13.701242) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-25 19:49:13.701608) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1453778987.303789-459354999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:49:14 INFO - MultiFileLogger online at 20160125 19:49:14 in /builds/slave/test-pgo 19:49:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 19:49:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:49:14 INFO - {'append_to_log': False, 19:49:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:49:14 INFO - 'blob_upload_branch': 'B2G-Inbound', 19:49:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:49:14 INFO - 'branch': 'B2G-Inbound', 19:49:14 INFO - 'buildbot_json_path': 'buildprops.json', 19:49:14 INFO - 'config_files': ('talos/linux_config.py',), 19:49:14 INFO - 'default_actions': ('clobber', 19:49:14 INFO - 'read-buildbot-config', 19:49:14 INFO - 'download-and-extract', 19:49:14 INFO - 'populate-webroot', 19:49:14 INFO - 'create-virtualenv', 19:49:14 INFO - 'install', 19:49:14 INFO - 'run-tests'), 19:49:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:49:14 INFO - 'download_minidump_stackwalk': True, 19:49:14 INFO - 'download_symbols': 'ondemand', 19:49:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:49:14 INFO - 'tooltool.py': '/tools/tooltool.py', 19:49:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:49:14 INFO - '/tools/misc-python/virtualenv.py')}, 19:49:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:49:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:49:14 INFO - 'installer_path': 'installer.exe', 19:49:14 INFO - 'log_level': 'info', 19:49:14 INFO - 'log_name': 'talos', 19:49:14 INFO - 'log_to_console': True, 19:49:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:49:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:49:14 INFO - 'opt_config_files': (), 19:49:14 INFO - 'pip_index': False, 19:49:14 INFO - 'sps_profile': False, 19:49:14 INFO - 'sps_profile_interval': 0, 19:49:14 INFO - 'suite': 'dromaeojs', 19:49:14 INFO - 'system_bits': '32', 19:49:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:49:14 INFO - 'title': 'talos-linux64-ix-056', 19:49:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:49:14 INFO - 'use_talos_json': True, 19:49:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:49:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:49:14 INFO - 'work_dir': 'build'} 19:49:14 INFO - ##### 19:49:14 INFO - ##### Running clobber step. 19:49:14 INFO - ##### 19:49:14 INFO - Running pre-action listener: _resource_record_pre_action 19:49:14 INFO - Running main action method: clobber 19:49:14 INFO - rmtree: /builds/slave/test-pgo/build 19:49:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:49:15 INFO - Running post-action listener: _resource_record_post_action 19:49:15 INFO - ##### 19:49:15 INFO - ##### Running read-buildbot-config step. 19:49:15 INFO - ##### 19:49:15 INFO - Running pre-action listener: _resource_record_pre_action 19:49:15 INFO - Running main action method: read_buildbot_config 19:49:15 INFO - Using buildbot properties: 19:49:15 INFO - { 19:49:15 INFO - "project": "", 19:49:15 INFO - "product": "firefox", 19:49:15 INFO - "script_repo_revision": "production", 19:49:15 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 19:49:15 INFO - "repository": "", 19:49:15 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 19:49:15 INFO - "buildid": "20160125173002", 19:49:15 INFO - "pgo_build": "True", 19:49:15 INFO - "basedir": "/builds/slave/test-pgo", 19:49:15 INFO - "buildnumber": 233, 19:49:15 INFO - "slavename": "talos-linux64-ix-056", 19:49:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:49:15 INFO - "platform": "ubuntu64_hw", 19:49:15 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 19:49:15 INFO - "branch": "b2g-inbound", 19:49:15 INFO - "repo_path": "integration/b2g-inbound", 19:49:15 INFO - "revision": "5ca0ea5a98e78842dacb9ef90854c635eab2022c", 19:49:15 INFO - "stage_platform": "linux64-pgo", 19:49:15 INFO - "builduid": "fc643be3f7164d1ebe33c567d9da5c52", 19:49:15 INFO - "slavebuilddir": "test" 19:49:15 INFO - } 19:49:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 19:49:15 INFO - Running post-action listener: _resource_record_post_action 19:49:15 INFO - ##### 19:49:15 INFO - ##### Running download-and-extract step. 19:49:15 INFO - ##### 19:49:15 INFO - Running pre-action listener: _resource_record_pre_action 19:49:15 INFO - Running main action method: download_and_extract 19:49:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:49: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')]} 19:49:15 INFO - https://queue.taskcluster.net/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:49:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/test_packages.json 19:49:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/test_packages.json 19:49:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:49:19 INFO - Downloaded 1448 bytes. 19:49:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:49:19 INFO - Using the following test package requirements: 19:49:19 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:49:19 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:49:19 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:49:19 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:19 INFO - u'jsshell-linux-x86_64.zip'], 19:49:19 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:49:19 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:49:19 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:49:19 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:49:19 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:49:19 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:49:19 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:49:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:49: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')]} 19:49:19 INFO - https://queue.taskcluster.net/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:49:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:49:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:49:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:49:23 INFO - Downloaded 22499141 bytes. 19:49:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:49:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:49:24 INFO - Return code: 0 19:49:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:49:24 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')]} 19:49:24 INFO - https://queue.taskcluster.net/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:49:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:49:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:49:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:49:26 INFO - Downloaded 22499141 bytes. 19:49:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:49:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:49:27 INFO - Return code: 0 19:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:27 INFO - https://queue.taskcluster.net/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:49:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:49:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:49:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:49:29 INFO - Downloaded 10706572 bytes. 19:49:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:49:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:49:29 INFO - Return code: 0 19:49:29 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')]} 19:49:29 INFO - https://queue.taskcluster.net/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:49:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:49:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:49:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:49:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:49:30 INFO - Downloaded 55983328 bytes. 19:49:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:49:30 INFO - mkdir: /builds/slave/test-pgo/properties 19:49:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:49:30 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:49:30 INFO - Contents: 19:49:30 INFO - build_url:https://queue.taskcluster.net/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:49:30 INFO - Running post-action listener: _resource_record_post_action 19:49:30 INFO - Running post-action listener: set_extra_try_arguments 19:49:30 INFO - ##### 19:49:30 INFO - ##### Running populate-webroot step. 19:49:30 INFO - ##### 19:49:30 INFO - Running pre-action listener: _resource_record_pre_action 19:49:30 INFO - Running main action method: populate_webroot 19:49:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:49:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:49:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:49:30 INFO - '--tppagecycles', 19:49:30 INFO - '7'], 19:49:30 INFO - 'tests': ['tsvgm']}}, 19:49:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:49:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:49:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:49:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:49:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:49:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:49:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:30 INFO - 'talos_options': ['--e10s'], 19:49:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:30 INFO - 'tests': ['damp', 'tps']}, 19:49:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:30 INFO - 'talos_options': ['--e10s'], 19:49:30 INFO - 'tests': ['damp', 'tps']}, 19:49:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:49:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:49:30 INFO - 'other': {'tests': ['a11yr', 19:49:30 INFO - 'ts_paint', 19:49:30 INFO - 'tpaint', 19:49:30 INFO - 'sessionrestore', 19:49:30 INFO - 'sessionrestore_no_auto_restore']}, 19:49:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:49:30 INFO - 'tests': ['a11yr', 19:49:30 INFO - 'ts_paint', 19:49:30 INFO - 'tpaint', 19:49:30 INFO - 'sessionrestore', 19:49:30 INFO - 'sessionrestore_no_auto_restore']}, 19:49:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:49:30 INFO - 'tests': ['a11yr', 19:49:30 INFO - 'ts_paint', 19:49:30 INFO - 'tpaint', 19:49:30 INFO - 'sessionrestore', 19:49:30 INFO - 'sessionrestore_no_auto_restore']}, 19:49:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:49:30 INFO - 'tests': ['a11yr', 19:49:30 INFO - 'ts_paint', 19:49:30 INFO - 'tpaint', 19:49:30 INFO - 'sessionrestore', 19:49:30 INFO - 'sessionrestore_no_auto_restore']}, 19:49:30 INFO - 'other_l64': {'tests': ['a11yr', 19:49:30 INFO - 'ts_paint', 19:49:30 INFO - 'tpaint', 19:49:30 INFO - 'sessionrestore', 19:49:30 INFO - 'sessionrestore_no_auto_restore']}, 19:49:30 INFO - 'other_nol64': {'tests': ['a11yr', 19:49:30 INFO - 'ts_paint', 19:49:30 INFO - 'tpaint', 19:49:30 INFO - 'sessionrestore', 19:49:30 INFO - 'sessionrestore_no_auto_restore']}, 19:49:30 INFO - 'svgr': {'tests': ['tsvgx', 19:49:30 INFO - 'tsvgr_opacity', 19:49:30 INFO - 'tart', 19:49:30 INFO - 'tscrollx', 19:49:30 INFO - 'cart']}, 19:49:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:49:30 INFO - 'tests': ['tsvgx', 19:49:30 INFO - 'tsvgr_opacity', 19:49:30 INFO - 'tart', 19:49:30 INFO - 'tscrollx', 19:49:30 INFO - 'cart']}, 19:49:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:30 INFO - 'tests': ['tp5o']}, 19:49:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:30 INFO - 'talos_options': ['--e10s'], 19:49:30 INFO - 'tests': ['tp5o']}, 19:49:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:30 INFO - 'talos_options': ['--xperf_path', 19:49:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:30 INFO - 'tests': ['tp5n']}, 19:49:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:30 INFO - 'talos_options': ['--e10s', 19:49:30 INFO - '--xperf_path', 19:49:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:30 INFO - 'tests': ['tp5n']}}, 19:49:30 INFO - 'talos.zip': {'path': '', 19:49:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:49:30 INFO - Running post-action listener: _resource_record_post_action 19:49:30 INFO - ##### 19:49:30 INFO - ##### Running create-virtualenv step. 19:49:30 INFO - ##### 19:49:30 INFO - Running pre-action listener: _resource_record_pre_action 19:49:30 INFO - Running main action method: create_virtualenv 19:49:30 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:49:30 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 19:49:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:49:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:49:30 INFO - Using real prefix '/usr' 19:49:30 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:49:31 INFO - Installing distribute.............................................................................................................................................................................................done. 19:49:33 INFO - Installing pip.................done. 19:49:33 INFO - Return code: 0 19:49:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:49: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')]} 19:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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')]} 19:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fdba55bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b13f0>, '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 0x2543560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543a10>, '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-1453778987.303789-459354999', '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 19:49:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:49:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:49:33 INFO - Using env: {'DISPLAY': ':0', 19:49:33 INFO - 'HOME': '/home/cltbld', 19:49:33 INFO - 'LANG': 'en_US.UTF-8', 19:49:33 INFO - 'LANGUAGE': 'en_US:en', 19:49:33 INFO - 'LOGNAME': 'cltbld', 19:49:33 INFO - 'MAIL': '/var/mail/cltbld', 19:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:33 INFO - 'MOZ_NO_REMOTE': '1', 19:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:33 INFO - 'NO_EM_RESTART': '1', 19:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:33 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:33 INFO - 'SHELL': '/bin/bash', 19:49:33 INFO - 'SHLVL': '1', 19:49:33 INFO - 'TERM': 'linux', 19:49:33 INFO - 'TMOUT': '86400', 19:49:33 INFO - 'USER': 'cltbld', 19:49:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453778987.303789-459354999', 19:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:33 INFO - '_': '/tools/buildbot/bin/python'} 19:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:33 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 19:49:33 INFO - Cleaning up... 19:49:33 INFO - Return code: 0 19:49:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:49: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')]} 19:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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')]} 19:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fdba55bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b13f0>, '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 0x2543560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543a10>, '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-1453778987.303789-459354999', '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 19:49:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:49:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:49:33 INFO - Using env: {'DISPLAY': ':0', 19:49:33 INFO - 'HOME': '/home/cltbld', 19:49:33 INFO - 'LANG': 'en_US.UTF-8', 19:49:33 INFO - 'LANGUAGE': 'en_US:en', 19:49:33 INFO - 'LOGNAME': 'cltbld', 19:49:33 INFO - 'MAIL': '/var/mail/cltbld', 19:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:33 INFO - 'MOZ_NO_REMOTE': '1', 19:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:33 INFO - 'NO_EM_RESTART': '1', 19:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:33 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:33 INFO - 'SHELL': '/bin/bash', 19:49:33 INFO - 'SHLVL': '1', 19:49:33 INFO - 'TERM': 'linux', 19:49:33 INFO - 'TMOUT': '86400', 19:49:33 INFO - 'USER': 'cltbld', 19:49:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453778987.303789-459354999', 19:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:33 INFO - '_': '/tools/buildbot/bin/python'} 19:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:33 INFO - Downloading/unpacking psutil>=0.7.1 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:49:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:35 INFO - Installing collected packages: psutil 19:49:35 INFO - Running setup.py install for psutil 19:49:35 INFO - building 'psutil._psutil_linux' extension 19:49:35 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 19:49:35 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 19:49:35 INFO - building 'psutil._psutil_posix' extension 19:49:35 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 19:49:36 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 19:49:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:36 INFO - Successfully installed psutil 19:49:36 INFO - Cleaning up... 19:49:36 INFO - Return code: 0 19:49:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fdba55bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b13f0>, '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 0x2543560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543a10>, '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-1453778987.303789-459354999', '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 19:49:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:49:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:49:36 INFO - Using env: {'DISPLAY': ':0', 19:49:36 INFO - 'HOME': '/home/cltbld', 19:49:36 INFO - 'LANG': 'en_US.UTF-8', 19:49:36 INFO - 'LANGUAGE': 'en_US:en', 19:49:36 INFO - 'LOGNAME': 'cltbld', 19:49:36 INFO - 'MAIL': '/var/mail/cltbld', 19:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:36 INFO - 'MOZ_NO_REMOTE': '1', 19:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:36 INFO - 'NO_EM_RESTART': '1', 19:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:36 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:36 INFO - 'SHELL': '/bin/bash', 19:49:36 INFO - 'SHLVL': '1', 19:49:36 INFO - 'TERM': 'linux', 19:49:36 INFO - 'TMOUT': '86400', 19:49:36 INFO - 'USER': 'cltbld', 19:49:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453778987.303789-459354999', 19:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:36 INFO - '_': '/tools/buildbot/bin/python'} 19:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:49:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:49:38 INFO - Installing collected packages: mozsystemmonitor 19:49:38 INFO - Running setup.py install for mozsystemmonitor 19:49:38 INFO - Successfully installed mozsystemmonitor 19:49:38 INFO - Cleaning up... 19:49:38 INFO - Return code: 0 19:49:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:49: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')]} 19:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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')]} 19:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fdba55bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b13f0>, '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 0x2543560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543a10>, '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-1453778987.303789-459354999', '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 19:49:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:49:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:49:38 INFO - Using env: {'DISPLAY': ':0', 19:49:38 INFO - 'HOME': '/home/cltbld', 19:49:38 INFO - 'LANG': 'en_US.UTF-8', 19:49:38 INFO - 'LANGUAGE': 'en_US:en', 19:49:38 INFO - 'LOGNAME': 'cltbld', 19:49:38 INFO - 'MAIL': '/var/mail/cltbld', 19:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:38 INFO - 'MOZ_NO_REMOTE': '1', 19:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:38 INFO - 'NO_EM_RESTART': '1', 19:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:38 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:38 INFO - 'SHELL': '/bin/bash', 19:49:38 INFO - 'SHLVL': '1', 19:49:38 INFO - 'TERM': 'linux', 19:49:38 INFO - 'TMOUT': '86400', 19:49:38 INFO - 'USER': 'cltbld', 19:49:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453778987.303789-459354999', 19:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:38 INFO - '_': '/tools/buildbot/bin/python'} 19:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:38 INFO - Downloading/unpacking blobuploader==1.2.4 19:49:38 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 19:49:38 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 19:49:38 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 19:49:38 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 19:49:38 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 19:49:38 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 19:49:40 INFO - Downloading blobuploader-1.2.4.tar.gz 19:49:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:49:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:49:40 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 19:49:40 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 19:49:40 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 19:49:40 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 19:49:40 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 19:49:40 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 19:49:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:49:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:49:40 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 19:49:40 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 19:49:40 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 19:49:40 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 19:49:40 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 19:49:40 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 19:49:41 INFO - Downloading docopt-0.6.1.tar.gz 19:49:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:49:41 INFO - Installing collected packages: blobuploader, requests, docopt 19:49:41 INFO - Running setup.py install for blobuploader 19:49:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:49:41 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:49:41 INFO - Running setup.py install for requests 19:49:41 INFO - Running setup.py install for docopt 19:49:41 INFO - Successfully installed blobuploader requests docopt 19:49:41 INFO - Cleaning up... 19:49:41 INFO - Return code: 0 19:49:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:49: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')]} 19:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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')]} 19:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fdba55bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b13f0>, '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 0x2543560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543a10>, '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-1453778987.303789-459354999', '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 19:49:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 19:49:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 19:49:41 INFO - Using env: {'DISPLAY': ':0', 19:49:41 INFO - 'HOME': '/home/cltbld', 19:49:41 INFO - 'LANG': 'en_US.UTF-8', 19:49:41 INFO - 'LANGUAGE': 'en_US:en', 19:49:41 INFO - 'LOGNAME': 'cltbld', 19:49:41 INFO - 'MAIL': '/var/mail/cltbld', 19:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:41 INFO - 'MOZ_NO_REMOTE': '1', 19:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:41 INFO - 'NO_EM_RESTART': '1', 19:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:41 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:41 INFO - 'SHELL': '/bin/bash', 19:49:41 INFO - 'SHLVL': '1', 19:49:41 INFO - 'TERM': 'linux', 19:49:41 INFO - 'TMOUT': '86400', 19:49:41 INFO - 'USER': 'cltbld', 19:49:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453778987.303789-459354999', 19:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:41 INFO - '_': '/tools/buildbot/bin/python'} 19:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:42 INFO - Running setup.py (path:/tmp/pip-uGVjo2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:42 INFO - Running setup.py (path:/tmp/pip-Kezktb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:42 INFO - Running setup.py (path:/tmp/pip-cRWpb7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:42 INFO - Running setup.py (path:/tmp/pip-oAV1cg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:42 INFO - Running setup.py (path:/tmp/pip-ddEPfF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:42 INFO - Running setup.py (path:/tmp/pip-XxA3LQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:42 INFO - Running setup.py (path:/tmp/pip-CgF2Br-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:42 INFO - Running setup.py (path:/tmp/pip-Xq8cSk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:42 INFO - Running setup.py (path:/tmp/pip-BGlbN_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:42 INFO - Running setup.py (path:/tmp/pip-_mvQGM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:42 INFO - Running setup.py (path:/tmp/pip-BH8av_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:42 INFO - Running setup.py (path:/tmp/pip-FXiNec-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:42 INFO - Running setup.py (path:/tmp/pip-gJA9Cz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:42 INFO - Running setup.py (path:/tmp/pip-aFQax9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:43 INFO - Running setup.py (path:/tmp/pip-iE7eXt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:43 INFO - Running setup.py (path:/tmp/pip-0aKNF8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:43 INFO - Running setup.py (path:/tmp/pip-wOusM_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:49:43 INFO - Running setup.py install for manifestparser 19:49:43 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:49:43 INFO - Running setup.py install for mozcrash 19:49:43 INFO - Running setup.py install for mozdebug 19:49:43 INFO - Running setup.py install for mozdevice 19:49:43 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:49:43 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:49:43 INFO - Running setup.py install for mozfile 19:49:43 INFO - Running setup.py install for mozhttpd 19:49:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:49:43 INFO - Running setup.py install for mozinfo 19:49:43 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:49:43 INFO - Running setup.py install for mozInstall 19:49:44 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:49:44 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:49:44 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:49:44 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:49:44 INFO - Running setup.py install for mozleak 19:49:44 INFO - Running setup.py install for mozlog 19:49:44 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:49:44 INFO - Running setup.py install for moznetwork 19:49:44 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:49:44 INFO - Running setup.py install for mozprocess 19:49:44 INFO - Running setup.py install for mozprofile 19:49:44 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:49:44 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:49:44 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:49:44 INFO - Running setup.py install for mozrunner 19:49:44 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:49:44 INFO - Running setup.py install for mozscreenshot 19:49:44 INFO - Running setup.py install for moztest 19:49:44 INFO - Running setup.py install for mozversion 19:49:45 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:49:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:49:45 INFO - Cleaning up... 19:49:45 INFO - Return code: 0 19:49:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:49: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')]} 19:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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')]} 19:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fdba55bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b13f0>, '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 0x2543560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543a10>, '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-1453778987.303789-459354999', '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 19:49:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:49:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:49:45 INFO - Using env: {'DISPLAY': ':0', 19:49:45 INFO - 'HOME': '/home/cltbld', 19:49:45 INFO - 'LANG': 'en_US.UTF-8', 19:49:45 INFO - 'LANGUAGE': 'en_US:en', 19:49:45 INFO - 'LOGNAME': 'cltbld', 19:49:45 INFO - 'MAIL': '/var/mail/cltbld', 19:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:45 INFO - 'MOZ_NO_REMOTE': '1', 19:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:45 INFO - 'NO_EM_RESTART': '1', 19:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:45 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:45 INFO - 'SHELL': '/bin/bash', 19:49:45 INFO - 'SHLVL': '1', 19:49:45 INFO - 'TERM': 'linux', 19:49:45 INFO - 'TMOUT': '86400', 19:49:45 INFO - 'USER': 'cltbld', 19:49:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453778987.303789-459354999', 19:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:45 INFO - '_': '/tools/buildbot/bin/python'} 19:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:45 INFO - Running setup.py (path:/tmp/pip-1hmPHE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:45 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)) 19:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:45 INFO - Running setup.py (path:/tmp/pip-MuN5aS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:45 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)) 19:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:45 INFO - Running setup.py (path:/tmp/pip-Pa1aj7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:45 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)) 19:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:45 INFO - Running setup.py (path:/tmp/pip-XchXjf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:45 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)) 19:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:45 INFO - Running setup.py (path:/tmp/pip-4Qvd7h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:45 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)) 19:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:45 INFO - Running setup.py (path:/tmp/pip-ap5UmE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:45 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)) 19:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:45 INFO - Running setup.py (path:/tmp/pip-S3YB05-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:45 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)) 19:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:45 INFO - Running setup.py (path:/tmp/pip-OUVCeb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:45 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)) 19:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:45 INFO - Running setup.py (path:/tmp/pip-5DQ82H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:45 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)) 19:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:45 INFO - Running setup.py (path:/tmp/pip-5rZ5Yi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:46 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)) 19:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:46 INFO - Running setup.py (path:/tmp/pip-PYBjhD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:46 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)) 19:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:46 INFO - Running setup.py (path:/tmp/pip-FCcbwv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:46 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)) 19:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:46 INFO - Running setup.py (path:/tmp/pip-N8XgXi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:46 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)) 19:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:46 INFO - Running setup.py (path:/tmp/pip-I79Wqq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:46 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)) 19:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:46 INFO - Running setup.py (path:/tmp/pip-SVHmIS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:46 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)) 19:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:46 INFO - Running setup.py (path:/tmp/pip-EVlHjS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:46 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)) 19:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:46 INFO - Running setup.py (path:/tmp/pip-GTwVka-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:46 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)) 19:49:46 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)) 19:49:46 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)) 19:49:46 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)) 19:49:46 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)) 19:49:46 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)) 19:49:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49:48 INFO - Downloading blessings-1.6.tar.gz 19:49:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:49:48 INFO - Installing collected packages: blessings 19:49:48 INFO - Running setup.py install for blessings 19:49:48 INFO - Successfully installed blessings 19:49:48 INFO - Cleaning up... 19:49:48 INFO - Return code: 0 19:49:48 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:49:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:49:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:49:48 INFO - Reading from file tmpfile_stdout 19:49:48 INFO - Current package versions: 19:49:48 INFO - argparse == 1.2.1 19:49:48 INFO - blessings == 1.6 19:49:48 INFO - blobuploader == 1.2.4 19:49:48 INFO - docopt == 0.6.1 19:49:48 INFO - manifestparser == 1.1 19:49:48 INFO - mozInstall == 1.12 19:49:48 INFO - mozcrash == 0.16 19:49:48 INFO - mozdebug == 0.1 19:49:48 INFO - mozdevice == 0.48 19:49:48 INFO - mozfile == 1.2 19:49:48 INFO - mozhttpd == 0.7 19:49:48 INFO - mozinfo == 0.9 19:49:48 INFO - mozleak == 0.1 19:49:48 INFO - mozlog == 3.1 19:49:48 INFO - moznetwork == 0.27 19:49:48 INFO - mozprocess == 0.22 19:49:48 INFO - mozprofile == 0.28 19:49:48 INFO - mozrunner == 6.11 19:49:48 INFO - mozscreenshot == 0.1 19:49:48 INFO - mozsystemmonitor == 0.0 19:49:48 INFO - moztest == 0.7 19:49:48 INFO - mozversion == 1.4 19:49:48 INFO - psutil == 3.1.1 19:49:48 INFO - requests == 1.2.3 19:49:48 INFO - wsgiref == 0.1.2 19:49:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:49: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')]} 19:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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')]} 19:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fdba55bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b13f0>, '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 0x2543560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543a10>, '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-1453778987.303789-459354999', '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 19:49:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:49:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:49:48 INFO - Using env: {'DISPLAY': ':0', 19:49:48 INFO - 'HOME': '/home/cltbld', 19:49:48 INFO - 'LANG': 'en_US.UTF-8', 19:49:48 INFO - 'LANGUAGE': 'en_US:en', 19:49:48 INFO - 'LOGNAME': 'cltbld', 19:49:48 INFO - 'MAIL': '/var/mail/cltbld', 19:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:48 INFO - 'MOZ_NO_REMOTE': '1', 19:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:48 INFO - 'NO_EM_RESTART': '1', 19:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:48 INFO - 'SHELL': '/bin/bash', 19:49:48 INFO - 'SHLVL': '1', 19:49:48 INFO - 'TERM': 'linux', 19:49:48 INFO - 'TMOUT': '86400', 19:49:48 INFO - 'USER': 'cltbld', 19:49:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453778987.303789-459354999', 19:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:48 INFO - '_': '/tools/buildbot/bin/python'} 19:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:48 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)) 19:49:48 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)) 19:49:48 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)) 19:49:48 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)) 19:49:48 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)) 19:49:48 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)) 19:49:48 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)) 19:49:48 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)) 19:49:48 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)) 19:49:48 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)) 19:49:48 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)) 19:49:48 INFO - Cleaning up... 19:49:48 INFO - Return code: 0 19:49:48 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:49: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')]} 19:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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')]} 19:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fdba55bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b13f0>, '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 0x2543560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543a10>, '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-1453778987.303789-459354999', '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 19:49:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:49:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:49:48 INFO - Using env: {'DISPLAY': ':0', 19:49:48 INFO - 'HOME': '/home/cltbld', 19:49:48 INFO - 'LANG': 'en_US.UTF-8', 19:49:48 INFO - 'LANGUAGE': 'en_US:en', 19:49:48 INFO - 'LOGNAME': 'cltbld', 19:49:48 INFO - 'MAIL': '/var/mail/cltbld', 19:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:48 INFO - 'MOZ_NO_REMOTE': '1', 19:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:48 INFO - 'NO_EM_RESTART': '1', 19:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:48 INFO - 'SHELL': '/bin/bash', 19:49:48 INFO - 'SHLVL': '1', 19:49:48 INFO - 'TERM': 'linux', 19:49:48 INFO - 'TMOUT': '86400', 19:49:48 INFO - 'USER': 'cltbld', 19:49:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453778987.303789-459354999', 19:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:48 INFO - '_': '/tools/buildbot/bin/python'} 19:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:49 INFO - Downloading/unpacking jsonschema 19:49:49 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 19:49:49 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 19:49:49 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 19:49:49 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 19:49:49 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 19:49:49 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 19:49:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:49:50 INFO - Downloading/unpacking functools32 (from jsonschema) 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49:51 INFO - Downloading functools32-3.2.3-2.tar.gz 19:49:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:49:51 INFO - warning: no files found matching '*.txt' 19:49:51 INFO - no previously-included directories found matching 'build' 19:49:51 INFO - no previously-included directories found matching 'dist' 19:49:51 INFO - no previously-included directories found matching '.git*' 19:49:51 INFO - Installing collected packages: jsonschema, functools32 19:49:51 INFO - Running setup.py install for functools32 19:49:51 INFO - warning: no files found matching '*.txt' 19:49:51 INFO - no previously-included directories found matching 'build' 19:49:51 INFO - no previously-included directories found matching 'dist' 19:49:51 INFO - no previously-included directories found matching '.git*' 19:49:51 INFO - Successfully installed jsonschema functools32 19:49:51 INFO - Cleaning up... 19:49:51 INFO - Return code: 0 19:49:51 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:49:51 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')]} 19:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:51 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')]} 19:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fdba55bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b13f0>, '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 0x2543560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543a10>, '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-1453778987.303789-459354999', '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 19:49:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:49:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:49:51 INFO - Using env: {'DISPLAY': ':0', 19:49:51 INFO - 'HOME': '/home/cltbld', 19:49:51 INFO - 'LANG': 'en_US.UTF-8', 19:49:51 INFO - 'LANGUAGE': 'en_US:en', 19:49:51 INFO - 'LOGNAME': 'cltbld', 19:49:51 INFO - 'MAIL': '/var/mail/cltbld', 19:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:51 INFO - 'MOZ_NO_REMOTE': '1', 19:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:51 INFO - 'NO_EM_RESTART': '1', 19:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:51 INFO - 'SHELL': '/bin/bash', 19:49:51 INFO - 'SHLVL': '1', 19:49:51 INFO - 'TERM': 'linux', 19:49:51 INFO - 'TMOUT': '86400', 19:49:51 INFO - 'USER': 'cltbld', 19:49:51 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453778987.303789-459354999', 19:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:51 INFO - '_': '/tools/buildbot/bin/python'} 19:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:51 INFO - Downloading/unpacking flake8 19:49:51 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 19:49:51 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 19:49:51 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 19:49:51 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 19:49:51 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 19:49:51 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 19:49:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:49:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:49:53 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 19:49:53 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 19:49:53 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 19:49:53 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 19:49:53 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 19:49:53 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 19:49:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:49:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:49:53 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 19:49:53 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 19:49:53 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 19:49:53 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 19:49:53 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 19:49:53 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 19:49:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:49:53 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 19:49:53 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 19:49:53 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 19:49:53 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 19:49:53 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 19:49:53 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 19:49:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:49:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:49:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:49:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:49:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:49:54 INFO - no previously-included directories found matching 'docs/_build' 19:49:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:49:54 INFO - Running setup.py install for pep8 19:49:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:49:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:49:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:49:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:49:54 INFO - no previously-included directories found matching 'docs/_build' 19:49:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:49:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:49:54 INFO - Cleaning up... 19:49:54 INFO - Return code: 0 19:49:54 INFO - Running post-action listener: _resource_record_post_action 19:49:54 INFO - Running post-action listener: _start_resource_monitoring 19:49:54 INFO - Starting resource monitoring. 19:49:54 INFO - ##### 19:49:54 INFO - ##### Running install step. 19:49:54 INFO - ##### 19:49:54 INFO - Running pre-action listener: _resource_record_pre_action 19:49:54 INFO - Running main action method: install 19:49:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:49:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:49:54 INFO - Reading from file tmpfile_stdout 19:49:54 INFO - Detecting whether we're running mozinstall >=1.0... 19:49:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:49:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:49:54 INFO - Reading from file tmpfile_stdout 19:49:54 INFO - Output received: 19:49:54 INFO - Usage: mozinstall [options] installer 19:49:54 INFO - Options: 19:49:54 INFO - -h, --help show this help message and exit 19:49:54 INFO - -d DEST, --destination=DEST 19:49:54 INFO - Directory to install application into. [default: 19:49:54 INFO - "/builds/slave/test-pgo"] 19:49:54 INFO - --app=APP Application being installed. [default: firefox] 19:49:54 INFO - mkdir: /builds/slave/test-pgo/build/application 19:49:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:49:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:50:10 INFO - Reading from file tmpfile_stdout 19:50:10 INFO - Output received: 19:50:10 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:50:10 INFO - Running post-action listener: _resource_record_post_action 19:50:10 INFO - ##### 19:50:10 INFO - ##### Running run-tests step. 19:50:10 INFO - ##### 19:50:10 INFO - Running pre-action listener: _resource_record_pre_action 19:50:10 INFO - Running main action method: run_tests 19:50:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:50:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:50:10 INFO - Python 2.7.3 19:50:10 INFO - Return code: 0 19:50:10 INFO - grabbing minidump binary from tooltool 19:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:10 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 0x24b13f0>, '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 0x2543560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:50:10 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 19:50:10 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 19:50:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:50:10 INFO - Return code: 0 19:50:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:50:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:50:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:50:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:50:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:50:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:50:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:50:12 INFO - Return code: 0 19:50:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.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 19:50:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.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 19:50:12 INFO - Using env: {'DISPLAY': ':0', 19:50:12 INFO - 'HOME': '/home/cltbld', 19:50:12 INFO - 'LANG': 'en_US.UTF-8', 19:50:12 INFO - 'LANGUAGE': 'en_US:en', 19:50:12 INFO - 'LOGNAME': 'cltbld', 19:50:12 INFO - 'MAIL': '/var/mail/cltbld', 19:50:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:50:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:12 INFO - 'MOZ_NO_REMOTE': '1', 19:50:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:12 INFO - 'NO_EM_RESTART': '1', 19:50:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:12 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:50:12 INFO - 'SHELL': '/bin/bash', 19:50:12 INFO - 'SHLVL': '1', 19:50:12 INFO - 'TERM': 'linux', 19:50:12 INFO - 'TMOUT': '86400', 19:50:12 INFO - 'USER': 'cltbld', 19:50:12 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453778987.303789-459354999', 19:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:12 INFO - '_': '/tools/buildbot/bin/python'} 19:50:12 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.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 19:50:12 INFO - mozversion application_buildid: 20160125173002 19:50:12 INFO - mozversion application_changeset: 5ca0ea5a98e78842dacb9ef90854c635eab2022c 19:50:12 INFO - mozversion application_display_name: Nightly 19:50:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:50:12 INFO - mozversion application_name: Firefox 19:50:12 INFO - mozversion application_remotingname: firefox 19:50:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 19:50:12 INFO - mozversion application_vendor: Mozilla 19:50:12 INFO - mozversion application_version: 47.0a1 19:50:12 INFO - mozversion platform_buildid: 20160125173002 19:50:12 INFO - mozversion platform_changeset: 5ca0ea5a98e78842dacb9ef90854c635eab2022c 19:50:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 19:50:12 INFO - mozversion platform_version: 47.0a1 19:50:12 INFO - using testdate: 1453780212 19:50:12 INFO - actual date: 1453780212 19:50:12 INFO - starting webserver on 'localhost:48215' 19:50:12 INFO - SUITE-START | Running 3 tests 19:50:12 INFO - TEST-START | dromaeo_css 19:50:12 INFO - operating with platform_type : linux_ 19:50:12 INFO - Initialising browser for dromaeo_css test... 19:50:12 INFO - TEST-INFO | started process 23646 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiU1THe/profile http://localhost:48215/getInfo.html) 19:50:16 INFO - PROCESS | 23646 | __metrics Screen width/height:1600/1200 19:50:16 INFO - PROCESS | 23646 | colorDepth:24 19:50:16 INFO - PROCESS | 23646 | Browser inner width/height: 1024/697 19:50:16 INFO - PROCESS | 23646 | __metrics 19:50:16 INFO - PROCESS | 23646 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:50:16 INFO - PROCESS | 23646 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:50:17 INFO - TEST-INFO | 23646: exit 0 19:50:17 INFO - Browser initialized. 19:50:17 INFO - Running cycle 1/1 for dromaeo_css test... 19:50:17 INFO - TEST-INFO | started process 23740 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiU1THe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:50:29 INFO - PROCESS | 23740 | RSS: Main: 149008384 19:50:29 INFO - PROCESS | 23740 | 19:51:21 INFO - PROCESS | 23740 | 1453780280998 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] 19:53:29 INFO - PROCESS | 23740 | Cycle 1(1): loaded http://localhost:48215/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48215/tests/dromaeo/cssquery-ext.html) 19:53:30 INFO - PROCESS | 23740 | RSS: Main: 266907648 19:53:30 INFO - PROCESS | 23740 | 19:56:33 INFO - PROCESS | 23740 | Cycle 1(1): loaded http://localhost:48215/tests/dromaeo/cssquery-ext.html (next: http://localhost:48215/tests/dromaeo/cssquery-jquery.html) 19:56:33 INFO - PROCESS | 23740 | RSS: Main: 234717184 19:56:33 INFO - PROCESS | 23740 | 19:59:35 INFO - PROCESS | 23740 | Cycle 1(1): loaded http://localhost:48215/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48215/tests/dromaeo/cssquery-mootools.html) 19:59:36 INFO - PROCESS | 23740 | RSS: Main: 229703680 19:59:36 INFO - PROCESS | 23740 | 20:02:38 INFO - PROCESS | 23740 | Cycle 1(1): loaded http://localhost:48215/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48215/tests/dromaeo/cssquery-prototype.html) 20:02:38 INFO - PROCESS | 23740 | RSS: Main: 212766720 20:02:38 INFO - PROCESS | 23740 | 20:05:41 INFO - PROCESS | 23740 | Cycle 1(1): loaded http://localhost:48215/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48215/tests/dromaeo/cssquery-yui.html) 20:05:41 INFO - PROCESS | 23740 | RSS: Main: 216256512 20:05:41 INFO - PROCESS | 23740 | 20:08:44 INFO - PROCESS | 23740 | Cycle 1(1): loaded http://localhost:48215/tests/dromaeo/cssquery-yui.html (next: http://localhost:48215/tests/dromaeo/cssquery-dojo.html) 20:08:44 INFO - PROCESS | 23740 | RSS: Main: 259362816 20:08:44 INFO - PROCESS | 23740 | 20:08:44 INFO - PROCESS | 23740 | __start_tp_report 20:08:44 INFO - PROCESS | 23740 | _x_x_mozilla_page_load 20:08:44 INFO - PROCESS | 23740 | _x_x_mozilla_page_load_details 20:08:44 INFO - PROCESS | 23740 | |i|pagename|runs| 20:08:44 INFO - PROCESS | 23740 | |0;dojo.html;3045.558394032865;3100.3024319528095;3131.2485003599127;3143.339898621289;3164.066600352896;4809.783559739812;4883.926741098886;4935.703857768536;4950.257461380795;5006.173981293086;4891.1195984722735;4922.926156107652;4938.851834444963;4955.628327875405;5006.849794506171;4544.636429085682;4549.431321084864;4602.562756538124;4627.514111018345;4643.466001409847;4597.402337696095;4638.48976612574;4665.813367465297;4667.369905062824;4670.929936050962;4434.246178149722;4469.486009108961;4520.570545798144;4572.474165470981;4598.057398233354;4541.9545804542195;4548.977255113737;4570.428696412949;4580.8167673293365;4607.470140933802;4518.638508919278;4524.298733696282;4536.54634536547;4555.74943378114;4599.149157405891;4757.881052973703;4840.733759643218;4842.951570484285;4899.755012249373;4932.753362331869;5321.787128514855;5343.973280133613;5355;5355.384130824966;5369.919451208235;5152.845414637567;5373.892522149574;5396.78412863485;5426.70153141581;5449.591280653967;4966.528179822911;5049.192129259301;5053.646244762868;5131.076406246874;5140.074786538422;5332.093544097513;5337.492938170868;5344.67931924078;5352.2506849041165;5386.48828361305;5115.462876397999;5146.639735218499;5155.304033955443;5155.381354237516;5200.947990520122;5290.1800220965815;5317.494837990384;5329.387120481194;5406.053940560386;5451.48210919962;5294.179402192666;5309.548688361455;5320.547753440924;5323;5325;5196.636235463481;5302.469753024744;5304.230886521433;5308.0710875596615;5352.678839269578;4121.113960498507;4172.228137794517;4178.895527611834;4248.808803603845;4262.531121576624;3770.6040865709256;3773.471713960048;3782.4893639358884;3800.657940785343;3803.657670809585;4961.975190124099;4965.1311020571975;4965.379327584052;4967.956729086933;5003.199488081889;5219.582433405319;5272.235525848807;5301.734913254322;5305.840824775263;5357.383900851374;4934.185859333242;4956;4961.08219979305;4970.080535100946;5012.523810238022;4520.977395113069;4603.447586289667;4617.676762626651;4635.235186194308;4661.091087237956;5462.317210348707;5489.478499542537;5538.363088244903;5560.77756889728;5573;5300.1519756838725;5305.708186049805;5307.203919412119;5310.628256022042;5350.438203988525;5540.944590554042;5567.582431317748;5568.610197286151;5573.442655734394;5620.494155526022;5185.688858668492;5224.52979231871;5257.369115706139;5278.97360513195;5331.573474121983;5305.124654431976;5309.123994540858;5313.707746074003;5318.0959236930585;5319.521243088141;5097.413797413196;5157.303763991963;5200.895982080413;5212.50481204285;5238.76425560843;5139.074966506065;5176.094183517794;5202.453742356998;5220.295260139985;5266.815661451831;5134.666246693953;5142.948570514247;5159.251908473326;5167.457416971164;5211.452797456364;5120.206368012964;5148.736278273317;5239.685618862881;5257.080010997984;5265.868353291045;4959.156943319572;5080.872978175427;5096.694198348111;5141.742912854417;5146.356705411824 20:08:44 INFO - PROCESS | 23740 | |1;ext.html;531.686305080003;538.981135660252;542.7340603104477;559.6809818403509;571.6341541413494;27508.86245568772;28177.85911070447;35676.64323356769;36256.918161956266;36454.45318320228;38304.80847595758;38555;38797;38854.417183742196;38941.41587876184;8346.666133354658;8536.658533658647;8541.95729021354;8549.700760473384;8555;8293.33653307734;8341.165883411672;8378.413511054228;8439.57802109892;8440.957795211016;8609.698660546883;8640.438371505863;8681.392302538825;8705.521196334199;8715.825683486326;8544.145585441438;8606.440581362223;8607.526586037766;8620.65517379304;8640.524771137585;8468.872966905501;8615.913840861574;8619.1811777881;8623.913760862437;8630;36090.27819443623;36394.272114557825;36503.817480912694;36529.26941461182;36571;3187.505936579834;3195.5206718992104;3225.8870939517005;3281.343731253735;3391.4573668212965;28842.71157288421;29053;29672.40655186906;29700.257493562618;29994.850025749733;3913.5303763548272;4018.1963607278662;4054.209429161315;4055.9188816223805;4077.4903137107863;249036;255388;255811;256035;256216;56344;56703.43296566982;56725.14912276319;56740.71629641826;56818;55014;56125.71937140288;56160.15759763607;56222;61250;13191.736165276641;14660;14922.328495217742;14924.626884327761;14931;10736.838947415796;10879;10879.782404351869;10880.455977201267;10896.891031089746;17783.19975601101;18108.185131669106;18995.525111872314;19141.277285044413;19369.709454358195;7363.595002274927;7585.886211706828;7585.962070189724;7670.884936725954;7781.377489800802;936.8032713130183;1019.8883217293038;1022.892596277395;1041.557338131291;1049.2550289294686;26670.599941000513;26901.490806774553;26947;27238.182854514398;27326.5901011485;1030.907218350337;1059.957601695939;1090.4057288777635;1133.3596517967487;1189.102227817992;14729.55811325662;15853;16053.598660033593;16301.184940753152;16847.915760421365;352415;356755;357388;357909;358356;53111.46888531065;53678.7316063425;53703.46296536984;53706;53749.1937620936;1300.5838131797923;1323.7087840675035;1328.0968941119938;1334.4528743215042;1340.8189894364332;26847.731522684524;28326.858365708038;29098.854505727337;31081.689183108785;31589;46376;47141.29288060613;47155.292670609284;47162.52837471581;47196.7640161797;272443;274437;274578;274918;276735;30370.240743980692;30910.69089309168;31098.68901310958;40727.13863571772;41526;38572.2285554293;39411.60588394079;44131.55868441275;45162.32256516089;45165.774171128935;32772;33114.834425827714;33216.66783332136;33218.50172247466;37295.25409491741;32358.676413235567;33265.83367083149;34842.65157348495;35132.47301290432;36125;32990.67009329876;33459.1635209112;36807.63192368149;37456.625433745314;37461.4380784283;26821.597676035264;30316.393672125992;30616;30730.84634576813;30866;23093.63838449394;24492.755072449047;24936.376590584656;24970.62544061804;25169.87415062913 20:08:44 INFO - PROCESS | 23740 | |2;jquery.html;333.2036432925309;333.4997503744382;335.5369589965847;337.4802803682329;341.80517105250016;14273.78589321161;14782;15508.53474395767;15675.29461174247;18012.189451474667;13150.605481835537;14769.483068092619;16342.34630614774;16420.83579164208;16436.917815410907;4235.788210589466;4741.099191153687;4744;4744.928826067612;4747.287906813971;3501.422265326218;3646.4165733482646;4660.37084993525;4690.29645553168;4946.15915294399;5013.172826483626;5049.116404629193;5067.366579177603;5086.618503612225;5094.84715458535;5063.063333283336;5477.397486276506;5917.437843404869;5921.674307913085;5922;4968.826091086795;5121.103806833789;5173.3016042834115;5176.5858731301405;5182.53357197854;18943;19494.12276447549;19572.70640940387;19584.510387240432;19704.507387315287;2025.635385630586;2057.4856285928518;2084.08300347848;2149.3659370485743;2252.6958860553777;8139;8440.366972477088;8441.02928163263;11675.591354302558;12621.873781262162;1768.3545505890258;1785.4822101590523;1787.0796539782023;1788.9373871914552;1801.5406071451696;53462.46537534614;54786.795254450764;55125;55399;55491.44508554903;8804.779880503038;9124.45253284805;9257.398269112486;9264.351495395393;9323.766905827273;11579.247348922294;11608.76782464346;11649.650510484698;11684.357360345093;11724.706882327839;6772.085768421299;6781.423578995742;6786.4910131739325;6823.283555226729;6897.068895699117;6496.447801936793;6511.218653761579;6526.28210896801;6570.8357291068105;6572;3899.980500097481;3923.548791888912;3946.072672921861;3968;3972.860949866799;1472.138798802691;1510.9471168509049;1562.546861410201;1563.234015332479;1582.3196025709055;829.7180855578147;921.6175287255847;960.3104673840978;1011.9696409107738;1052.2897044494935;15256.542303730906;15365;16043;16411.83588164127;16557.503274901774;803.4817542684935;843.4053991935671;867.9392442528963;922.423485321674;924.8335299646128;8851.60167792451;9253.935797383252;9493.240540756722;9624.855627165598;9661.565229564687;139615;140646;141077;141128;365953;62662.686686566274;63309.68345158337;63544.68227658924;68749;74251.62874185595;1077.849101125843;1108.279618248129;1128.041165009735;1129.0459561670375;1139.1797905508022;13767.655808604864;14097.506587269396;14308.284585770461;14551.41794328215;14587.489437869624;28898.566521502617;29371.706282937754;30248.69751302547;30304.696953030187;30576.694233058275;37407.43888841615;38050.42924356192;38601.227975440896;40566.39150412687;40874.18251634891;6423.710933007932;6885.518013739191;6935.063766391674;7133.857322853618;7234.131904171533;9819.312648114563;10471.3193642413;11130.610428634958;11164.609238676607;11415.258008229439;9313.301502387212;9630.133288004114;9712.3201375903;9914.900850991398;10009.399436033862;9992.900070999487;9993.800123997335;10055.832709942244;10080.747981300527;10180.287379883337;7459.627018648937;9166.770830729285;10013.59945602197;10201.234907382124;10279.897201027894;6573.704183311666;6697.866042679022;6784.559003664746;6812.676372899252;6896;8900.465972041698;9165.312601555044;9896.406215627085;9977.95231500711;10168 20:08:44 INFO - PROCESS | 23740 | |3;mootools.html;1303.9022073344502;1414.6534099145708;1432.3411230833815;1548.8606025457714;1712.7430885367194;6697.162854643169;7211.170715367734;7355.3380195782365;7358.22738612446;7362.447816413764;7135.821604459891;7232.421406287497;7237.638118094101;7239.203687594373;7264.745733899302;1921.8366438852715;1969.123739935722;2105.694674272237;2162.50262439639;2178.880161591112;2155.4288113649895;2158.4495953531828;2158.816500597451;2166.393409845246;2167.945801354971;2079.5754907888067;2201.2955854126685;2212.867227966319;2214.1475531920164;2217.5786600545925;2177.5862586108587;2209.326155522565;2216.556688662266;2225.343523660524;2225.643896976492;2176.270949232009;2187.464071302525;2209.7458792238936;2212.081985975818;2213.3359992002333;7584.241575842427;7618.085829700416;7626.1992490788225;7643.197464266227;7666;4524.366588677588;4621.445426548802;4623.676342656016;4625.583697467244;4635.582797548203;2901.8984335548153;2907.1714561349913;2961.540961151025;2965.303153758865;3039.361734035855;895.3508706187962;901.5357091098024;924.3390975452517;935.4901578639658;939.957701903416;10362.585496580203;10365.740856478573;10371.066604005675;10399.220058495568;10405.3756774593;4035.092104276573;4050.10897602527;4094.508658960884;4107.794610269475;4121.4848143982;8920.152585504367;8990.460572365679;9006.324525660602;9013.459192448474;9021;4622.2835460503675;4629.120467111238;4630.467496237909;4640.605548528345;4655.86032419028;4139.00663840676;4141.79291035447;4142.855000074983;4144.088300573869;4147.730397524151;3272.1655977725527;3342.615599206074;3450.896473105811;3495.528103706018;3510.78935263885;1079.2768844873954;1108.3460758152728;1121.52895783771;1121.8878112188715;1126.0934947367448;1049.6168898352046;1281.1096288079696;1324.9470021199045;1347.1782212850153;1351.236551348485;7064.646767661699;7091.9290807091265;7133.072700548999;7148.785536433916;7152.892706609405;1094.1738987064716;1095.3592148593161;1096.7751610919743;1113.3153110836938;1134.7219931116929;5741.425857414225;5768.077107662753;5768.3366412862215;5773.1051686988585;5793.8841223175305;8637.740867773977;9157.862632060524;9272.768180795534;9284.071592840797;9336.4864932428;9204.4477331359;9215.53922303882;9231.123043310874;9233.722988310361;9245.58394872219;6912.205096413876;7098.112735908012;7137.964995075685;7157.4274058075225;7160.140783106061;6942.652867356713;7059.541129826544;7061.964690176516;7067.399271062018;7084;7909.327707144727;8082.15137410587;8193.221643943816;8201.630926608435;8316.37627177952;8443.451175673561;8558.871616925626;8568.400211985101;8584.270337021424;8597;6258.968705156445;6519.8044058678315;6520.9347906520325;6536.901946470902;6543.70553325111;6583.703733331916;6651.534392592472;6974.197967233833;7054.964725176341;7153.0343403639845;6671;6801.5238933274195;6803;6817.216020157745;6961.164660240804;6574.4411725002;6777.762778302736;6780.627065511444;6848.00703897942;6867.553609015398;6953.79138625842;7011.544249623758;7018.859622807618;7019.508634395544;7025.824354391181;6410.45511131559;6434;6488.286288508355;6506.869862602816;6509.251436084911;6424.550281480251;6438.163038804925;6438.452731517874;6439.45264652491;6451.516136289891 20:08:44 INFO - PROCESS | 23740 | |4;prototype.html;278.4597880112583;279.22793476038754;283.9205022593673;285.2583283462995;285.8156489064553;5490.066688662927;5634.915476267859;5759.280089988752;5857.443542863426;5858;5625.156226566017;5757.827265182041;5820.3597604263605;5823.242978412801;5827.096799995997;4445.533219012005;4445.977425192208;4455.576720211575;4457.554244575533;4459.487158976727;4228.640565551932;4281.05816720321;4334.826606935719;4443.466783985927;4454.621357184643;4272.9359059614135;4307.870763877088;4310.892227694301;4321.956780432202;4345.587169218919;4342.870853578061;4348.97825510872;4356.237658409766;4363.80362883671;4371.431713877176;3747.8126093695478;3771.113788259757;3776.3202623527754;3776.6978641708597;3782.9432558511644;5393.406725260218;5496.065668836268;5504.366997795265;5509.201165830972;5511.200875873016;5029.572486338666;5037.715382577456;5039.571636410909;5042.520960508746;5047;6120.785772497986;6123.081537769326;6123.632582045091;6128.877422451526;6129.724162412702;4030.5969403059753;4078.4697989261504;4085.6527195188446;4153.833846646131;4214.115035842477;6417.294097649255;6426.357364263583;6437.38844809747;6451.645159516224;6453.9677301613665;4265.4241677373775;4269.807858646368;4274.294741367639;4280;4283.1433713257475;4326.826926922888;4328.264195086843;4330.2638551446325;4330.328799036154;4336.544662810423;4906.435759887588;5032.446430892599;5037.496250374933;5045.772940217626;5053.343065401547;6087.4521293083835;6178.443940045418;6180.7947450246775;6190;6201.720922558406;1488.5683151885833;1510.041123886318;1512.5008747113427;1513.160196091158;1513.2887542854842;971.3783178765595;971.8421272435169;978.1148061004802;994.6121012805012;1000.0199804191788;5826.796062137805;5844.532437404998;5848.093545500455;5850.3564607893095;5851.707414629337;6347.809565712943;6403.519736019724;6415.133956915756;6415.486761059104;6421.197350331208;5836.358000620014;5842.328132264844;5845.181674565564;5849.298084229919;5854.4730974212525;3284.244623736506;3414;3420.81185534793;3428.023013441157;3432.3650124727005;6641;6641.435477984425;6643.003549467522;6644.534882558271;6649;6484.773032943825;6503.349665033459;6511.674416279167;6513.316101809337;6513.641749703717;6407.551471396958;6596.670166491656;6606.636634985122;6606.900896486556;6630.569013014235;6376.585521941059;6376.617402955838;6399.04014397844;6407.263164736115;6408.679566021773;6061.909071363845;6172.475339596184;6228.657423841732;6279.215098112736;6364.522660800366;6670.966000269966;6681.29846366144;6686.197656281083;6699.39705426514;6718.56329338611;4273.529911709647;4275.187714334266;4277.165952639206;4278.593533614302;4280.122574872082;6245.656488893154;6380.840478987877;6409.679516024087;6419;6420.133282006869;6199.628022318675;6206.255249370104;6208.192934918432;6210.844728881814;6212.534059945432;6225.28409232944;6233.096201050913;6237.812865614039;6240.251169859646;6242.5942313751275;5961.225040744849;6108.541859360655;6111.174991376108;6121.816345509642;6126.785562505291;6236.345183755821;6244.843878903063;6247.812915546032;6252.499800015897;6253.656048917172;6050.213472248755;6105.5420843437805;6111.1444397785235;6111.449969502588;6114.838180745644 20:08:44 INFO - PROCESS | 23740 | |5;yui.html;767.9923200767994;769.6959700918137;784.6704384158653;792.4215322814345;842.3219308456692;12533.937330313358;12705.174163679354;12716.682082947931;12746.80879786804;12750.744985100293;11751.706207344821;12581.811272830915;12674.4930202792;12828.67928301793;12889.548865789699;775.0234704272601;791.2759824760337;791.3985371117934;791.7268542352879;793.6864938349348;779.9298063174314;784.7214238945178;786.2844811221789;786.6381464526296;786.9763907082797;820.979475513111;821.4208982667205;827.7392621324263;829.2868133405267;829.3945419843518;822.366777581259;825.5707032343148;826.6734639817269;827.1769589258696;827.3091968206525;604.8336707405455;608.0150156746056;608.4919092557719;608.6074481959156;609.232367217305;11666.475008624633;11701.122415818763;11717.824232636518;11735.295882247006;11764.058875290042;10829.512671929704;10959;10991.395473248967;11181.32912025281;11341.489632966537;9809.803803923953;9835.90164098357;9882.160016398615;9930.404175749405;10000.149987251092;3410.198603328216;3510.9648903511147;3553.4847447120283;3559.359315323241;3569.1077230692326;44898.55101448976;47677.284840727414;47717.284240736415;47808.760956194994;47809;9170.724878253663;9324;9531.761705957406;9627;9741.9025809741;16048.27782749779;16053.678926421406;16063.919680401523;16074.276657550437;16090.517284481484;7131.8573628528175;7158.677859496335;7163.89254161188;7173.282671732785;7232.602206878567;4027.2549578328103;4059.8579049733116;4088.7546747195265;4095.058136628592;4133.379993001074;2851.7148285171315;2872.8707208175683;2885.0190935082173;2886.076455534209;2891.1760148357616;506.2558039681662;524.6878107526015;540.1384791257938;542.251692664121;544.27067729243;540.8884741855446;545.8335207761671;562.4853259267725;565.1184152721768;615.187951903483;7563.621818909032;7731.381489480828;7770.106437759617;7945;7962.402819788539;551.878586710923;600.753690986702;608.6378604730179;618.1253526260381;620.3796203796204;3795.867144649924;3821.9617803821607;3986.920261594752;4194.895127621773;4221.6833737469815;48716;49069.26396104061;49168;49317;49387.25919111216;47271.27924340468;49987.50012499828;50244.24633630498;50296.74851625718;50378.24432633514;38540.22919541594;39150.6084939147;44372.77813610911;44548.3317750234;48438;7930.920690793018;8105.513669179868;8382.774548060863;8596.441231319945;8665.43674661145;31520.527192092595;33055.00834974954;34012.65987340194;34014.829925850216;34044.1488962768;37871.81064094772;38490;42888.78555607202;43343;47294.76352618215;10862;10888.61889833852;11038.227324087236;11310.773784524428;11347.319160850375;11860.975114723706;11871.169018168644;11987.880121198676;12446.190997585129;12665.366731663196;11294.94352528232;11326.150538709795;11373.14701397382;11458.484368203284;11568.768624627628;10596.31123976939;10814.513346899566;10840.837387439036;11175.050120739828;11278.154138439813;10535.736606584896;10659.840102398626;10743.677689669323;10804.297720648132;10838.783224335311;8886.555672216235;9025.954870225607;9028.232600228792;9305.953470232605;9356.672516461891;8501.659933602834;8825.558722063743;9258.675946341846;9397.765055873659;9806.901930980885 20:08:44 INFO - PROCESS | 23740 | __end_tp_report 20:08:44 INFO - PROCESS | 23740 | __start_cc_report 20:08:44 INFO - PROCESS | 23740 | _x_x_mozilla_cycle_collect,963 20:08:44 INFO - PROCESS | 23740 | __end_cc_report 20:08:44 INFO - PROCESS | 23740 | __startTimestamp1453781324860__endTimestamp 20:08:44 INFO - PROCESS | 23740 | 20:08:44 INFO - PROCESS | 23740 | ------- Summary: start ------- 20:08:44 INFO - PROCESS | 23740 | Number of tests: 6 20:08:44 INFO - PROCESS | 23740 | 20:08:44 INFO - PROCESS | 23740 | [#0] dojo.html Cycles:165 Average:4957.54 Median:5140.07 stddev:511.75 (10.0%) stddev-sans-first:490.85 20:08:44 INFO - PROCESS | 23740 | Values: 3045.6 3100.3 3131.2 3143.3 3164.1 4809.8 4883.9 4935.7 4950.3 5006.2 4891.1 4922.9 4938.9 4955.6 5006.8 4544.6 4549.4 4602.6 4627.5 4643.5 4597.4 4638.5 4665.8 4667.4 4670.9 4434.2 4469.5 4520.6 4572.5 4598.1 4542.0 4549.0 4570.4 4580.8 4607.5 4518.6 4524.3 4536.5 4555.7 4599.1 4757.9 4840.7 4843.0 4899.8 4932.8 5321.8 5344.0 5355.0 5355.4 5369.9 5152.8 5373.9 5396.8 5426.7 5449.6 4966.5 5049.2 5053.6 5131.1 5140.1 5332.1 5337.5 5344.7 5352.3 5386.5 5115.5 5146.6 5155.3 5155.4 5200.9 5290.2 5317.5 5329.4 5406.1 5451.5 5294.2 5309.5 5320.5 5323.0 5325.0 5196.6 5302.5 5304.2 5308.1 5352.7 4121.1 4172.2 4178.9 4248.8 4262.5 3770.6 3773.5 3782.5 3800.7 3803.7 4962.0 4965.1 4965.4 4968.0 5003.2 5219.6 5272.2 5301.7 5305.8 5357.4 4934.2 4956.0 4961.1 4970.1 5012.5 4521.0 4603.4 4617.7 4635.2 4661.1 5462.3 5489.5 5538.4 5560.8 5573.0 5300.2 5305.7 5307.2 5310.6 5350.4 5540.9 5567.6 5568.6 5573.4 5620.5 5185.7 5224.5 5257.4 5279.0 5331.6 5305.1 5309.1 5313.7 5318.1 5319.5 5097.4 5157.3 5200.9 5212.5 5238.8 5139.1 5176.1 5202.5 5220.3 5266.8 5134.7 5142.9 5159.3 5167.5 5211.5 5120.2 5148.7 5239.7 5257.1 5265.9 4959.2 5080.9 5096.7 5141.7 5146.4 20:08:44 INFO - PROCESS | 23740 | 20:08:44 INFO - PROCESS | 23740 | [#1] ext.html Cycles:180 Average:45862.19 Median:196215.82 stddev:78230.06 (39.9%) stddev-sans-first:78375.48 20:08:44 INFO - PROCESS | 23740 | Values: 531.7 539.0 542.7 559.7 571.6 27508.9 28177.9 35676.6 36256.9 36454.5 38304.8 38555.0 38797.0 38854.4 38941.4 8346.7 8536.7 8542.0 8549.7 8555.0 8293.3 8341.2 8378.4 8439.6 8441.0 8609.7 8640.4 8681.4 8705.5 8715.8 8544.1 8606.4 8607.5 8620.7 8640.5 8468.9 8615.9 8619.2 8623.9 8630.0 36090.3 36394.3 36503.8 36529.3 36571.0 3187.5 3195.5 3225.9 3281.3 3391.5 28842.7 29053.0 29672.4 29700.3 29994.9 3913.5 4018.2 4054.2 4055.9 4077.5 249036.0 255388.0 255811.0 256035.0 256216.0 56344.0 56703.4 56725.1 56740.7 56818.0 55014.0 56125.7 56160.2 56222.0 61250.0 13191.7 14660.0 14922.3 14924.6 14931.0 10736.8 10879.0 10879.8 10880.5 10896.9 17783.2 18108.2 18995.5 19141.3 19369.7 7363.6 7585.9 7586.0 7670.9 7781.4 936.8 1019.9 1022.9 1041.6 1049.3 26670.6 26901.5 26947.0 27238.2 27326.6 1030.9 1060.0 1090.4 1133.4 1189.1 14729.6 15853.0 16053.6 16301.2 16847.9 352415.0 356755.0 357388.0 357909.0 358356.0 53111.5 53678.7 53703.5 53706.0 53749.2 1300.6 1323.7 1328.1 1334.5 1340.8 26847.7 28326.9 29098.9 31081.7 31589.0 46376.0 47141.3 47155.3 47162.5 47196.8 272443.0 274437.0 274578.0 274918.0 276735.0 30370.2 30910.7 31098.7 40727.1 41526.0 38572.2 39411.6 44131.6 45162.3 45165.8 32772.0 33114.8 33216.7 33218.5 37295.3 32358.7 33265.8 34842.7 35132.5 36125.0 32990.7 33459.2 36807.6 37456.6 37461.4 26821.6 30316.4 30616.0 30730.8 30866.0 23093.6 24492.8 24936.4 24970.6 25169.9 20:08:44 INFO - PROCESS | 23740 | 20:08:44 INFO - PROCESS | 23740 | [#2] jquery.html Cycles:180 Average:16968.71 Median:22269.63 stddev:35325.73 (158.6%) stddev-sans-first:35402.75 20:08:44 INFO - PROCESS | 23740 | Values: 333.2 333.5 335.5 337.5 341.8 14273.8 14782.0 15508.5 15675.3 18012.2 13150.6 14769.5 16342.3 16420.8 16436.9 4235.8 4741.1 4744.0 4744.9 4747.3 3501.4 3646.4 4660.4 4690.3 4946.2 5013.2 5049.1 5067.4 5086.6 5094.8 5063.1 5477.4 5917.4 5921.7 5922.0 4968.8 5121.1 5173.3 5176.6 5182.5 18943.0 19494.1 19572.7 19584.5 19704.5 2025.6 2057.5 2084.1 2149.4 2252.7 8139.0 8440.4 8441.0 11675.6 12621.9 1768.4 1785.5 1787.1 1788.9 1801.5 53462.5 54786.8 55125.0 55399.0 55491.4 8804.8 9124.5 9257.4 9264.4 9323.8 11579.2 11608.8 11649.7 11684.4 11724.7 6772.1 6781.4 6786.5 6823.3 6897.1 6496.4 6511.2 6526.3 6570.8 6572.0 3900.0 3923.5 3946.1 3968.0 3972.9 1472.1 1510.9 1562.5 1563.2 1582.3 829.7 921.6 960.3 1012.0 1052.3 15256.5 15365.0 16043.0 16411.8 16557.5 803.5 843.4 867.9 922.4 924.8 8851.6 9253.9 9493.2 9624.9 9661.6 139615.0 140646.0 141077.0 141128.0 365953.0 62662.7 63309.7 63544.7 68749.0 74251.6 1077.8 1108.3 1128.0 1129.0 1139.2 13767.7 14097.5 14308.3 14551.4 14587.5 28898.6 29371.7 30248.7 30304.7 30576.7 37407.4 38050.4 38601.2 40566.4 40874.2 6423.7 6885.5 6935.1 7133.9 7234.1 9819.3 10471.3 11130.6 11164.6 11415.3 9313.3 9630.1 9712.3 9914.9 10009.4 9992.9 9993.8 10055.8 10080.7 10180.3 7459.6 9166.8 10013.6 10201.2 10279.9 6573.7 6697.9 6784.6 6812.7 6896.0 8900.5 9165.3 9896.4 9978.0 10168.0 20:08:44 INFO - PROCESS | 23740 | 20:08:44 INFO - PROCESS | 23740 | [#3] mootools.html Cycles:180 Average:5302.83 Median:6438.95 stddev:2756.41 (42.8%) stddev-sans-first:2747.75 20:08:44 INFO - PROCESS | 23740 | Values: 1303.9 1414.7 1432.3 1548.9 1712.7 6697.2 7211.2 7355.3 7358.2 7362.4 7135.8 7232.4 7237.6 7239.2 7264.7 1921.8 1969.1 2105.7 2162.5 2178.9 2155.4 2158.4 2158.8 2166.4 2167.9 2079.6 2201.3 2212.9 2214.1 2217.6 2177.6 2209.3 2216.6 2225.3 2225.6 2176.3 2187.5 2209.7 2212.1 2213.3 7584.2 7618.1 7626.2 7643.2 7666.0 4524.4 4621.4 4623.7 4625.6 4635.6 2901.9 2907.2 2961.5 2965.3 3039.4 895.4 901.5 924.3 935.5 940.0 10362.6 10365.7 10371.1 10399.2 10405.4 4035.1 4050.1 4094.5 4107.8 4121.5 8920.2 8990.5 9006.3 9013.5 9021.0 4622.3 4629.1 4630.5 4640.6 4655.9 4139.0 4141.8 4142.9 4144.1 4147.7 3272.2 3342.6 3450.9 3495.5 3510.8 1079.3 1108.3 1121.5 1121.9 1126.1 1049.6 1281.1 1324.9 1347.2 1351.2 7064.6 7091.9 7133.1 7148.8 7152.9 1094.2 1095.4 1096.8 1113.3 1134.7 5741.4 5768.1 5768.3 5773.1 5793.9 8637.7 9157.9 9272.8 9284.1 9336.5 9204.4 9215.5 9231.1 9233.7 9245.6 6912.2 7098.1 7138.0 7157.4 7160.1 6942.7 7059.5 7062.0 7067.4 7084.0 7909.3 8082.2 8193.2 8201.6 8316.4 8443.5 8558.9 8568.4 8584.3 8597.0 6259.0 6519.8 6520.9 6536.9 6543.7 6583.7 6651.5 6974.2 7055.0 7153.0 6671.0 6801.5 6803.0 6817.2 6961.2 6574.4 6777.8 6780.6 6848.0 6867.6 6953.8 7011.5 7018.9 7019.5 7025.8 6410.5 6434.0 6488.3 6506.9 6509.3 6424.6 6438.2 6438.5 6439.5 6451.5 20:08:44 INFO - PROCESS | 23740 | 20:08:44 INFO - PROCESS | 23740 | [#4] prototype.html Cycles:180 Average:5125.78 Median:5849.83 stddev:1585.99 (27.1%) stddev-sans-first:1548.14 20:08:44 INFO - PROCESS | 23740 | Values: 278.5 279.2 283.9 285.3 285.8 5490.1 5634.9 5759.3 5857.4 5858.0 5625.2 5757.8 5820.4 5823.2 5827.1 4445.5 4446.0 4455.6 4457.6 4459.5 4228.6 4281.1 4334.8 4443.5 4454.6 4272.9 4307.9 4310.9 4322.0 4345.6 4342.9 4349.0 4356.2 4363.8 4371.4 3747.8 3771.1 3776.3 3776.7 3782.9 5393.4 5496.1 5504.4 5509.2 5511.2 5029.6 5037.7 5039.6 5042.5 5047.0 6120.8 6123.1 6123.6 6128.9 6129.7 4030.6 4078.5 4085.7 4153.8 4214.1 6417.3 6426.4 6437.4 6451.6 6454.0 4265.4 4269.8 4274.3 4280.0 4283.1 4326.8 4328.3 4330.3 4330.3 4336.5 4906.4 5032.4 5037.5 5045.8 5053.3 6087.5 6178.4 6180.8 6190.0 6201.7 1488.6 1510.0 1512.5 1513.2 1513.3 971.4 971.8 978.1 994.6 1000.0 5826.8 5844.5 5848.1 5850.4 5851.7 6347.8 6403.5 6415.1 6415.5 6421.2 5836.4 5842.3 5845.2 5849.3 5854.5 3284.2 3414.0 3420.8 3428.0 3432.4 6641.0 6641.4 6643.0 6644.5 6649.0 6484.8 6503.3 6511.7 6513.3 6513.6 6407.6 6596.7 6606.6 6606.9 6630.6 6376.6 6376.6 6399.0 6407.3 6408.7 6061.9 6172.5 6228.7 6279.2 6364.5 6671.0 6681.3 6686.2 6699.4 6718.6 4273.5 4275.2 4277.2 4278.6 4280.1 6245.7 6380.8 6409.7 6419.0 6420.1 6199.6 6206.3 6208.2 6210.8 6212.5 6225.3 6233.1 6237.8 6240.3 6242.6 5961.2 6108.5 6111.2 6121.8 6126.8 6236.3 6244.8 6247.8 6252.5 6253.7 6050.2 6105.5 6111.1 6111.4 6114.8 20:08:44 INFO - PROCESS | 23740 | 20:08:44 INFO - PROCESS | 23740 | [#5] yui.html Cycles:180 Average:12956.13 Median:48123.50 stddev:14836.21 (30.8%) stddev-sans-first:14849.59 20:08:44 INFO - PROCESS | 23740 | Values: 768.0 769.7 784.7 792.4 842.3 12533.9 12705.2 12716.7 12746.8 12750.7 11751.7 12581.8 12674.5 12828.7 12889.5 775.0 791.3 791.4 791.7 793.7 779.9 784.7 786.3 786.6 787.0 821.0 821.4 827.7 829.3 829.4 822.4 825.6 826.7 827.2 827.3 604.8 608.0 608.5 608.6 609.2 11666.5 11701.1 11717.8 11735.3 11764.1 10829.5 10959.0 10991.4 11181.3 11341.5 9809.8 9835.9 9882.2 9930.4 10000.1 3410.2 3511.0 3553.5 3559.4 3569.1 44898.6 47677.3 47717.3 47808.8 47809.0 9170.7 9324.0 9531.8 9627.0 9741.9 16048.3 16053.7 16063.9 16074.3 16090.5 7131.9 7158.7 7163.9 7173.3 7232.6 4027.3 4059.9 4088.8 4095.1 4133.4 2851.7 2872.9 2885.0 2886.1 2891.2 506.3 524.7 540.1 542.3 544.3 540.9 545.8 562.5 565.1 615.2 7563.6 7731.4 7770.1 7945.0 7962.4 551.9 600.8 608.6 618.1 620.4 3795.9 3822.0 3986.9 4194.9 4221.7 48716.0 49069.3 49168.0 49317.0 49387.3 47271.3 49987.5 50244.2 50296.7 50378.2 38540.2 39150.6 44372.8 44548.3 48438.0 7930.9 8105.5 8382.8 8596.4 8665.4 31520.5 33055.0 34012.7 34014.8 34044.1 37871.8 38490.0 42888.8 43343.0 47294.8 10862.0 10888.6 11038.2 11310.8 11347.3 11861.0 11871.2 11987.9 12446.2 12665.4 11294.9 11326.2 11373.1 11458.5 11568.8 10596.3 10814.5 10840.8 11175.1 11278.2 10535.7 10659.8 10743.7 10804.3 10838.8 8886.6 9026.0 9028.2 9306.0 9356.7 8501.7 8825.6 9258.7 9397.8 9806.9 20:08:44 INFO - PROCESS | 23740 | -------- Summary: end -------- 20:08:44 INFO - PROCESS | 23740 | 20:08:45 INFO - TEST-INFO | 23740: exit 0 20:08:45 INFO - TEST-OK | dromaeo_css | took 1113362ms 20:08:45 INFO - TEST-START | kraken 20:08:45 INFO - operating with platform_type : linux_ 20:08:45 INFO - Initialising browser for kraken test... 20:08:45 INFO - TEST-INFO | started process 23938 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0apWGP/profile http://localhost:48215/getInfo.html) 20:08:49 INFO - PROCESS | 23938 | __metrics Screen width/height:1600/1200 20:08:49 INFO - PROCESS | 23938 | colorDepth:24 20:08:49 INFO - PROCESS | 23938 | Browser inner width/height: 1024/697 20:08:49 INFO - PROCESS | 23938 | __metrics 20:08:50 INFO - PROCESS | 23938 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:08:50 INFO - PROCESS | 23938 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:08:50 INFO - TEST-INFO | 23938: exit 0 20:08:50 INFO - Browser initialized. 20:08:50 INFO - Running cycle 1/1 for kraken test... 20:08:50 INFO - TEST-INFO | started process 24020 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0apWGP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:02 INFO - PROCESS | 24020 | RSS: Main: 148783104 20:09:02 INFO - PROCESS | 24020 | 20:09:05 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48215/tests/kraken/driver.html?testName=audio-beat-detection) 20:09:05 INFO - PROCESS | 24020 | RSS: Main: 188801024 20:09:05 INFO - PROCESS | 24020 | 20:09:08 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48215/tests/kraken/driver.html?testName=audio-dft) 20:09:09 INFO - PROCESS | 24020 | RSS: Main: 178475008 20:09:09 INFO - PROCESS | 24020 | 20:09:11 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48215/tests/kraken/driver.html?testName=audio-fft) 20:09:12 INFO - PROCESS | 24020 | RSS: Main: 163282944 20:09:12 INFO - PROCESS | 24020 | 20:09:14 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48215/tests/kraken/driver.html?testName=audio-oscillator) 20:09:15 INFO - PROCESS | 24020 | RSS: Main: 166363136 20:09:15 INFO - PROCESS | 24020 | 20:09:17 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48215/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:09:17 INFO - PROCESS | 24020 | RSS: Main: 167653376 20:09:17 INFO - PROCESS | 24020 | 20:09:20 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48215/tests/kraken/driver.html?testName=imaging-darkroom) 20:09:21 INFO - PROCESS | 24020 | RSS: Main: 167251968 20:09:21 INFO - PROCESS | 24020 | 20:09:24 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48215/tests/kraken/driver.html?testName=imaging-desaturate) 20:09:25 INFO - PROCESS | 24020 | RSS: Main: 168873984 20:09:25 INFO - PROCESS | 24020 | 20:09:28 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48215/tests/kraken/driver.html?testName=json-parse-financial) 20:09:28 INFO - PROCESS | 24020 | RSS: Main: 167837696 20:09:28 INFO - PROCESS | 24020 | 20:09:30 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48215/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:09:30 INFO - PROCESS | 24020 | RSS: Main: 179531776 20:09:30 INFO - PROCESS | 24020 | 20:09:32 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48215/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:09:33 INFO - PROCESS | 24020 | RSS: Main: 177963008 20:09:33 INFO - PROCESS | 24020 | 20:09:35 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48215/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:09:35 INFO - PROCESS | 24020 | RSS: Main: 188260352 20:09:35 INFO - PROCESS | 24020 | 20:09:38 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:09:38 INFO - PROCESS | 24020 | RSS: Main: 197353472 20:09:38 INFO - PROCESS | 24020 | 20:09:41 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:09:42 INFO - PROCESS | 24020 | RSS: Main: 197058560 20:09:42 INFO - PROCESS | 24020 | 20:09:43 INFO - PROCESS | 24020 | Cycle 1(1): loaded http://localhost:48215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48215/tests/kraken/driver.html?testName=ai-astar) 20:09:44 INFO - PROCESS | 24020 | RSS: Main: 257134592 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | __start_tp_report 20:09:44 INFO - PROCESS | 24020 | _x_x_mozilla_page_load 20:09:44 INFO - PROCESS | 24020 | _x_x_mozilla_page_load_details 20:09:44 INFO - PROCESS | 24020 | |i|pagename|runs| 20:09:44 INFO - PROCESS | 24020 | |0;ai-astar;113;112;109;110;113;112;113;113;105;112 20:09:44 INFO - PROCESS | 24020 | |1;audio-beat-detection;154;124;157;171;126;158;155;130;169;125 20:09:44 INFO - PROCESS | 24020 | |2;audio-dft;162;163;160;167;162;163;166;163;164;161 20:09:44 INFO - PROCESS | 24020 | |3;audio-fft;74;74;93;98;73;74;77;118;97;75 20:09:44 INFO - PROCESS | 24020 | |4;audio-oscillator;97;97;146;96;97;96;155;96;97;137 20:09:44 INFO - PROCESS | 24020 | |5;imaging-gaussian-blur;119;115;115;115;114;115;115;116;115;115 20:09:44 INFO - PROCESS | 24020 | |6;imaging-darkroom;145;145;146;146;146;147;146;146;145;146 20:09:44 INFO - PROCESS | 24020 | |7;imaging-desaturate;96;95;95;96;96;96;95;96;95;96 20:09:44 INFO - PROCESS | 24020 | |8;json-parse-financial;56;57;58;56;56;59;56;57;56;54 20:09:44 INFO - PROCESS | 24020 | |9;json-stringify-tinderbox;68;70;69;68;69;70;69;68;70;68 20:09:44 INFO - PROCESS | 24020 | |10;stanford-crypto-aes;84;84;82;97;84;83;86;85;92;86 20:09:44 INFO - PROCESS | 24020 | |11;stanford-crypto-ccm;131;121;119;115;118;115;118;118;116;123 20:09:44 INFO - PROCESS | 24020 | |12;stanford-crypto-pbkdf2;146;139;141;142;146;131;152;141;155;141 20:09:44 INFO - PROCESS | 24020 | |13;stanford-crypto-sha256-iterative;72;71;68;66;68;68;69;70;67;68 20:09:44 INFO - PROCESS | 24020 | __end_tp_report 20:09:44 INFO - PROCESS | 24020 | __start_cc_report 20:09:44 INFO - PROCESS | 24020 | _x_x_mozilla_cycle_collect,941 20:09:44 INFO - PROCESS | 24020 | __end_cc_report 20:09:44 INFO - PROCESS | 24020 | __startTimestamp1453781384045__endTimestamp 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | ------- Summary: start ------- 20:09:44 INFO - PROCESS | 24020 | Number of tests: 14 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.50 stddev:2.57 (2.3%) stddev-sans-first:2.65 20:09:44 INFO - PROCESS | 24020 | Values: 113.0 112.0 109.0 110.0 113.0 112.0 113.0 113.0 105.0 112.0 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:156.00 stddev:18.67 (12.0%) stddev-sans-first:19.62 20:09:44 INFO - PROCESS | 24020 | Values: 154.0 124.0 157.0 171.0 126.0 158.0 155.0 130.0 169.0 125.0 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:2.13 (1.3%) stddev-sans-first:2.22 20:09:44 INFO - PROCESS | 24020 | Values: 162.0 163.0 160.0 167.0 162.0 163.0 166.0 163.0 164.0 161.0 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#3] audio-fft Cycles:10 Average:85.30 Median:76.00 stddev:15.41 (20.3%) stddev-sans-first:15.79 20:09:44 INFO - PROCESS | 24020 | Values: 74.0 74.0 93.0 98.0 73.0 74.0 77.0 118.0 97.0 75.0 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#4] audio-oscillator Cycles:10 Average:111.40 Median:96.50 stddev:24.25 (25.1%) stddev-sans-first:25.16 20:09:44 INFO - PROCESS | 24020 | Values: 97.0 97.0 146.0 96.0 97.0 96.0 155.0 96.0 97.0 137.0 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:0.50 20:09:44 INFO - PROCESS | 24020 | Values: 119.0 115.0 115.0 115.0 114.0 115.0 115.0 116.0 115.0 115.0 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 20:09:44 INFO - PROCESS | 24020 | Values: 145.0 145.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 146.0 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:09:44 INFO - PROCESS | 24020 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.50 stddev:1.35 (2.4%) stddev-sans-first:1.42 20:09:44 INFO - PROCESS | 24020 | Values: 56.0 57.0 58.0 56.0 56.0 59.0 56.0 57.0 56.0 54.0 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 20:09:44 INFO - PROCESS | 24020 | Values: 68.0 70.0 69.0 68.0 69.0 70.0 69.0 68.0 70.0 68.0 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:85.50 stddev:4.64 (5.4%) stddev-sans-first:4.85 20:09:44 INFO - PROCESS | 24020 | Values: 84.0 84.0 82.0 97.0 84.0 83.0 86.0 85.0 92.0 86.0 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:118.50 stddev:4.79 (4.0%) stddev-sans-first:2.67 20:09:44 INFO - PROCESS | 24020 | Values: 131.0 121.0 119.0 115.0 118.0 115.0 118.0 118.0 116.0 123.0 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.40 Median:144.00 stddev:6.79 (4.7%) stddev-sans-first:7.13 20:09:44 INFO - PROCESS | 24020 | Values: 146.0 139.0 141.0 142.0 146.0 131.0 152.0 141.0 155.0 141.0 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - PROCESS | 24020 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:1.83 (2.7%) stddev-sans-first:1.50 20:09:44 INFO - PROCESS | 24020 | Values: 72.0 71.0 68.0 66.0 68.0 68.0 69.0 70.0 67.0 68.0 20:09:44 INFO - PROCESS | 24020 | -------- Summary: end -------- 20:09:44 INFO - PROCESS | 24020 | 20:09:44 INFO - TEST-INFO | 24020: exit 0 20:09:45 INFO - TEST-OK | kraken | took 59421ms 20:09:45 INFO - TEST-START | v8_7 20:09:45 INFO - operating with platform_type : linux_ 20:09:45 INFO - Initialising browser for v8_7 test... 20:09:45 INFO - TEST-INFO | started process 24271 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdc7Pcm/profile http://localhost:48215/getInfo.html) 20:09:49 INFO - PROCESS | 24271 | __metrics Screen width/height:1600/1200 20:09:49 INFO - PROCESS | 24271 | colorDepth:24 20:09:49 INFO - PROCESS | 24271 | Browser inner width/height: 1024/697 20:09:49 INFO - PROCESS | 24271 | __metrics 20:09:49 INFO - PROCESS | 24271 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:09:49 INFO - PROCESS | 24271 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:09:50 INFO - TEST-INFO | 24271: exit 0 20:09:50 INFO - Browser initialized. 20:09:50 INFO - Running cycle 1/1 for v8_7 test... 20:09:50 INFO - TEST-INFO | started process 24353 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdc7Pcm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:02 INFO - PROCESS | 24353 | RSS: Main: 148340736 20:10:02 INFO - PROCESS | 24353 | 20:10:24 INFO - PROCESS | 24353 | Cycle 1(1): loaded http://localhost:48215/tests/v8_7/run.html (next: http://localhost:48215/tests/v8_7/run.html) 20:10:25 INFO - PROCESS | 24353 | RSS: Main: 636850176 20:10:25 INFO - PROCESS | 24353 | 20:10:25 INFO - PROCESS | 24353 | __start_tp_report 20:10:25 INFO - PROCESS | 24353 | _x_x_mozilla_page_load 20:10:25 INFO - PROCESS | 24353 | _x_x_mozilla_page_load_details 20:10:25 INFO - PROCESS | 24353 | |i|pagename|runs| 20:10:25 INFO - PROCESS | 24353 | |0;Richards;166.19577862722286 20:10:25 INFO - PROCESS | 24353 | |1;DeltaBlue;188.89308651303364 20:10:25 INFO - PROCESS | 24353 | |2;Encrypt;273.7476047084588 20:10:25 INFO - PROCESS | 24353 | |3;Decrypt;5319.148936170212 20:10:25 INFO - PROCESS | 24353 | |4;RayTrace;1974.3589743589744 20:10:25 INFO - PROCESS | 24353 | |5;Earley;770.4160246533128 20:10:25 INFO - PROCESS | 24353 | |6;Boyer;12382.716049382716 20:10:25 INFO - PROCESS | 24353 | |7;RegExp;41959.183673469386 20:10:25 INFO - PROCESS | 24353 | |8;Splay;631.5461346633416 20:10:25 INFO - PROCESS | 24353 | |9;NavierStokes;4826.923076923077 20:10:25 INFO - PROCESS | 24353 | __end_tp_report 20:10:25 INFO - PROCESS | 24353 | __startTimestamp1453781425041__endTimestamp 20:10:25 INFO - PROCESS | 24353 | 20:10:25 INFO - PROCESS | 24353 | ------- Summary: start ------- 20:10:25 INFO - PROCESS | 24353 | Number of tests: 10 20:10:25 INFO - PROCESS | 24353 | 20:10:25 INFO - PROCESS | 24353 | [#0] Richards Cycles:1 Average:166.20 Median:166.20 stddev:0.00 (0.0%) 20:10:25 INFO - PROCESS | 24353 | Values: 166.2 20:10:25 INFO - PROCESS | 24353 | 20:10:25 INFO - PROCESS | 24353 | [#1] DeltaBlue Cycles:1 Average:188.89 Median:188.89 stddev:0.00 (0.0%) 20:10:25 INFO - PROCESS | 24353 | Values: 188.9 20:10:25 INFO - PROCESS | 24353 | 20:10:25 INFO - PROCESS | 24353 | [#2] Encrypt Cycles:1 Average:273.75 Median:273.75 stddev:0.00 (0.0%) 20:10:25 INFO - PROCESS | 24353 | Values: 273.7 20:10:25 INFO - PROCESS | 24353 | 20:10:25 INFO - PROCESS | 24353 | [#3] Decrypt Cycles:1 Average:5319.15 Median:5319.15 stddev:0.00 (0.0%) 20:10:25 INFO - PROCESS | 24353 | Values: 5319.1 20:10:25 INFO - PROCESS | 24353 | 20:10:25 INFO - PROCESS | 24353 | [#4] RayTrace Cycles:1 Average:1974.36 Median:1974.36 stddev:0.00 (0.0%) 20:10:25 INFO - PROCESS | 24353 | Values: 1974.4 20:10:25 INFO - PROCESS | 24353 | 20:10:25 INFO - PROCESS | 24353 | [#5] Earley Cycles:1 Average:770.42 Median:770.42 stddev:0.00 (0.0%) 20:10:25 INFO - PROCESS | 24353 | Values: 770.4 20:10:25 INFO - PROCESS | 24353 | 20:10:25 INFO - PROCESS | 24353 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 20:10:25 INFO - PROCESS | 24353 | Values: 12382.7 20:10:25 INFO - PROCESS | 24353 | 20:10:25 INFO - PROCESS | 24353 | [#7] RegExp Cycles:1 Average:41959.18 Median:41959.18 stddev:0.00 (0.0%) 20:10:25 INFO - PROCESS | 24353 | Values: 41959.2 20:10:25 INFO - PROCESS | 24353 | 20:10:25 INFO - PROCESS | 24353 | [#8] Splay Cycles:1 Average:631.55 Median:631.55 stddev:0.00 (0.0%) 20:10:25 INFO - PROCESS | 24353 | Values: 631.5 20:10:25 INFO - PROCESS | 24353 | 20:10:25 INFO - PROCESS | 24353 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 20:10:25 INFO - PROCESS | 24353 | Values: 4826.9 20:10:25 INFO - PROCESS | 24353 | -------- Summary: end -------- 20:10:25 INFO - PROCESS | 24353 | 20:10:25 INFO - TEST-INFO | 24353: exit 0 20:10:25 INFO - TEST-OK | v8_7 | took 40905ms 20:10:25 INFO - SUITE-END | took 1213s 20:10:25 INFO - Completed test suite (00:20:13) 20:10:25 INFO - Working with test: dromaeo_css 20:10:25 INFO - Generating results file: dromaeo_css 20:10:25 INFO - Working with test: kraken 20:10:25 INFO - Generating results file: kraken 20:10:25 INFO - javascript benchmark 20:10:25 INFO - Working with test: v8_7 20:10:25 INFO - Generating results file: v8_7 20:10:25 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:10:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 20:10:26 INFO - process_Request line: dromaeo_css 6563.63 graph.html#tests=[[72,201,35]] 20:10:26 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:10:26 INFO - process_Request line: kraken 1517.90 graph.html#tests=[[232,201,35]] 20:10:26 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:10:26 INFO - process_Request line: v8_7 18874.48 graph.html#tests=[[230,201,35]] 20:10:26 INFO - RETURN: dromaeo_css: 6563.63 20:10:26 INFO - RETURN: kraken: 1517.90 20:10:26 INFO - RETURN: v8_7: 18874.48 20:10:26 INFO - javascript benchmark 20:10:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3045.558394032865, 3100.3024319528095, 3131.2485003599127, 3143.339898621289, 3164.066600352896, 4809.783559739812, 4883.926741098886, 4935.703857768536, 4950.257461380795, 5006.173981293086, 4891.1195984722735, 4922.926156107652, 4938.851834444963, 4955.628327875405, 5006.849794506171, 4544.636429085682, 4549.431321084864, 4602.562756538124, 4627.514111018345, 4643.466001409847, 4597.402337696095, 4638.48976612574, 4665.813367465297, 4667.369905062824, 4670.929936050962, 4434.246178149722, 4469.486009108961, 4520.570545798144, 4572.474165470981, 4598.057398233354, 4541.9545804542195, 4548.977255113737, 4570.428696412949, 4580.8167673293365, 4607.470140933802, 4518.638508919278, 4524.298733696282, 4536.54634536547, 4555.74943378114, 4599.149157405891, 4757.881052973703, 4840.733759643218, 4842.951570484285, 4899.755012249373, 4932.753362331869, 5321.787128514855, 5343.973280133613, 5355.0, 5355.384130824966, 5369.919451208235, 5152.845414637567, 5373.892522149574, 5396.78412863485, 5426.70153141581, 5449.591280653967, 4966.528179822911, 5049.192129259301, 5053.646244762868, 5131.076406246874, 5140.074786538422, 5332.093544097513, 5337.492938170868, 5344.67931924078, 5352.2506849041165, 5386.48828361305, 5115.462876397999, 5146.639735218499, 5155.304033955443, 5155.381354237516, 5200.947990520122, 5290.1800220965815, 5317.494837990384, 5329.387120481194, 5406.053940560386, 5451.48210919962, 5294.179402192666, 5309.548688361455, 5320.547753440924, 5323.0, 5325.0, 5196.636235463481, 5302.469753024744, 5304.230886521433, 5308.0710875596615, 5352.678839269578, 4121.113960498507, 4172.228137794517, 4178.895527611834, 4248.808803603845, 4262.531121576624, 3770.6040865709256, 3773.471713960048, 3782.4893639358884, 3800.657940785343, 3803.657670809585, 4961.975190124099, 4965.1311020571975, 4965.379327584052, 4967.956729086933, 5003.199488081889, 5219.582433405319, 5272.235525848807, 5301.734913254322, 5305.840824775263, 5357.383900851374, 4934.185859333242, 4956.0, 4961.08219979305, 4970.080535100946, 5012.523810238022, 4520.977395113069, 4603.447586289667, 4617.676762626651, 4635.235186194308, 4661.091087237956, 5462.317210348707, 5489.478499542537, 5538.363088244903, 5560.77756889728, 5573.0, 5300.1519756838725, 5305.708186049805, 5307.203919412119, 5310.628256022042, 5350.438203988525, 5540.944590554042, 5567.582431317748, 5568.610197286151, 5573.442655734394, 5620.494155526022, 5185.688858668492, 5224.52979231871, 5257.369115706139, 5278.97360513195, 5331.573474121983, 5305.124654431976, 5309.123994540858, 5313.707746074003, 5318.0959236930585, 5319.521243088141, 5097.413797413196, 5157.303763991963, 5200.895982080413, 5212.50481204285, 5238.76425560843, 5139.074966506065, 5176.094183517794, 5202.453742356998, 5220.295260139985, 5266.815661451831, 5134.666246693953, 5142.948570514247, 5159.251908473326, 5167.457416971164, 5211.452797456364, 5120.206368012964, 5148.736278273317, 5239.685618862881, 5257.080010997984, 5265.868353291045, 4959.156943319572, 5080.872978175427, 5096.694198348111, 5141.742912854417, 5146.356705411824], "unit": "score", "name": "dojo.html", "value": 4927.227366841096}, {"lowerIsBetter": false, "replicates": [531.686305080003, 538.981135660252, 542.7340603104477, 559.6809818403509, 571.6341541413494, 27508.86245568772, 28177.85911070447, 35676.64323356769, 36256.918161956266, 36454.45318320228, 38304.80847595758, 38555.0, 38797.0, 38854.417183742196, 38941.41587876184, 8346.666133354658, 8536.658533658647, 8541.95729021354, 8549.700760473384, 8555.0, 8293.33653307734, 8341.165883411672, 8378.413511054228, 8439.57802109892, 8440.957795211016, 8609.698660546883, 8640.438371505863, 8681.392302538825, 8705.521196334199, 8715.825683486326, 8544.145585441438, 8606.440581362223, 8607.526586037766, 8620.65517379304, 8640.524771137585, 8468.872966905501, 8615.913840861574, 8619.1811777881, 8623.913760862437, 8630.0, 36090.27819443623, 36394.272114557825, 36503.817480912694, 36529.26941461182, 36571.0, 3187.505936579834, 3195.5206718992104, 3225.8870939517005, 3281.343731253735, 3391.4573668212965, 28842.71157288421, 29053.0, 29672.40655186906, 29700.257493562618, 29994.850025749733, 3913.5303763548272, 4018.1963607278662, 4054.209429161315, 4055.9188816223805, 4077.4903137107863, 249036.0, 255388.0, 255811.0, 256035.0, 256216.0, 56344.0, 56703.43296566982, 56725.14912276319, 56740.71629641826, 56818.0, 55014.0, 56125.71937140288, 56160.15759763607, 56222.0, 61250.0, 13191.736165276641, 14660.0, 14922.328495217742, 14924.626884327761, 14931.0, 10736.838947415796, 10879.0, 10879.782404351869, 10880.455977201267, 10896.891031089746, 17783.19975601101, 18108.185131669106, 18995.525111872314, 19141.277285044413, 19369.709454358195, 7363.595002274927, 7585.886211706828, 7585.962070189724, 7670.884936725954, 7781.377489800802, 936.8032713130183, 1019.8883217293038, 1022.892596277395, 1041.557338131291, 1049.2550289294686, 26670.599941000513, 26901.490806774553, 26947.0, 27238.182854514398, 27326.5901011485, 1030.907218350337, 1059.957601695939, 1090.4057288777635, 1133.3596517967487, 1189.102227817992, 14729.55811325662, 15853.0, 16053.598660033593, 16301.184940753152, 16847.915760421365, 352415.0, 356755.0, 357388.0, 357909.0, 358356.0, 53111.46888531065, 53678.7316063425, 53703.46296536984, 53706.0, 53749.1937620936, 1300.5838131797923, 1323.7087840675035, 1328.0968941119938, 1334.4528743215042, 1340.8189894364332, 26847.731522684524, 28326.858365708038, 29098.854505727337, 31081.689183108785, 31589.0, 46376.0, 47141.29288060613, 47155.292670609284, 47162.52837471581, 47196.7640161797, 272443.0, 274437.0, 274578.0, 274918.0, 276735.0, 30370.240743980692, 30910.69089309168, 31098.68901310958, 40727.13863571772, 41526.0, 38572.2285554293, 39411.60588394079, 44131.55868441275, 45162.32256516089, 45165.774171128935, 32772.0, 33114.834425827714, 33216.66783332136, 33218.50172247466, 37295.25409491741, 32358.676413235567, 33265.83367083149, 34842.65157348495, 35132.47301290432, 36125.0, 32990.67009329876, 33459.1635209112, 36807.63192368149, 37456.625433745314, 37461.4380784283, 26821.597676035264, 30316.393672125992, 30616.0, 30730.84634576813, 30866.0, 23093.63838449394, 24492.755072449047, 24936.376590584656, 24970.62544061804, 25169.87415062913], "unit": "score", "name": "ext.html", "value": 18054.069802206424}, {"lowerIsBetter": false, "replicates": [333.2036432925309, 333.4997503744382, 335.5369589965847, 337.4802803682329, 341.80517105250016, 14273.78589321161, 14782.0, 15508.53474395767, 15675.29461174247, 18012.189451474667, 13150.605481835537, 14769.483068092619, 16342.34630614774, 16420.83579164208, 16436.917815410907, 4235.788210589466, 4741.099191153687, 4744.0, 4744.928826067612, 4747.287906813971, 3501.422265326218, 3646.4165733482646, 4660.37084993525, 4690.29645553168, 4946.15915294399, 5013.172826483626, 5049.116404629193, 5067.366579177603, 5086.618503612225, 5094.84715458535, 5063.063333283336, 5477.397486276506, 5917.437843404869, 5921.674307913085, 5922.0, 4968.826091086795, 5121.103806833789, 5173.3016042834115, 5176.5858731301405, 5182.53357197854, 18943.0, 19494.12276447549, 19572.70640940387, 19584.510387240432, 19704.507387315287, 2025.635385630586, 2057.4856285928518, 2084.08300347848, 2149.3659370485743, 2252.6958860553777, 8139.0, 8440.366972477088, 8441.02928163263, 11675.591354302558, 12621.873781262162, 1768.3545505890258, 1785.4822101590523, 1787.0796539782023, 1788.9373871914552, 1801.5406071451696, 53462.46537534614, 54786.795254450764, 55125.0, 55399.0, 55491.44508554903, 8804.779880503038, 9124.45253284805, 9257.398269112486, 9264.351495395393, 9323.766905827273, 11579.247348922294, 11608.76782464346, 11649.650510484698, 11684.357360345093, 11724.706882327839, 6772.085768421299, 6781.423578995742, 6786.4910131739325, 6823.283555226729, 6897.068895699117, 6496.447801936793, 6511.218653761579, 6526.28210896801, 6570.8357291068105, 6572.0, 3899.980500097481, 3923.548791888912, 3946.072672921861, 3968.0, 3972.860949866799, 1472.138798802691, 1510.9471168509049, 1562.546861410201, 1563.234015332479, 1582.3196025709055, 829.7180855578147, 921.6175287255847, 960.3104673840978, 1011.9696409107738, 1052.2897044494935, 15256.542303730906, 15365.0, 16043.0, 16411.83588164127, 16557.503274901774, 803.4817542684935, 843.4053991935671, 867.9392442528963, 922.423485321674, 924.8335299646128, 8851.60167792451, 9253.935797383252, 9493.240540756722, 9624.855627165598, 9661.565229564687, 139615.0, 140646.0, 141077.0, 141128.0, 365953.0, 62662.686686566274, 63309.68345158337, 63544.68227658924, 68749.0, 74251.62874185595, 1077.849101125843, 1108.279618248129, 1128.041165009735, 1129.0459561670375, 1139.1797905508022, 13767.655808604864, 14097.506587269396, 14308.284585770461, 14551.41794328215, 14587.489437869624, 28898.566521502617, 29371.706282937754, 30248.69751302547, 30304.696953030187, 30576.694233058275, 37407.43888841615, 38050.42924356192, 38601.227975440896, 40566.39150412687, 40874.18251634891, 6423.710933007932, 6885.518013739191, 6935.063766391674, 7133.857322853618, 7234.131904171533, 9819.312648114563, 10471.3193642413, 11130.610428634958, 11164.609238676607, 11415.258008229439, 9313.301502387212, 9630.133288004114, 9712.3201375903, 9914.900850991398, 10009.399436033862, 9992.900070999487, 9993.800123997335, 10055.832709942244, 10080.747981300527, 10180.287379883337, 7459.627018648937, 9166.770830729285, 10013.59945602197, 10201.234907382124, 10279.897201027894, 6573.704183311666, 6697.866042679022, 6784.559003664746, 6812.676372899252, 6896.0, 8900.465972041698, 9165.312601555044, 9896.406215627085, 9977.95231500711, 10168.0], "unit": "score", "name": "jquery.html", "value": 7519.950233585894}, {"lowerIsBetter": false, "replicates": [1303.9022073344502, 1414.6534099145708, 1432.3411230833815, 1548.8606025457714, 1712.7430885367194, 6697.162854643169, 7211.170715367734, 7355.3380195782365, 7358.22738612446, 7362.447816413764, 7135.821604459891, 7232.421406287497, 7237.638118094101, 7239.203687594373, 7264.745733899302, 1921.8366438852715, 1969.123739935722, 2105.694674272237, 2162.50262439639, 2178.880161591112, 2155.4288113649895, 2158.4495953531828, 2158.816500597451, 2166.393409845246, 2167.945801354971, 2079.5754907888067, 2201.2955854126685, 2212.867227966319, 2214.1475531920164, 2217.5786600545925, 2177.5862586108587, 2209.326155522565, 2216.556688662266, 2225.343523660524, 2225.643896976492, 2176.270949232009, 2187.464071302525, 2209.7458792238936, 2212.081985975818, 2213.3359992002333, 7584.241575842427, 7618.085829700416, 7626.1992490788225, 7643.197464266227, 7666.0, 4524.366588677588, 4621.445426548802, 4623.676342656016, 4625.583697467244, 4635.582797548203, 2901.8984335548153, 2907.1714561349913, 2961.540961151025, 2965.303153758865, 3039.361734035855, 895.3508706187962, 901.5357091098024, 924.3390975452517, 935.4901578639658, 939.957701903416, 10362.585496580203, 10365.740856478573, 10371.066604005675, 10399.220058495568, 10405.3756774593, 4035.092104276573, 4050.10897602527, 4094.508658960884, 4107.794610269475, 4121.4848143982, 8920.152585504367, 8990.460572365679, 9006.324525660602, 9013.459192448474, 9021.0, 4622.2835460503675, 4629.120467111238, 4630.467496237909, 4640.605548528345, 4655.86032419028, 4139.00663840676, 4141.79291035447, 4142.855000074983, 4144.088300573869, 4147.730397524151, 3272.1655977725527, 3342.615599206074, 3450.896473105811, 3495.528103706018, 3510.78935263885, 1079.2768844873954, 1108.3460758152728, 1121.52895783771, 1121.8878112188715, 1126.0934947367448, 1049.6168898352046, 1281.1096288079696, 1324.9470021199045, 1347.1782212850153, 1351.236551348485, 7064.646767661699, 7091.9290807091265, 7133.072700548999, 7148.785536433916, 7152.892706609405, 1094.1738987064716, 1095.3592148593161, 1096.7751610919743, 1113.3153110836938, 1134.7219931116929, 5741.425857414225, 5768.077107662753, 5768.3366412862215, 5773.1051686988585, 5793.8841223175305, 8637.740867773977, 9157.862632060524, 9272.768180795534, 9284.071592840797, 9336.4864932428, 9204.4477331359, 9215.53922303882, 9231.123043310874, 9233.722988310361, 9245.58394872219, 6912.205096413876, 7098.112735908012, 7137.964995075685, 7157.4274058075225, 7160.140783106061, 6942.652867356713, 7059.541129826544, 7061.964690176516, 7067.399271062018, 7084.0, 7909.327707144727, 8082.15137410587, 8193.221643943816, 8201.630926608435, 8316.37627177952, 8443.451175673561, 8558.871616925626, 8568.400211985101, 8584.270337021424, 8597.0, 6258.968705156445, 6519.8044058678315, 6520.9347906520325, 6536.901946470902, 6543.70553325111, 6583.703733331916, 6651.534392592472, 6974.197967233833, 7054.964725176341, 7153.0343403639845, 6671.0, 6801.5238933274195, 6803.0, 6817.216020157745, 6961.164660240804, 6574.4411725002, 6777.762778302736, 6780.627065511444, 6848.00703897942, 6867.553609015398, 6953.79138625842, 7011.544249623758, 7018.859622807618, 7019.508634395544, 7025.824354391181, 6410.45511131559, 6434.0, 6488.286288508355, 6506.869862602816, 6509.251436084911, 6424.550281480251, 6438.163038804925, 6438.452731517874, 6439.45264652491, 6451.516136289891], "unit": "score", "name": "mootools.html", "value": 4352.498140628065}, {"lowerIsBetter": false, "replicates": [278.4597880112583, 279.22793476038754, 283.9205022593673, 285.2583283462995, 285.8156489064553, 5490.066688662927, 5634.915476267859, 5759.280089988752, 5857.443542863426, 5858.0, 5625.156226566017, 5757.827265182041, 5820.3597604263605, 5823.242978412801, 5827.096799995997, 4445.533219012005, 4445.977425192208, 4455.576720211575, 4457.554244575533, 4459.487158976727, 4228.640565551932, 4281.05816720321, 4334.826606935719, 4443.466783985927, 4454.621357184643, 4272.9359059614135, 4307.870763877088, 4310.892227694301, 4321.956780432202, 4345.587169218919, 4342.870853578061, 4348.97825510872, 4356.237658409766, 4363.80362883671, 4371.431713877176, 3747.8126093695478, 3771.113788259757, 3776.3202623527754, 3776.6978641708597, 3782.9432558511644, 5393.406725260218, 5496.065668836268, 5504.366997795265, 5509.201165830972, 5511.200875873016, 5029.572486338666, 5037.715382577456, 5039.571636410909, 5042.520960508746, 5047.0, 6120.785772497986, 6123.081537769326, 6123.632582045091, 6128.877422451526, 6129.724162412702, 4030.5969403059753, 4078.4697989261504, 4085.6527195188446, 4153.833846646131, 4214.115035842477, 6417.294097649255, 6426.357364263583, 6437.38844809747, 6451.645159516224, 6453.9677301613665, 4265.4241677373775, 4269.807858646368, 4274.294741367639, 4280.0, 4283.1433713257475, 4326.826926922888, 4328.264195086843, 4330.2638551446325, 4330.328799036154, 4336.544662810423, 4906.435759887588, 5032.446430892599, 5037.496250374933, 5045.772940217626, 5053.343065401547, 6087.4521293083835, 6178.443940045418, 6180.7947450246775, 6190.0, 6201.720922558406, 1488.5683151885833, 1510.041123886318, 1512.5008747113427, 1513.160196091158, 1513.2887542854842, 971.3783178765595, 971.8421272435169, 978.1148061004802, 994.6121012805012, 1000.0199804191788, 5826.796062137805, 5844.532437404998, 5848.093545500455, 5850.3564607893095, 5851.707414629337, 6347.809565712943, 6403.519736019724, 6415.133956915756, 6415.486761059104, 6421.197350331208, 5836.358000620014, 5842.328132264844, 5845.181674565564, 5849.298084229919, 5854.4730974212525, 3284.244623736506, 3414.0, 3420.81185534793, 3428.023013441157, 3432.3650124727005, 6641.0, 6641.435477984425, 6643.003549467522, 6644.534882558271, 6649.0, 6484.773032943825, 6503.349665033459, 6511.674416279167, 6513.316101809337, 6513.641749703717, 6407.551471396958, 6596.670166491656, 6606.636634985122, 6606.900896486556, 6630.569013014235, 6376.585521941059, 6376.617402955838, 6399.04014397844, 6407.263164736115, 6408.679566021773, 6061.909071363845, 6172.475339596184, 6228.657423841732, 6279.215098112736, 6364.522660800366, 6670.966000269966, 6681.29846366144, 6686.197656281083, 6699.39705426514, 6718.56329338611, 4273.529911709647, 4275.187714334266, 4277.165952639206, 4278.593533614302, 4280.122574872082, 6245.656488893154, 6380.840478987877, 6409.679516024087, 6419.0, 6420.133282006869, 6199.628022318675, 6206.255249370104, 6208.192934918432, 6210.844728881814, 6212.534059945432, 6225.28409232944, 6233.096201050913, 6237.812865614039, 6240.251169859646, 6242.5942313751275, 5961.225040744849, 6108.541859360655, 6111.174991376108, 6121.816345509642, 6126.785562505291, 6236.345183755821, 6244.843878903063, 6247.812915546032, 6252.499800015897, 6253.656048917172, 6050.213472248755, 6105.5420843437805, 6111.1444397785235, 6111.449969502588, 6114.838180745644], "unit": "score", "name": "prototype.html", "value": 4590.3058647891885}, {"lowerIsBetter": false, "replicates": [767.9923200767994, 769.6959700918137, 784.6704384158653, 792.4215322814345, 842.3219308456692, 12533.937330313358, 12705.174163679354, 12716.682082947931, 12746.80879786804, 12750.744985100293, 11751.706207344821, 12581.811272830915, 12674.4930202792, 12828.67928301793, 12889.548865789699, 775.0234704272601, 791.2759824760337, 791.3985371117934, 791.7268542352879, 793.6864938349348, 779.9298063174314, 784.7214238945178, 786.2844811221789, 786.6381464526296, 786.9763907082797, 820.979475513111, 821.4208982667205, 827.7392621324263, 829.2868133405267, 829.3945419843518, 822.366777581259, 825.5707032343148, 826.6734639817269, 827.1769589258696, 827.3091968206525, 604.8336707405455, 608.0150156746056, 608.4919092557719, 608.6074481959156, 609.232367217305, 11666.475008624633, 11701.122415818763, 11717.824232636518, 11735.295882247006, 11764.058875290042, 10829.512671929704, 10959.0, 10991.395473248967, 11181.32912025281, 11341.489632966537, 9809.803803923953, 9835.90164098357, 9882.160016398615, 9930.404175749405, 10000.149987251092, 3410.198603328216, 3510.9648903511147, 3553.4847447120283, 3559.359315323241, 3569.1077230692326, 44898.55101448976, 47677.284840727414, 47717.284240736415, 47808.760956194994, 47809.0, 9170.724878253663, 9324.0, 9531.761705957406, 9627.0, 9741.9025809741, 16048.27782749779, 16053.678926421406, 16063.919680401523, 16074.276657550437, 16090.517284481484, 7131.8573628528175, 7158.677859496335, 7163.89254161188, 7173.282671732785, 7232.602206878567, 4027.2549578328103, 4059.8579049733116, 4088.7546747195265, 4095.058136628592, 4133.379993001074, 2851.7148285171315, 2872.8707208175683, 2885.0190935082173, 2886.076455534209, 2891.1760148357616, 506.2558039681662, 524.6878107526015, 540.1384791257938, 542.251692664121, 544.27067729243, 540.8884741855446, 545.8335207761671, 562.4853259267725, 565.1184152721768, 615.187951903483, 7563.621818909032, 7731.381489480828, 7770.106437759617, 7945.0, 7962.402819788539, 551.878586710923, 600.753690986702, 608.6378604730179, 618.1253526260381, 620.3796203796204, 3795.867144649924, 3821.9617803821607, 3986.920261594752, 4194.895127621773, 4221.6833737469815, 48716.0, 49069.26396104061, 49168.0, 49317.0, 49387.25919111216, 47271.27924340468, 49987.50012499828, 50244.24633630498, 50296.74851625718, 50378.24432633514, 38540.22919541594, 39150.6084939147, 44372.77813610911, 44548.3317750234, 48438.0, 7930.920690793018, 8105.513669179868, 8382.774548060863, 8596.441231319945, 8665.43674661145, 31520.527192092595, 33055.00834974954, 34012.65987340194, 34014.829925850216, 34044.1488962768, 37871.81064094772, 38490.0, 42888.78555607202, 43343.0, 47294.76352618215, 10862.0, 10888.61889833852, 11038.227324087236, 11310.773784524428, 11347.319160850375, 11860.975114723706, 11871.169018168644, 11987.880121198676, 12446.190997585129, 12665.366731663196, 11294.94352528232, 11326.150538709795, 11373.14701397382, 11458.484368203284, 11568.768624627628, 10596.31123976939, 10814.513346899566, 10840.837387439036, 11175.050120739828, 11278.154138439813, 10535.736606584896, 10659.840102398626, 10743.677689669323, 10804.297720648132, 10838.783224335311, 8886.555672216235, 9025.954870225607, 9028.232600228792, 9305.953470232605, 9356.672516461891, 8501.659933602834, 8825.558722063743, 9258.675946341846, 9397.765055873659, 9806.901930980885], "unit": "score", "name": "yui.html", "value": 5982.049238281799}], "name": "dromaeo_css", "value": 6563.625641581506}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 109.0, 110.0, 113.0, 112.0, 113.0, 113.0, 105.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 157.0, 171.0, 126.0, 158.0, 155.0, 130.0, 169.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 160.0, 167.0, 162.0, 163.0, 166.0, 163.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 93.0, 98.0, 73.0, 74.0, 77.0, 118.0, 97.0, 75.0], "unit": "score", "name": "audio-fft", "value": 85.3}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 146.0, 96.0, 97.0, 96.0, 155.0, 96.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 111.4}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 116.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 58.0, 56.0, 56.0, 59.0, 56.0, 57.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 69.0, 68.0, 69.0, 70.0, 69.0, 68.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 82.0, 97.0, 84.0, 83.0, 86.0, 85.0, 92.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [131.0, 121.0, 119.0, 115.0, 118.0, 115.0, 118.0, 118.0, 116.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [146.0, 139.0, 141.0, 142.0, 146.0, 131.0, 152.0, 141.0, 155.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 68.0, 66.0, 68.0, 68.0, 69.0, 70.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1517.9000000000005}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.19577862722286], "unit": "score", "name": "Richards", "value": 212.41213400000004}, {"lowerIsBetter": false, "replicates": [188.89308651303364], "unit": "score", "name": "DeltaBlue", "value": 350.02869200000004}, {"lowerIsBetter": false, "replicates": [273.7476047084588], "unit": "score", "name": "Encrypt", "value": 972.3591929999996}, {"lowerIsBetter": false, "replicates": [5319.148936170212], "unit": "score", "name": "Decrypt", "value": 50.04202800000001}, {"lowerIsBetter": false, "replicates": [1974.3589743589744], "unit": "score", "name": "RayTrace", "value": 374.7996233766234}, {"lowerIsBetter": false, "replicates": [770.4160246533128], "unit": "score", "name": "Earley", "value": 865.0689739999998}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [41959.183673469386], "unit": "score", "name": "RegExp", "value": 21.711218385214018}, {"lowerIsBetter": false, "replicates": [631.5461346633416], "unit": "score", "name": "Splay", "value": 129.0341204343534}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 18874.4779695799}]} 20:10:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18874.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1517.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6563.63"}}} 20:10:26 INFO - Return code: 0 20:10:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:10:26 INFO - # TBPL SUCCESS # 20:10:26 INFO - Running post-action listener: _resource_record_post_action 20:10:26 INFO - Running post-run listener: _resource_record_post_run 20:10:27 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550223872; Read time: 208; Write time: 481804 20:10:27 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236363776; Read time: 0; Write time: 264288 20:10:27 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 4096; Write bytes: 313860096; Read time: 208; Write time: 217516 20:10:27 INFO - Running post-run listener: _upload_blobber_files 20:10:27 INFO - Blob upload gear active. 20:10:27 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:10:27 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 20:10:27 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:10:27 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:10:28 INFO - (blobuploader) - INFO - Open directory for files ... 20:10:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:10:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:10:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:28 INFO - (blobuploader) - INFO - Done attempting. 20:10:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:10:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:10:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:29 INFO - (blobuploader) - INFO - Done attempting. 20:10:29 INFO - (blobuploader) - INFO - Iteration through files over. 20:10:29 INFO - Return code: 0 20:10:29 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:10:29 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:10:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f595de03c7c6e7a4b050b8b526f7af42ff756b4abbac0e7ce94aaa74fe25e5ae4b2f54abdae0ebc25223caf4329eb7986c9fb29125769845b0e80cb0684967e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5f4c8895cce02d2f158667644f7a1fbd7bd28cb7e5442a7abc64f043289448283435a4f22c8549e627c13aa28db2527ebc607a365af6d656073713f8a4cf180e"} 20:10:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:10:29 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:10:29 INFO - Contents: 20:10:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f595de03c7c6e7a4b050b8b526f7af42ff756b4abbac0e7ce94aaa74fe25e5ae4b2f54abdae0ebc25223caf4329eb7986c9fb29125769845b0e80cb0684967e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5f4c8895cce02d2f158667644f7a1fbd7bd28cb7e5442a7abc64f043289448283435a4f22c8549e627c13aa28db2527ebc607a365af6d656073713f8a4cf180e"} 20:10:29 INFO - Running post-run listener: copy_logs_to_upload_dir 20:10:29 INFO - Copying logs to upload dir... 20:10:29 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:10:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.620177 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-25 20:10:29.315233) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 20:10:29.318910) ========= 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-1453778987.303789-459354999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f595de03c7c6e7a4b050b8b526f7af42ff756b4abbac0e7ce94aaa74fe25e5ae4b2f54abdae0ebc25223caf4329eb7986c9fb29125769845b0e80cb0684967e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5f4c8895cce02d2f158667644f7a1fbd7bd28cb7e5442a7abc64f043289448283435a4f22c8549e627c13aa28db2527ebc607a365af6d656073713f8a4cf180e"} build_url:https://queue.taskcluster.net/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011469 build_url: 'https://queue.taskcluster.net/v1/task/cMNnhdwbQhaX2IAXPx7XgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f595de03c7c6e7a4b050b8b526f7af42ff756b4abbac0e7ce94aaa74fe25e5ae4b2f54abdae0ebc25223caf4329eb7986c9fb29125769845b0e80cb0684967e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5f4c8895cce02d2f158667644f7a1fbd7bd28cb7e5442a7abc64f043289448283435a4f22c8549e627c13aa28db2527ebc607a365af6d656073713f8a4cf180e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 20:10:29.344286) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 20:10:29.344625) ========= 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-1453778987.303789-459354999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 20:10:29.429285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 20:10:29.429605) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 20:10:29.430310) ========= ========= Total master_lag: 0.46 =========