builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1450720537.71 results: success (0) buildid: 20151221073536 builduid: d943cee5eef04449aff294f331ad79fe revision: 79bbc8864c85a98b2743700a121b2a5b8afa7fa3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:37.705569) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:37.706158) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:37.706566) ========= 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=61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006234 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:37.736535) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:37.736873) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:37.750849) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:37.751247) ========= 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=61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:37.799896) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:37.800223) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:37.800611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:37.800892) ========= 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=61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 09:55:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2015-12-21 09:55:38 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:38.001281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:38.001610) ========= 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=61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022350 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:38.050770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:38.051129) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 79bbc8864c85a98b2743700a121b2a5b8afa7fa3 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 79bbc8864c85a98b2743700a121b2a5b8afa7fa3 --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=61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 09:55:38,945 truncating revision to first 12 chars 2015-12-21 09:55:38,945 Setting DEBUG logging. 2015-12-21 09:55:38,945 attempt 1/10 2015-12-21 09:55:38,945 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/79bbc8864c85?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 09:55:39,190 unpacking tar archive at: mozilla-inbound-79bbc8864c85/testing/mozharness/ program finished with exit code 0 elapsedTime=0.588485 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:38.652523) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:38.652826) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:38.660388) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:38.660651) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 09:55:38.661058) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-21 09:55:38.661339) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:55:39 INFO - MultiFileLogger online at 20151221 09:55:39 in /builds/slave/test-pgo 09:55:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:55:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:55:39 INFO - {'append_to_log': False, 09:55:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:55:39 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:55:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:55:39 INFO - 'branch': 'Mozilla-Inbound', 09:55:39 INFO - 'buildbot_json_path': 'buildprops.json', 09:55:39 INFO - 'config_files': ('talos/linux_config.py',), 09:55:39 INFO - 'default_actions': ('clobber', 09:55:39 INFO - 'read-buildbot-config', 09:55:39 INFO - 'download-and-extract', 09:55:39 INFO - 'populate-webroot', 09:55:39 INFO - 'create-virtualenv', 09:55:39 INFO - 'install', 09:55:39 INFO - 'run-tests'), 09:55:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:55:39 INFO - 'download_minidump_stackwalk': True, 09:55:39 INFO - 'download_symbols': 'ondemand', 09:55:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:55:39 INFO - 'tooltool.py': '/tools/tooltool.py', 09:55:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:55:39 INFO - '/tools/misc-python/virtualenv.py')}, 09:55:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:55:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:55:39 INFO - 'installer_path': 'installer.exe', 09:55:39 INFO - 'log_level': 'info', 09:55:39 INFO - 'log_name': 'talos', 09:55:39 INFO - 'log_to_console': True, 09:55:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:55:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:55:39 INFO - 'opt_config_files': (), 09:55:39 INFO - 'pip_index': False, 09:55:39 INFO - 'sps_profile': False, 09:55:39 INFO - 'sps_profile_interval': 0, 09:55:39 INFO - 'suite': 'dromaeojs-e10s', 09:55:39 INFO - 'system_bits': '64', 09:55:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:55:39 INFO - 'title': 'talos-linux64-ix-045', 09:55:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:55:39 INFO - 'use_talos_json': True, 09:55:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:55:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:55:39 INFO - 'work_dir': 'build'} 09:55:39 INFO - ##### 09:55:39 INFO - ##### Running clobber step. 09:55:39 INFO - ##### 09:55:39 INFO - Running pre-action listener: _resource_record_pre_action 09:55:39 INFO - Running main action method: clobber 09:55:39 INFO - rmtree: /builds/slave/test-pgo/build 09:55:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:55:40 INFO - Running post-action listener: _resource_record_post_action 09:55:40 INFO - ##### 09:55:40 INFO - ##### Running read-buildbot-config step. 09:55:40 INFO - ##### 09:55:40 INFO - Running pre-action listener: _resource_record_pre_action 09:55:40 INFO - Running main action method: read_buildbot_config 09:55:40 INFO - Using buildbot properties: 09:55:40 INFO - { 09:55:40 INFO - "project": "", 09:55:40 INFO - "product": "firefox", 09:55:40 INFO - "script_repo_revision": "production", 09:55:40 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 09:55:40 INFO - "repository": "", 09:55:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 09:55:40 INFO - "buildid": "20151221073536", 09:55:40 INFO - "pgo_build": "True", 09:55:40 INFO - "basedir": "/builds/slave/test-pgo", 09:55:40 INFO - "buildnumber": 537, 09:55:40 INFO - "slavename": "talos-linux64-ix-045", 09:55:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:55:40 INFO - "platform": "ubuntu64_hw", 09:55:40 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:55:40 INFO - "branch": "mozilla-inbound", 09:55:40 INFO - "repo_path": "integration/mozilla-inbound", 09:55:40 INFO - "revision": "79bbc8864c85a98b2743700a121b2a5b8afa7fa3", 09:55:40 INFO - "stage_platform": "linux64-pgo", 09:55:40 INFO - "builduid": "d943cee5eef04449aff294f331ad79fe", 09:55:40 INFO - "slavebuilddir": "test" 09:55:40 INFO - } 09:55:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:55:40 INFO - Running post-action listener: _resource_record_post_action 09:55:40 INFO - ##### 09:55:40 INFO - ##### Running download-and-extract step. 09:55:40 INFO - ##### 09:55:40 INFO - Running pre-action listener: _resource_record_pre_action 09:55:40 INFO - Running main action method: download_and_extract 09:55:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:55:40 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')]} 09:55:40 INFO - https://queue.taskcluster.net/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:55:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/test_packages.json 09:55:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/test_packages.json 09:55:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:55:42 INFO - Downloaded 1302 bytes. 09:55:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:55:42 INFO - Using the following test package requirements: 09:55:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:55:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:55:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:42 INFO - u'jsshell-linux-x86_64.zip'], 09:55:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:55:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:55:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:55:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:55:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:55:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:55:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:55:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:42 INFO - https://queue.taskcluster.net/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:55:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:55:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:55:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:55:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:55:50 INFO - Downloaded 23175016 bytes. 09:55:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:55:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:55:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:55:51 INFO - Return code: 0 09:55:51 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:55: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')]} 09:55:51 INFO - https://queue.taskcluster.net/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:55:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:55:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:55:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:55:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:55:53 INFO - Downloaded 23175016 bytes. 09:55:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:55:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:55:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:55:55 INFO - Return code: 0 09:55:55 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')]} 09:55:55 INFO - https://queue.taskcluster.net/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:55:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:55:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:55:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:55:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:55:56 INFO - Downloaded 11132277 bytes. 09:55:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 09:55:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:55:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:55:56 INFO - Return code: 0 09:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:56 INFO - https://queue.taskcluster.net/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:55:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:55:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:55:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:55:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:55:58 INFO - Downloaded 54931754 bytes. 09:55:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:55:58 INFO - mkdir: /builds/slave/test-pgo/properties 09:55:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:55:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:55:58 INFO - Contents: 09:55:58 INFO - build_url:https://queue.taskcluster.net/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:55:58 INFO - Running post-action listener: _resource_record_post_action 09:55:58 INFO - Running post-action listener: set_extra_try_arguments 09:55:58 INFO - ##### 09:55:58 INFO - ##### Running populate-webroot step. 09:55:58 INFO - ##### 09:55:58 INFO - Running pre-action listener: _resource_record_pre_action 09:55:58 INFO - Running main action method: populate_webroot 09:55:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:55:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:55:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:55:58 INFO - '--tppagecycles', 09:55:58 INFO - '7'], 09:55:58 INFO - 'tests': ['tsvgm']}}, 09:55:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:55:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:55:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:55:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:55:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:55:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:55:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:58 INFO - 'talos_options': ['--e10s'], 09:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:58 INFO - 'tests': ['damp', 'tps']}, 09:55:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:58 INFO - 'talos_options': ['--e10s'], 09:55:58 INFO - 'tests': ['damp', 'tps']}, 09:55:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:55:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:55:58 INFO - 'other': {'tests': ['a11yr', 09:55:58 INFO - 'ts_paint', 09:55:58 INFO - 'tpaint', 09:55:58 INFO - 'sessionrestore', 09:55:58 INFO - 'sessionrestore_no_auto_restore']}, 09:55:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:55:58 INFO - 'tests': ['a11yr', 09:55:58 INFO - 'ts_paint', 09:55:58 INFO - 'tpaint', 09:55:58 INFO - 'sessionrestore', 09:55:58 INFO - 'sessionrestore_no_auto_restore']}, 09:55:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:55:58 INFO - 'tests': ['a11yr', 09:55:58 INFO - 'ts_paint', 09:55:58 INFO - 'tpaint', 09:55:58 INFO - 'sessionrestore', 09:55:58 INFO - 'sessionrestore_no_auto_restore']}, 09:55:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:55:58 INFO - 'tests': ['a11yr', 09:55:58 INFO - 'ts_paint', 09:55:58 INFO - 'tpaint', 09:55:58 INFO - 'sessionrestore', 09:55:58 INFO - 'sessionrestore_no_auto_restore']}, 09:55:58 INFO - 'other_l64': {'tests': ['a11yr', 09:55:58 INFO - 'ts_paint', 09:55:58 INFO - 'tpaint', 09:55:58 INFO - 'sessionrestore', 09:55:58 INFO - 'sessionrestore_no_auto_restore']}, 09:55:58 INFO - 'other_nol64': {'tests': ['a11yr', 09:55:58 INFO - 'ts_paint', 09:55:58 INFO - 'tpaint', 09:55:58 INFO - 'sessionrestore', 09:55:58 INFO - 'sessionrestore_no_auto_restore']}, 09:55:58 INFO - 'svgr': {'tests': ['tsvgx', 09:55:58 INFO - 'tsvgr_opacity', 09:55:58 INFO - 'tart', 09:55:58 INFO - 'tscrollx', 09:55:58 INFO - 'cart']}, 09:55:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:55:58 INFO - 'tests': ['tsvgx', 09:55:58 INFO - 'tsvgr_opacity', 09:55:58 INFO - 'tart', 09:55:58 INFO - 'tscrollx', 09:55:58 INFO - 'cart']}, 09:55:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:58 INFO - 'tests': ['tp5o']}, 09:55:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:58 INFO - 'talos_options': ['--e10s'], 09:55:58 INFO - 'tests': ['tp5o']}, 09:55:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:58 INFO - 'talos_options': ['--xperf_path', 09:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:58 INFO - 'tests': ['tp5n']}, 09:55:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:58 INFO - 'talos_options': ['--e10s', 09:55:58 INFO - '--xperf_path', 09:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:58 INFO - 'tests': ['tp5n']}}, 09:55:58 INFO - 'talos.zip': {'path': '', 09:55:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:55:58 INFO - Running post-action listener: _resource_record_post_action 09:55:58 INFO - ##### 09:55:58 INFO - ##### Running create-virtualenv step. 09:55:58 INFO - ##### 09:55:58 INFO - Running pre-action listener: _resource_record_pre_action 09:55:58 INFO - Running main action method: create_virtualenv 09:55:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:55:58 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 09:55:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:55:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:55:58 INFO - Using real prefix '/usr' 09:55:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:55:59 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:01 INFO - Installing pip.................done. 09:56:01 INFO - Return code: 0 09:56:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7604c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f17f0>, '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 0x295d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295d760>, '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': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', '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 09:56:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:56:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:56:01 INFO - Using env: {'DISPLAY': ':0', 09:56:01 INFO - 'HOME': '/home/cltbld', 09:56:01 INFO - 'LANG': 'en_US.UTF-8', 09:56:01 INFO - 'LANGUAGE': 'en_US:en', 09:56:01 INFO - 'LOGNAME': 'cltbld', 09:56:01 INFO - 'MAIL': '/var/mail/cltbld', 09:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:01 INFO - 'MOZ_NO_REMOTE': '1', 09:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:01 INFO - 'NO_EM_RESTART': '1', 09:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:01 INFO - 'SHELL': '/bin/bash', 09:56:01 INFO - 'SHLVL': '1', 09:56:01 INFO - 'TERM': 'linux', 09:56:01 INFO - 'TMOUT': '86400', 09:56:01 INFO - 'USER': 'cltbld', 09:56:01 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', 09:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:01 INFO - '_': '/tools/buildbot/bin/python'} 09:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:01 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 09:56:01 INFO - Cleaning up... 09:56:01 INFO - Return code: 0 09:56:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7604c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f17f0>, '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 0x295d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295d760>, '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': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', '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 09:56:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:56:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:56:01 INFO - Using env: {'DISPLAY': ':0', 09:56:01 INFO - 'HOME': '/home/cltbld', 09:56:01 INFO - 'LANG': 'en_US.UTF-8', 09:56:01 INFO - 'LANGUAGE': 'en_US:en', 09:56:01 INFO - 'LOGNAME': 'cltbld', 09:56:01 INFO - 'MAIL': '/var/mail/cltbld', 09:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:01 INFO - 'MOZ_NO_REMOTE': '1', 09:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:01 INFO - 'NO_EM_RESTART': '1', 09:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:01 INFO - 'SHELL': '/bin/bash', 09:56:01 INFO - 'SHLVL': '1', 09:56:01 INFO - 'TERM': 'linux', 09:56:01 INFO - 'TMOUT': '86400', 09:56:01 INFO - 'USER': 'cltbld', 09:56:01 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', 09:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:01 INFO - '_': '/tools/buildbot/bin/python'} 09:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:01 INFO - Downloading/unpacking psutil>=0.7.1 09:56:01 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 09:56:01 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 09:56:01 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 09:56:01 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 09:56:01 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 09:56:01 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 09:56:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:56:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:56:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:56:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:03 INFO - Installing collected packages: psutil 09:56:03 INFO - Running setup.py install for psutil 09:56:03 INFO - building 'psutil._psutil_linux' extension 09:56:03 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 09:56:03 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 09:56:03 INFO - building 'psutil._psutil_posix' extension 09:56:03 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 09:56:03 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 09:56:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:03 INFO - Successfully installed psutil 09:56:03 INFO - Cleaning up... 09:56:04 INFO - Return code: 0 09:56:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:56:04 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')]} 09:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:04 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')]} 09:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7604c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f17f0>, '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 0x295d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295d760>, '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': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', '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 09:56:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:56:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:56:04 INFO - Using env: {'DISPLAY': ':0', 09:56:04 INFO - 'HOME': '/home/cltbld', 09:56:04 INFO - 'LANG': 'en_US.UTF-8', 09:56:04 INFO - 'LANGUAGE': 'en_US:en', 09:56:04 INFO - 'LOGNAME': 'cltbld', 09:56:04 INFO - 'MAIL': '/var/mail/cltbld', 09:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:04 INFO - 'MOZ_NO_REMOTE': '1', 09:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:04 INFO - 'NO_EM_RESTART': '1', 09:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:04 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:04 INFO - 'SHELL': '/bin/bash', 09:56:04 INFO - 'SHLVL': '1', 09:56:04 INFO - 'TERM': 'linux', 09:56:04 INFO - 'TMOUT': '86400', 09:56:04 INFO - 'USER': 'cltbld', 09:56:04 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', 09:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:04 INFO - '_': '/tools/buildbot/bin/python'} 09:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:56:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:56:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:56:05 INFO - Installing collected packages: mozsystemmonitor 09:56:05 INFO - Running setup.py install for mozsystemmonitor 09:56:06 INFO - Successfully installed mozsystemmonitor 09:56:06 INFO - Cleaning up... 09:56:06 INFO - Return code: 0 09:56:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:56:06 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')]} 09:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:06 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')]} 09:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7604c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f17f0>, '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 0x295d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295d760>, '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': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', '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 09:56:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:56:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:56:06 INFO - Using env: {'DISPLAY': ':0', 09:56:06 INFO - 'HOME': '/home/cltbld', 09:56:06 INFO - 'LANG': 'en_US.UTF-8', 09:56:06 INFO - 'LANGUAGE': 'en_US:en', 09:56:06 INFO - 'LOGNAME': 'cltbld', 09:56:06 INFO - 'MAIL': '/var/mail/cltbld', 09:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:06 INFO - 'MOZ_NO_REMOTE': '1', 09:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:06 INFO - 'NO_EM_RESTART': '1', 09:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:06 INFO - 'SHELL': '/bin/bash', 09:56:06 INFO - 'SHLVL': '1', 09:56:06 INFO - 'TERM': 'linux', 09:56:06 INFO - 'TMOUT': '86400', 09:56:06 INFO - 'USER': 'cltbld', 09:56:06 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', 09:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:06 INFO - '_': '/tools/buildbot/bin/python'} 09:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:06 INFO - Downloading/unpacking blobuploader==1.2.4 09:56:06 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 09:56:06 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 09:56:06 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 09:56:06 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 09:56:06 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 09:56:06 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 09:56:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:56:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:56:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:56:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:56:08 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 09:56:08 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 09:56:08 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 09:56:08 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 09:56:08 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 09:56:08 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 09:56:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:56:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:56:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:56:08 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 09:56:08 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 09:56:08 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 09:56:08 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 09:56:08 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 09:56:08 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 09:56:08 INFO - Downloading docopt-0.6.1.tar.gz 09:56:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:56:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:56:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:56:08 INFO - Running setup.py install for blobuploader 09:56:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:56:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:56:08 INFO - Running setup.py install for requests 09:56:09 INFO - Running setup.py install for docopt 09:56:09 INFO - Successfully installed blobuploader requests docopt 09:56:09 INFO - Cleaning up... 09:56:09 INFO - Return code: 0 09:56:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7604c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f17f0>, '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 0x295d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295d760>, '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': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', '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 09:56:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:56:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:56:09 INFO - Using env: {'DISPLAY': ':0', 09:56:09 INFO - 'HOME': '/home/cltbld', 09:56:09 INFO - 'LANG': 'en_US.UTF-8', 09:56:09 INFO - 'LANGUAGE': 'en_US:en', 09:56:09 INFO - 'LOGNAME': 'cltbld', 09:56:09 INFO - 'MAIL': '/var/mail/cltbld', 09:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:09 INFO - 'MOZ_NO_REMOTE': '1', 09:56:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:09 INFO - 'NO_EM_RESTART': '1', 09:56:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:09 INFO - 'SHELL': '/bin/bash', 09:56:09 INFO - 'SHLVL': '1', 09:56:09 INFO - 'TERM': 'linux', 09:56:09 INFO - 'TMOUT': '86400', 09:56:09 INFO - 'USER': 'cltbld', 09:56:09 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', 09:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:09 INFO - '_': '/tools/buildbot/bin/python'} 09:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:56:09 INFO - Running setup.py (path:/tmp/pip-3AppJr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:56:09 INFO - Running setup.py (path:/tmp/pip-94WtV0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:56:09 INFO - Running setup.py (path:/tmp/pip-LBfM4I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:56:09 INFO - Running setup.py (path:/tmp/pip-ZU2szy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:56:09 INFO - Running setup.py (path:/tmp/pip-5cFINv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:56:09 INFO - Running setup.py (path:/tmp/pip-aGo_6R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:56:09 INFO - Running setup.py (path:/tmp/pip-oZ_hYq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:56:10 INFO - Running setup.py (path:/tmp/pip-jcwU_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:56:10 INFO - Running setup.py (path:/tmp/pip-AcuijQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:56:10 INFO - Running setup.py (path:/tmp/pip-qVyH3a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:56:10 INFO - Running setup.py (path:/tmp/pip-h8yq4x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:56:10 INFO - Running setup.py (path:/tmp/pip-ce1hSa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:56:10 INFO - Running setup.py (path:/tmp/pip-YclsD3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:56:10 INFO - Running setup.py (path:/tmp/pip-11ddV4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:56:10 INFO - Running setup.py (path:/tmp/pip-Ly38XM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:56:10 INFO - Running setup.py (path:/tmp/pip-O4A7Hl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:56:10 INFO - Running setup.py (path:/tmp/pip-Tdy5XZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:56:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:56:10 INFO - Running setup.py install for manifestparser 09:56:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:56:10 INFO - Running setup.py install for mozcrash 09:56:10 INFO - Running setup.py install for mozdebug 09:56:11 INFO - Running setup.py install for mozdevice 09:56:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:56:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:56:11 INFO - Running setup.py install for mozfile 09:56:11 INFO - Running setup.py install for mozhttpd 09:56:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:56:11 INFO - Running setup.py install for mozinfo 09:56:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:56:11 INFO - Running setup.py install for mozInstall 09:56:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:56:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:56:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:56:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:56:11 INFO - Running setup.py install for mozleak 09:56:11 INFO - Running setup.py install for mozlog 09:56:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:56:11 INFO - Running setup.py install for moznetwork 09:56:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:56:11 INFO - Running setup.py install for mozprocess 09:56:12 INFO - Running setup.py install for mozprofile 09:56:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:56:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:56:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:56:12 INFO - Running setup.py install for mozrunner 09:56:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:56:12 INFO - Running setup.py install for mozscreenshot 09:56:12 INFO - Running setup.py install for moztest 09:56:12 INFO - Running setup.py install for mozversion 09:56:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:56:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:56:12 INFO - Cleaning up... 09:56:12 INFO - Return code: 0 09:56:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:56:12 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')]} 09:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:12 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')]} 09:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7604c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f17f0>, '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 0x295d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295d760>, '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': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', '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 09:56:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:56:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:56:12 INFO - Using env: {'DISPLAY': ':0', 09:56:12 INFO - 'HOME': '/home/cltbld', 09:56:12 INFO - 'LANG': 'en_US.UTF-8', 09:56:12 INFO - 'LANGUAGE': 'en_US:en', 09:56:12 INFO - 'LOGNAME': 'cltbld', 09:56:12 INFO - 'MAIL': '/var/mail/cltbld', 09:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:12 INFO - 'MOZ_NO_REMOTE': '1', 09:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:12 INFO - 'NO_EM_RESTART': '1', 09:56:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:12 INFO - 'SHELL': '/bin/bash', 09:56:12 INFO - 'SHLVL': '1', 09:56:12 INFO - 'TERM': 'linux', 09:56:12 INFO - 'TMOUT': '86400', 09:56:12 INFO - 'USER': 'cltbld', 09:56:12 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', 09:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:12 INFO - '_': '/tools/buildbot/bin/python'} 09:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:56:12 INFO - Running setup.py (path:/tmp/pip-gzaSfn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:56:12 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)) 09:56:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:56:12 INFO - Running setup.py (path:/tmp/pip-CV5UGE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:56:12 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)) 09:56:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:56:12 INFO - Running setup.py (path:/tmp/pip-wXZm6j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:56:12 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)) 09:56:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:56:12 INFO - Running setup.py (path:/tmp/pip-sXcWKq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:56:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:56:13 INFO - Running setup.py (path:/tmp/pip-XtGUxW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:56:13 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)) 09:56:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:56:13 INFO - Running setup.py (path:/tmp/pip-MOAvBx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:56:13 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)) 09:56:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:56:13 INFO - Running setup.py (path:/tmp/pip-RhLkuF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:56:13 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)) 09:56:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:56:13 INFO - Running setup.py (path:/tmp/pip-4JL5rW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:56:13 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)) 09:56:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:56:13 INFO - Running setup.py (path:/tmp/pip-aaaJ7n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:56:13 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)) 09:56:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:56:13 INFO - Running setup.py (path:/tmp/pip-mvyhdt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:56:13 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)) 09:56:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:56:13 INFO - Running setup.py (path:/tmp/pip-1IcvTE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:56:13 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)) 09:56:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:56:13 INFO - Running setup.py (path:/tmp/pip-lbkJvm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:56:13 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)) 09:56:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:56:13 INFO - Running setup.py (path:/tmp/pip-pQta9P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:56:13 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)) 09:56:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:56:13 INFO - Running setup.py (path:/tmp/pip-Tofr_2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:56:13 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)) 09:56:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:56:13 INFO - Running setup.py (path:/tmp/pip-1weItV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:56:13 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)) 09:56:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:56:13 INFO - Running setup.py (path:/tmp/pip-Of5ZLi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:56:13 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)) 09:56:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:56:13 INFO - Running setup.py (path:/tmp/pip-XjY57k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:56:14 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)) 09:56:14 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)) 09:56:14 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)) 09:56:14 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)) 09:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:56:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:56:14 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 09:56:14 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 09:56:14 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 09:56:14 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 09:56:14 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 09:56:14 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 09:56:15 INFO - Downloading blessings-1.5.1.tar.gz 09:56:15 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:56:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:56:15 INFO - Installing collected packages: blessings 09:56:15 INFO - Running setup.py install for blessings 09:56:15 INFO - Successfully installed blessings 09:56:15 INFO - Cleaning up... 09:56:15 INFO - Return code: 0 09:56:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:56:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:56:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:56:16 INFO - Reading from file tmpfile_stdout 09:56:16 INFO - Current package versions: 09:56:16 INFO - argparse == 1.2.1 09:56:16 INFO - blessings == 1.5.1 09:56:16 INFO - blobuploader == 1.2.4 09:56:16 INFO - docopt == 0.6.1 09:56:16 INFO - manifestparser == 1.1 09:56:16 INFO - mozInstall == 1.12 09:56:16 INFO - mozcrash == 0.16 09:56:16 INFO - mozdebug == 0.1 09:56:16 INFO - mozdevice == 0.47 09:56:16 INFO - mozfile == 1.2 09:56:16 INFO - mozhttpd == 0.7 09:56:16 INFO - mozinfo == 0.9 09:56:16 INFO - mozleak == 0.1 09:56:16 INFO - mozlog == 3.1 09:56:16 INFO - moznetwork == 0.27 09:56:16 INFO - mozprocess == 0.22 09:56:16 INFO - mozprofile == 0.28 09:56:16 INFO - mozrunner == 6.11 09:56:16 INFO - mozscreenshot == 0.1 09:56:16 INFO - mozsystemmonitor == 0.0 09:56:16 INFO - moztest == 0.7 09:56:16 INFO - mozversion == 1.4 09:56:16 INFO - psutil == 3.1.1 09:56:16 INFO - requests == 1.2.3 09:56:16 INFO - wsgiref == 0.1.2 09:56:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:56:16 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')]} 09:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:16 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')]} 09:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7604c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f17f0>, '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 0x295d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295d760>, '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': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', '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 09:56:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 09:56:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:56:16 INFO - Using env: {'DISPLAY': ':0', 09:56:16 INFO - 'HOME': '/home/cltbld', 09:56:16 INFO - 'LANG': 'en_US.UTF-8', 09:56:16 INFO - 'LANGUAGE': 'en_US:en', 09:56:16 INFO - 'LOGNAME': 'cltbld', 09:56:16 INFO - 'MAIL': '/var/mail/cltbld', 09:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:16 INFO - 'MOZ_NO_REMOTE': '1', 09:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:16 INFO - 'NO_EM_RESTART': '1', 09:56:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:16 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:16 INFO - 'SHELL': '/bin/bash', 09:56:16 INFO - 'SHLVL': '1', 09:56:16 INFO - 'TERM': 'linux', 09:56:16 INFO - 'TMOUT': '86400', 09:56:16 INFO - 'USER': 'cltbld', 09:56:16 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', 09:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:16 INFO - '_': '/tools/buildbot/bin/python'} 09:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:16 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)) 09:56:16 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)) 09:56:16 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)) 09:56:16 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)) 09:56:16 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)) 09:56:16 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)) 09:56:16 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)) 09:56:16 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)) 09:56:16 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)) 09:56:16 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)) 09:56:16 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)) 09:56:16 INFO - Cleaning up... 09:56:16 INFO - Return code: 0 09:56:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:56:16 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')]} 09:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:16 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')]} 09:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7604c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f17f0>, '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 0x295d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295d760>, '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': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', '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 09:56:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:56:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:56:16 INFO - Using env: {'DISPLAY': ':0', 09:56:16 INFO - 'HOME': '/home/cltbld', 09:56:16 INFO - 'LANG': 'en_US.UTF-8', 09:56:16 INFO - 'LANGUAGE': 'en_US:en', 09:56:16 INFO - 'LOGNAME': 'cltbld', 09:56:16 INFO - 'MAIL': '/var/mail/cltbld', 09:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:16 INFO - 'MOZ_NO_REMOTE': '1', 09:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:16 INFO - 'NO_EM_RESTART': '1', 09:56:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:16 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:16 INFO - 'SHELL': '/bin/bash', 09:56:16 INFO - 'SHLVL': '1', 09:56:16 INFO - 'TERM': 'linux', 09:56:16 INFO - 'TMOUT': '86400', 09:56:16 INFO - 'USER': 'cltbld', 09:56:16 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', 09:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:16 INFO - '_': '/tools/buildbot/bin/python'} 09:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:16 INFO - Downloading/unpacking jsonschema 09:56:16 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 09:56:16 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 09:56:16 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 09:56:16 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 09:56:16 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 09:56:16 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 09:56:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:56:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 09:56:18 INFO - Downloading/unpacking functools32 (from jsonschema) 09:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:18 INFO - Downloading functools32-3.2.3-2.tar.gz 09:56:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:56:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:56:18 INFO - warning: no files found matching '*.txt' 09:56:18 INFO - no previously-included directories found matching 'build' 09:56:18 INFO - no previously-included directories found matching 'dist' 09:56:18 INFO - no previously-included directories found matching '.git*' 09:56:18 INFO - Installing collected packages: jsonschema, functools32 09:56:18 INFO - Running setup.py install for functools32 09:56:18 INFO - warning: no files found matching '*.txt' 09:56:18 INFO - no previously-included directories found matching 'build' 09:56:18 INFO - no previously-included directories found matching 'dist' 09:56:18 INFO - no previously-included directories found matching '.git*' 09:56:18 INFO - Successfully installed jsonschema functools32 09:56:18 INFO - Cleaning up... 09:56:18 INFO - Return code: 0 09:56:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:56:18 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')]} 09:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:18 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')]} 09:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7604c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f17f0>, '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 0x295d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295d760>, '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': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', '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 09:56:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:56:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:56:18 INFO - Using env: {'DISPLAY': ':0', 09:56:18 INFO - 'HOME': '/home/cltbld', 09:56:18 INFO - 'LANG': 'en_US.UTF-8', 09:56:18 INFO - 'LANGUAGE': 'en_US:en', 09:56:18 INFO - 'LOGNAME': 'cltbld', 09:56:18 INFO - 'MAIL': '/var/mail/cltbld', 09:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:18 INFO - 'MOZ_NO_REMOTE': '1', 09:56:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:18 INFO - 'NO_EM_RESTART': '1', 09:56:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:18 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:18 INFO - 'SHELL': '/bin/bash', 09:56:18 INFO - 'SHLVL': '1', 09:56:18 INFO - 'TERM': 'linux', 09:56:18 INFO - 'TMOUT': '86400', 09:56:18 INFO - 'USER': 'cltbld', 09:56:18 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', 09:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:18 INFO - '_': '/tools/buildbot/bin/python'} 09:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:18 INFO - Downloading/unpacking flake8 09:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:56:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 09:56:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:56:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 09:56:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 09:56:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:56:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:56:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:56:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:56:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:56:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:56:21 INFO - no previously-included directories found matching 'docs/_build' 09:56:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:56:21 INFO - Running setup.py install for pep8 09:56:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:56:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:56:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:56:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:56:21 INFO - no previously-included directories found matching 'docs/_build' 09:56:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:56:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:56:21 INFO - Cleaning up... 09:56:21 INFO - Return code: 0 09:56:21 INFO - Running post-action listener: _resource_record_post_action 09:56:21 INFO - Running post-action listener: _start_resource_monitoring 09:56:21 INFO - Starting resource monitoring. 09:56:21 INFO - ##### 09:56:21 INFO - ##### Running install step. 09:56:21 INFO - ##### 09:56:21 INFO - Running pre-action listener: _resource_record_pre_action 09:56:21 INFO - Running main action method: install 09:56:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:56:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:56:21 INFO - Reading from file tmpfile_stdout 09:56:21 INFO - Detecting whether we're running mozinstall >=1.0... 09:56:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:56:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:56:21 INFO - Reading from file tmpfile_stdout 09:56:21 INFO - Output received: 09:56:21 INFO - Usage: mozinstall [options] installer 09:56:21 INFO - Options: 09:56:21 INFO - -h, --help show this help message and exit 09:56:21 INFO - -d DEST, --destination=DEST 09:56:21 INFO - Directory to install application into. [default: 09:56:21 INFO - "/builds/slave/test-pgo"] 09:56:21 INFO - --app=APP Application being installed. [default: firefox] 09:56:21 INFO - mkdir: /builds/slave/test-pgo/build/application 09:56:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:56:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:56:37 INFO - Reading from file tmpfile_stdout 09:56:37 INFO - Output received: 09:56:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:56:37 INFO - Running post-action listener: _resource_record_post_action 09:56:37 INFO - ##### 09:56:37 INFO - ##### Running run-tests step. 09:56:37 INFO - ##### 09:56:37 INFO - Running pre-action listener: _resource_record_pre_action 09:56:37 INFO - Running main action method: run_tests 09:56:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:56:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:56:37 INFO - Python 2.7.3 09:56:37 INFO - Return code: 0 09:56:37 INFO - grabbing minidump binary from tooltool 09:56:37 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')]} 09:56:37 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 0x29f17f0>, '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 0x295d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295d760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:56:37 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 09:56:37 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 09:56:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:56:37 INFO - Return code: 0 09:56:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:56:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:56:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:56:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:56:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:56:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:56:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:56:38 INFO - Return code: 0 09:56:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 09:56:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:56:38 INFO - Using env: {'DISPLAY': ':0', 09:56:38 INFO - 'HOME': '/home/cltbld', 09:56:38 INFO - 'LANG': 'en_US.UTF-8', 09:56:38 INFO - 'LANGUAGE': 'en_US:en', 09:56:38 INFO - 'LOGNAME': 'cltbld', 09:56:38 INFO - 'MAIL': '/var/mail/cltbld', 09:56:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:56:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:38 INFO - 'MOZ_NO_REMOTE': '1', 09:56:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:38 INFO - 'NO_EM_RESTART': '1', 09:56:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:38 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:56:38 INFO - 'SHELL': '/bin/bash', 09:56:38 INFO - 'SHLVL': '1', 09:56:38 INFO - 'TERM': 'linux', 09:56:38 INFO - 'TMOUT': '86400', 09:56:38 INFO - 'USER': 'cltbld', 09:56:38 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785', 09:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:38 INFO - '_': '/tools/buildbot/bin/python'} 09:56:38 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:56:38 INFO - mozversion application_buildid: 20151221073536 09:56:38 INFO - mozversion application_changeset: 79bbc8864c85a98b2743700a121b2a5b8afa7fa3 09:56:38 INFO - mozversion application_display_name: Nightly 09:56:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:56:38 INFO - mozversion application_name: Firefox 09:56:38 INFO - mozversion application_remotingname: firefox 09:56:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:56:38 INFO - mozversion application_vendor: Mozilla 09:56:38 INFO - mozversion application_version: 46.0a1 09:56:38 INFO - mozversion platform_buildid: 20151221073536 09:56:38 INFO - mozversion platform_changeset: 79bbc8864c85a98b2743700a121b2a5b8afa7fa3 09:56:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:56:38 INFO - mozversion platform_version: 46.0a1 09:56:38 INFO - using testdate: 1450720598 09:56:38 INFO - actual date: 1450720598 09:56:38 INFO - starting webserver on 'localhost:59766' 09:56:38 INFO - SUITE-START | Running 3 tests 09:56:38 INFO - TEST-START | dromaeo_css 09:56:38 INFO - operating with platform_type : linux_ 09:56:38 INFO - Initialising browser for dromaeo_css test... 09:56:38 INFO - TEST-INFO | started process 11586 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuZDs6Y/profile http://localhost:59766/getInfo.html) 09:56:42 INFO - PROCESS | 11586 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 09:56:43 INFO - PROCESS | 11586 | __metrics Screen width/height:1600/1200 09:56:43 INFO - PROCESS | 11586 | colorDepth:24 09:56:43 INFO - PROCESS | 11586 | Browser inner width/height: 1024/697 09:56:43 INFO - PROCESS | 11586 | __metrics 09:56:43 INFO - PROCESS | 11586 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:56:44 INFO - TEST-INFO | 11586: exit 0 09:56:44 INFO - Browser initialized. 09:56:44 INFO - Running cycle 1/1 for dromaeo_css test... 09:56:44 INFO - TEST-INFO | started process 11721 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuZDs6Y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:56 INFO - PROCESS | 11721 | RSS: Main: 151179264 09:56:56 INFO - PROCESS | 11721 | 09:57:45 INFO - PROCESS | 11721 | 1450720665947 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] 09:59:55 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:59766/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59766/tests/dromaeo/cssquery-ext.html) 09:59:56 INFO - PROCESS | 11721 | RSS: Main: 157560832 09:59:56 INFO - PROCESS | 11721 | 10:02:58 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:59766/tests/dromaeo/cssquery-ext.html (next: http://localhost:59766/tests/dromaeo/cssquery-jquery.html) 10:02:58 INFO - PROCESS | 11721 | RSS: Main: 152219648 10:02:58 INFO - PROCESS | 11721 | 10:06:00 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:59766/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59766/tests/dromaeo/cssquery-mootools.html) 10:06:01 INFO - PROCESS | 11721 | RSS: Main: 155242496 10:06:01 INFO - PROCESS | 11721 | 10:09:02 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:59766/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59766/tests/dromaeo/cssquery-prototype.html) 10:09:03 INFO - PROCESS | 11721 | RSS: Main: 152223744 10:09:03 INFO - PROCESS | 11721 | 10:12:05 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:59766/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59766/tests/dromaeo/cssquery-yui.html) 10:12:06 INFO - PROCESS | 11721 | RSS: Main: 153903104 10:12:06 INFO - PROCESS | 11721 | 10:15:08 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:59766/tests/dromaeo/cssquery-yui.html (next: http://localhost:59766/tests/dromaeo/cssquery-dojo.html) 10:15:08 INFO - PROCESS | 11721 | RSS: Main: 155332608 10:15:08 INFO - PROCESS | 11721 | 10:15:08 INFO - PROCESS | 11721 | __start_tp_report 10:15:08 INFO - PROCESS | 11721 | _x_x_mozilla_page_load 10:15:08 INFO - PROCESS | 11721 | _x_x_mozilla_page_load_details 10:15:08 INFO - PROCESS | 11721 | |i|pagename|runs| 10:15:08 INFO - PROCESS | 11721 | |0;dojo.html;3191.7127458528726;3239.4816829307315;3257.2671148991494;3292.5225842252876;3297.6702329767013;5316.255724198606;5459.3994660587305;5475.534579560732;5495.175723641456;5523.281973343464;5411.810586629459;5416.891662166764;5429.212764149196;5513.09034009389;5536.501714845663;4985.077760614289;5026.748662566875;5107;5110.872228194287;5130.179171332587;5088.160453525164;5113.054084994269;5122.974385128069;5127.154019586764;5149.974250128744;4951.900961980777;4975.402951645826;5044.596432285445;5101.183810590306;5159.871003224912;5080.542751152377;5094.414142373637;5103.132467480537;5105.030044291572;5105.642605017651;5072.0870243356185;5081.949180508184;5084.51697088776;5095.031943930641;5108.514691104339;5194.480551944813;5226.372835259755;5325.467453254682;5349.331333583302;5410.513053825135;5958.374370691102;5961.076033214816;5979.730912108966;6028.728707208143;6042.57701960863;5973.611715238496;6015.3383127855905;6023.668698221596;6024.879502409927;6035.909461358083;5440.292761940922;5478.233047373371;5526.281583394133;5544.528715059265;5551.111822108443;6047.334793172748;6068.362821903725;6077.483413909778;6077.574569780073;6111.786087486917;5893.204417403681;5895.086261629454;5898.351181370046;5899.646021238654;5915.438033386821;5803.303603567514;5894.705264736746;5904.1734157218025;5908.4091590841435;5981.760729570856;5868.031774757117;5889.646621202742;5910.704464776744;5935.910961335583;5993.520518358608;5859.267591551056;5986.161937328778;6014.428629280212;6028.728707208186;6044.969775151096;4416.867493975186;4542.545745425497;4548.704334218265;4553.33976573395;4589.770511474413;3975.5626881043063;4034.1931613677384;4053.2704113259306;4054;4055.128147448254;5621.353544342372;5674.517665998354;5684.971575142098;5720.542356611461;5745.080787074048;5857.062869940874;6070.998285282967;6107.4197951194565;6108.389161083945;6121.418465245794;5507.173923911365;5591.133374326904;5618.269624948731;5619.690916999522;5629.971850140805;5190.506901844319;5190.948090519122;5250.711210883438;5254.185601231815;5258.1849813279005;5817.301923769175;6119;6144.8771024579255;6163.414475624809;6168.0439531872635;5864.589478736448;5951.345352011189;5992.161097446448;6097.176881120992;6109.20580324555;5965.612235204698;6116.694165291807;6139.785107521216;6140.815775526741;6154.599951003171;5814.127880817742;5975.193348898017;5985.940140598713;5991.910121348271;5996.340402555803;5920.940790592039;5934.792282270272;5973.432523910222;6025.1564780931585;6061.848453788691;5804.767809287581;5854.795082172103;5862.706864656665;5863.501602363847;5868.618539794899;5768.798092066758;5790.24726785532;5839.124131380327;5854.531637469077;5859.882802344015;5747.798827041033;5792.8551786204;5794.971025144847;5807.738651760596;5856.648601083949;5879.794207202727;5895.616784908967;5910.172575839472;5925.703714814156;5929.080992446177;5651.547876169814;5673.092305231144;5759.481646651821;5771.971140144273;5779.7110144493445 10:15:08 INFO - PROCESS | 11721 | |1;ext.html;560.8906263278661;572.3332317849704;573.0430181596734;588.0913987888712;612.0543759890968;38277.80861095698;39957.20085598286;40061.39907901384;40073.1985360293;40097.59902400975;41919.790401047954;42273.57726422735;42464;42466.150676986515;42468.575314246846;8651.221390074908;8771.254443372321;8804;8811.339149563777;8827.073157318486;8439.409241353107;8536.78658033548;8567.443116197428;8578.18507241811;8589.656413743443;8630.697925572606;8714.782130446727;8742.388032837704;8747.431416957877;8747.431416957908;8578.571071446402;8614.05245423003;8653.740387788377;8671.046184919654;8680.565971701453;8545.359098067669;8620.396572239946;8636.956815215946;8646.437981531244;8689.348298877609;38260.61739382598;38527;38802.417963730564;38910.22179556393;38979.8051009746;2772.5979732938613;3193.984030079858;3293.5059741038795;3306.7519936004896;3925.823337949799;26185.607215891778;26254.6061809073;26607.600885986725;26698.199054028217;27121.05076322339;3835.7314987950854;3883.0680636647285;3901.843926242947;3922.666573341269;3936.2127574485216;244821;245307;245780;246616;246759;39784.60215397867;40388;40412.393814092815;40470.59529404727;40514.59485405167;40114.19771604551;40364.394534082014;40398.79800600978;40424.191516169514;40451;13299;13300.201987880759;13316.933415333055;13389.129706569041;13396.196228226338;10823.621173258898;10868.293560918515;10881.619143329945;11034.944825275823;11217.102631789438;13946.232957187249;13948.86051139496;13977.860221397656;14063.226522541154;14105.506307279196;5579;5620.831375058755;5640.210370548045;5904;6102.298235702862;908.1508789282043;940.849464085743;948.0756262644005;950.458238803889;964.2575217082947;24771.380715481897;25670.614940775904;25742.663251089885;25908.35229119287;25930.611040834403;1017.801528701896;1052.4474650808233;1072;1133.3879704959395;1140.5209811878865;13751.931240343934;13837.792433113511;16204.513864584082;16420.343186272654;16436.917815410845;402986;405406;405778;407202;410496;52157.47842521526;52822.47177528252;52949.2057619136;53252;53346.46653533415;1226.3071364678929;1244.595506460404;1252.7494501099816;1254.6612414647993;1265.1333836322149;27804.72195278021;28654;29019.12942611725;29035.854820725763;29185.85407072951;46371;47475.28787068128;47610.285845713035;47621.76189119171;47660.52339476561;238774;241957;242006;242232;242307;36372.818135909154;44464;44631.77684111689;45126.584809823034;45381.319280211486;40620;41171.38242926299;41371.58628413677;41400.37899431571;41964.58035419607;30824.53763193509;31215.84392078025;31563.684363156073;31599;31694;35541.28917421585;39922.800385997885;40604.79697601493;41381.37927931023;42259.577404226795;32172.356552869278;36435.63564364429;37195.25609487849;37331.440028399054;37411;30488.84755576208;32950.34099318048;33058.669413306525;33390.499142512395;33395.165120872174;23453.648195277427;23593;23778.881105595054;27551.862240688668;27931.44137117287 10:15:08 INFO - PROCESS | 11721 | |2;jquery.html;354.893531940418;357.47094300435356;358.48199351936444;358.5894151196878;361.73412541781784;13551.390187441564;14737;17065;17595.472135835913;18304.542386440346;16116.75824862628;16191.676166476664;16372.83627163728;16383.344666213367;16750.83249167511;4854.247591623304;4928.457869634337;4972.105021096201;4972.353594032771;4977.402711674604;4480.372747815309;4916.532929371704;4930.457649658535;4948.554630083292;5311;5373.086575282192;5383.219433182187;5383.300170977787;5399.433059528732;5401.4868587484325;4854.538818812207;4943.802247910079;5339.5728341732765;5382.058139825534;5385.3268341457315;4669.836555720533;4708.529147085298;4715.127701375257;4715.740634265114;4739.64452666048;12572.497100115985;12602.558910438182;19955.501112472306;20710.68933965992;20775.792242077536;2029.6448121578665;2125.0012494127736;2210.789974952393;2285.3829466044076;2433.5254625348066;9527.190188833958;9640.614375425044;9923;10803.5678572857;13595.660108497366;1839.448165550343;1855;1868.2900497810745;1871.4946964319693;1904.114586717183;59325.89851220776;60244;61371.38628613746;61494;62046.68976655133;9628.71113866585;9992.950035249778;10003.79954405476;10142.340747851513;10167;12700.872991270155;13027.218366898016;13040.347982601023;13060.934695326652;13159.802602960963;7296.489245752852;7423.628818559158;7443.776686699408;7547.622618869034;7577.810554736176;7142.073723988659;7148.678309476086;7186.389156921616;7356.411487081128;7474.103107627011;4384.254676704968;4412.161689279091;4419.0719948810465;4435.866923992286;4438;1839.2551016838202;1850.12119243361;1884.9528761780791;1890.9621807563772;1894.7347371368019;907.6596276396351;933.5798890499302;952.7999120184838;958.6500927161536;1044.968650940473;15290.847091528942;16093;16437;17533;17986.820131798515;781.5935713428985;896.4442045931564;916.9546716742918;928.6285485805731;968.4867020479157;8646.697365592174;8947.19475247231;9153.267738580898;9171.40385874916;9185.989541150468;395108;407165;407209;531114;544069;78722.60638696884;78893.60553197197;80845.19154808494;82481;82886.58556707177;1087.0542627913765;1124.707576030238;1127.5377095391013;1137.2778285788418;1148.7243061665308;14684.706305874037;15301.693966120838;15367.308471118602;15412.46056388021;15753.369865205263;30664.386712266078;34346.82826585851;35060;35613.82193089018;35926.461103082955;43915.12169756651;45030;45708;47023.52976470192;47776.28335575038;8869.157430044394;9224.631014759334;9356.719298421058;9372.812543749224;9391.342606017513;10743.462826858782;13343.399547020214;16214.270357834162;16726;16816.495505134866;13057.151285166434;13098.934505327412;13105.27920964356;13733.313334333443;13767.518136865161;14000.789988149982;14502.1298722077;14585.416583336548;14610.415583376545;15025.699486010437;13415.731685366432;13725.656858578615;13888.930555347159;14273;14556.344964476835;9123.582805784274;9184.632614695605;9216.124468175512;9622.711318660451;9839.508024598885;9616.471094089893;9789.46157961319;9818.45998470091;13664.098338752328;13766.105203161762 10:15:08 INFO - PROCESS | 11721 | |3;mootools.html;1342.8455727591327;1373.23785299159;1403.9508617198394;1469.8089248397707;1511.4936496273747;6802.557833740803;6893.655317234131;7326.157491888434;7717.614119294034;7721.420893432994;7212.639368031603;7324.853502929938;7429.739959101433;7439.256074392558;7455.813604659887;2240.1599400224914;2295.517941232343;2297.597920363938;2298.184144628658;2300.447892505795;2310.9653355199684;2316.5830150572892;2356.493353928905;2358.5636657218383;2360.3745007573007;2254.6279863822533;2258.8192944564394;2276.64711969645;2281.2927992322434;2296.8851557422145;2219.9223027194053;2222.288867562381;2226.832987525942;2234.553089382122;2236.105557776902;2302.07916833268;2335.97664023361;2336.5910965581124;2336.7429582745885;2342.8008619267384;7382.077240344957;7398.926010739878;7471;7486.475946683734;7503.249675032508;4545.681802273843;4589.403377560929;4624.09830083134;4633.698809577367;4634;2944.8085874418093;2951.8671659775364;3009.368032713133;3021.6978302169828;3055.908322750321;977.154761131616;993.3791380387258;1003.9698809035741;1049.632628579991;1062.4315990944885;9940.652077177265;9980.900190998069;10037.096661300446;10049.547770350351;10056.74858128538;4138.8344466221615;4224.7253928495165;4243.681723870722;4270.743755374688;4283.550227226158;8687.391882568287;8714.17215364552;8736.344774141964;8748.606312715943;8748.69379571712;4578.313253012075;4583.564561366665;4630.814767409333;4639.907201855944;4656.464506581787;4137.379393091061;4230.70385073042;4242.618164365222;4267.893302667396;4269.743815371087;3631.5460567429072;3635.5092062571744;3651.5253017107607;3666.6150054244454;3672.908177295589;1098.0940723902813;1120.2774210634095;1140.8573928258968;1148.9885101149048;1153.2503872482785;959.1080295325274;1003.7340104872214;1167.0197034491068;1172.4782471799967;1172.9061675066146;6870.106886104774;6929.480288978347;6934.826629334307;6936.895946560806;6987.615681137485;1165.056304393444;1209.1415095282448;1221.7617564574823;1223.247702662856;1225.6506895534908;5448.645838020516;5473.124300112043;5505.9724701376235;5512.118061110203;5516.668999860021;8691.869621955675;8907.242884354773;8919.643214271357;9093.272538197061;9102.180803727697;8953.641854325753;8997.775055623662;9012.18890299863;9081.77295567603;9095.36332456735;7101.218865924744;7279.490435669452;7353.595552244571;7364.77905662831;7390.963045184847;7136.357727804315;7213.20654727969;7250.3112204340505;7273.854522909618;7286.854262914818;8056.798580035546;8250.54621995796;8274.338052955629;8306.501609903426;8314.708985185489;8268.421210515206;8334.62494187751;8374.07885132647;8377.623006964579;8415.95792021036;6043.939560604514;6170.784022559189;6580.979948108051;6875.965620171867;6964.686589103604;7130.643467826691;7138.571685698875;7150.356467917913;7154.928450715426;7176.569405835667;6669.7332106715185;6878.793636190922;6879.6560171992205;6900;7037.859242815218;6828.692708828015;6833.214180369321;6854.554453960476;6906.689198985957;6952.478564107611;6717.1267735194115;6721.529492935643;6789.592624442549;6804;6812.523123381316;6357.046443033582;6364.4908407326375;6401.487880969418;6403.8719225614295;6416.262129855127;6307.590006649553;6324.968375158279;6385.7126429309865;6389.904151437825;6409.102725618324 10:15:08 INFO - PROCESS | 11721 | |4;prototype.html;319.59571142504734;321.2562916847498;325.414254342184;327.46296074437925;330.4827944267223;6134.631922084673;6180.165677633524;6202.844928876781;6208.099825525296;6312.116303717483;6028.819135425944;6144.53915956304;6177.9382206177925;6185.536084793636;6208;4737.976310118444;4759.500252473493;4762.714237145765;4771.475137734847;4773.307870358787;4765.69023013503;4766.285057241407;4768;4770.809167633308;4771.141194584973;4629.189891768944;4705.294205869112;4723.669343145981;4733.313669517918;4737.384140061788;4707.529247075282;4708.387909571751;4709.45841228258;4715.174844402216;4730.597899178574;3963.2271707017144;4063.7561746295023;4099.733517321394;4113.958860411388;4117.56765539617;5877.823665290048;5881.3530511643685;5916.497097746696;5938.346781853993;5973.8805223895715;5420.051490989101;5453.618246722731;5471.124620060811;5473.589480788957;5475.534579560742;6638.336166383371;6639.203295604559;6652.268250492442;6653.600783952978;6654.933450665529;4351.151525452538;4479.216137176014;4482.5069242383315;4487.865364039084;4498.730076195438;6862.416694580967;6913.89629155563;6923.446124310043;6930.965345173242;6939.583624982517;4570.3829982951875;4575.679702420865;4579.06129243511;4581.748003859753;4588.426446694163;4566.478305245104;4569.109023740405;4633.837815676435;4646.884747660537;4653.092646933816;5436.646617969898;5441.646292991022;5444.101723215705;5448.863778405572;5450.836474905759;6695.12963314766;6699.464042876558;6704.296048914891;6717.664116794141;6735.932640673628;1617.5551723275958;1628.5928517870532;1635.7709920611123;1638.565780068283;1640.5898525368657;1058.1799105692996;1059.7244716373643;1070.1011150633349;1085.0451602589671;1092.9125669946545;6426.389492998158;6467;6467.676616169267;6475.32009139043;6479.384458476437;6939.479539034593;6940.895886561706;6947.4789390795895;6949.861002779916;6958.199807022257;6322.715477803418;6403.423691867754;6412.4549413299455;6440.903386449207;6446.129772480655;3798.848046078181;3827.0432391902023;3827.6363745444137;3828.7319887608155;3835.386338185877;6951.165860096719;7124.073870396919;7144.571325720473;7158.391536719437;7159.355657990805;7202.135743710788;7204.9639751800905;7207;7212.783616491513;7218.963905180441;6987.510874238857;7046.471514636422;7082.256363081905;7096.07750992378;7138.214796372395;6982.7206911725;7007.124109486314;7025.929740702528;7046.436285097077;7048.224695283412;6940.7917762467205;6943.618101004493;6949.30506949301;6950.20072691647;6962.965185174042;6919.446444284546;7099.148102227766;7104.786856394317;7142.535735177197;7145.428365730625;4575.359449676981;4603.884902877455;4612.285095810154;4620.09908067937;4626.259798432235;6933.168019837652;6945.131858517685;6970.407515361251;6974.58152510851;7003.439724822104;6654.168228971379;6795.048693183057;6819.761308354184;6823.1812182538415;6824.112865327475;6796.286389928986;6798;6802.693878775566;6806.897896531655;6834.692438840363;6633.2040155181685;6677.69950352245;6686.398224159849;6687.498437617295;6709.530332876652;6650.268470468342;6738.09035780183;6812.693428795816;6829;6829.692663830239;6663.566868153554;6681;6691.832704182434;6695.296993815579;6707.429868461236 10:15:08 INFO - PROCESS | 11721 | |5;yui.html;730.5397599512308;766.896468976688;817.5094943034184;819.0376307838288;830.4685001598974;12416.937915310422;12646.747065058693;12655.493780248778;12657;12664.366781660914;12768.42542085606;12881.420336084875;12883.871161288407;12888.74222515549;12901.5484458044;802.6628815897323;819.0294501016315;822.4448497264323;824.3734761581211;825.8637324841394;799.2207597592359;806.2904643913348;811.6266517401973;813.259933460551;814.42989907065;836.5399030533213;837.3887062444419;840.6889450903175;840.848647243496;843.3084870406269;831.6216121664659;834.2241715204857;834.837206744685;835.5028757889046;835.778518692547;614.0298328640781;615.4245780195531;615.9753609855601;616.7255571270787;617.7621615677996;13358.599242022754;13426.798598021038;13431.3955871986;13495.055346125775;13532.255725935069;11564.710882227928;11635.301881887113;11852.525898964032;11868.821967670492;12300;10121.1903047756;10174.135198508136;10192.949035254851;10252.282340236186;10279.486025698685;3490.703290220334;3492.807895565743;3531.5055892175114;3541.557305336833;3580.838862251205;44752.3287150693;45364;45444.318335225;45502.77248613736;45834.54165458336;8643.30853531716;8820.426672266281;9147.405418647899;9222;9429;16611.916940415464;16629.50111496657;16716;16745.162741863103;16758.74861877073;7301.744438944612;7306.305900939402;7479.401647868158;7564.054493188351;7568.205338439495;4190.306008487839;4221.641160501392;4263.637590804817;4407.360932664746;4433.844815431445;2795.077624383948;2810.690824009357;2814.733369983516;2817.7323154300307;2823.124831302303;521.1176733336657;528.8915772266677;538.2867700297122;550.1445252632195;553.4133818152771;581.5492992930513;637.2098597738864;669.4610838275138;676.35746041261;678.2403707847243;8327.458715183493;8503.74488765338;8517.787055323543;8641.30869530436;8725.52009639476;655.8393193667582;657.375493281375;674.1101745695635;690.6684791300204;718.8454482286334;4020.1356708307853;4064.7357921734992;4207.037353180491;4207.410962465257;4258.518031742254;54685.179722304194;55807.720961395746;55980;56701.43298566961;56872.71563642238;49376.50623493791;50176.498235017185;50523.24215136776;51951;52561.47438525642;45821.77089114533;45887.54112458833;45889.770551147696;45915.77042114768;46129.538704613195;8077.434579579373;8212.096669366485;8362.247397734232;8898.644054237759;8950.373473857027;33577.16057098592;33688.326233474705;34472.65527344795;34690.47964280487;34763;43328.78335608302;43494.78252608717;43938.78030609826;44488.33267501055;45130.54869451263;11032.393218373067;11099.445027748741;11100.222984391015;11108.666739997812;11589.942050289694;12371.195872268274;12381.814272786096;12432;12454.49908131477;12627.305498197687;11203.383813890314;11403.543858245908;11482;11832.70418239551;11862.584809531625;11689.473973671375;11868.169228153947;12350.75298494043;12403.813942791046;12417.875821241672;9851.753706157404;10956.780864382827;11223.66329010131;11482.13883958723;11783.057355411718;9372.906270937476;9431.481268530297;9462.763430914281;9674.22606191489;9783.46190959504;8732;8820.74673093572;8821.250193733347;9020.278377729635;9737.07497787709 10:15:08 INFO - PROCESS | 11721 | __end_tp_report 10:15:08 INFO - PROCESS | 11721 | __start_cc_report 10:15:08 INFO - PROCESS | 11721 | _x_x_mozilla_cycle_collect,314 10:15:08 INFO - PROCESS | 11721 | __end_cc_report 10:15:08 INFO - PROCESS | 11721 | __startTimestamp1450721708952__endTimestamp 10:15:08 INFO - PROCESS | 11721 | 10:15:08 INFO - PROCESS | 11721 | ------- Summary: start ------- 10:15:08 INFO - PROCESS | 11721 | Number of tests: 6 10:15:08 INFO - PROCESS | 11721 | 10:15:08 INFO - PROCESS | 11721 | [#0] dojo.html Cycles:165 Average:5532.08 Median:5790.25 stddev:630.27 (10.9%) stddev-sans-first:604.87 10:15:08 INFO - PROCESS | 11721 | Values: 3191.7 3239.5 3257.3 3292.5 3297.7 5316.3 5459.4 5475.5 5495.2 5523.3 5411.8 5416.9 5429.2 5513.1 5536.5 4985.1 5026.7 5107.0 5110.9 5130.2 5088.2 5113.1 5123.0 5127.2 5150.0 4951.9 4975.4 5044.6 5101.2 5159.9 5080.5 5094.4 5103.1 5105.0 5105.6 5072.1 5081.9 5084.5 5095.0 5108.5 5194.5 5226.4 5325.5 5349.3 5410.5 5958.4 5961.1 5979.7 6028.7 6042.6 5973.6 6015.3 6023.7 6024.9 6035.9 5440.3 5478.2 5526.3 5544.5 5551.1 6047.3 6068.4 6077.5 6077.6 6111.8 5893.2 5895.1 5898.4 5899.6 5915.4 5803.3 5894.7 5904.2 5908.4 5981.8 5868.0 5889.6 5910.7 5935.9 5993.5 5859.3 5986.2 6014.4 6028.7 6045.0 4416.9 4542.5 4548.7 4553.3 4589.8 3975.6 4034.2 4053.3 4054.0 4055.1 5621.4 5674.5 5685.0 5720.5 5745.1 5857.1 6071.0 6107.4 6108.4 6121.4 5507.2 5591.1 5618.3 5619.7 5630.0 5190.5 5190.9 5250.7 5254.2 5258.2 5817.3 6119.0 6144.9 6163.4 6168.0 5864.6 5951.3 5992.2 6097.2 6109.2 5965.6 6116.7 6139.8 6140.8 6154.6 5814.1 5975.2 5985.9 5991.9 5996.3 5920.9 5934.8 5973.4 6025.2 6061.8 5804.8 5854.8 5862.7 5863.5 5868.6 5768.8 5790.2 5839.1 5854.5 5859.9 5747.8 5792.9 5795.0 5807.7 5856.6 5879.8 5895.6 5910.2 5925.7 5929.1 5651.5 5673.1 5759.5 5772.0 5779.7 10:15:08 INFO - PROCESS | 11721 | 10:15:08 INFO - PROCESS | 11721 | [#1] ext.html Cycles:180 Average:45551.15 Median:3924.24 stddev:81003.07 (2064.2%) stddev-sans-first:81159.87 10:15:08 INFO - PROCESS | 11721 | Values: 560.9 572.3 573.0 588.1 612.1 38277.8 39957.2 40061.4 40073.2 40097.6 41919.8 42273.6 42464.0 42466.2 42468.6 8651.2 8771.3 8804.0 8811.3 8827.1 8439.4 8536.8 8567.4 8578.2 8589.7 8630.7 8714.8 8742.4 8747.4 8747.4 8578.6 8614.1 8653.7 8671.0 8680.6 8545.4 8620.4 8637.0 8646.4 8689.3 38260.6 38527.0 38802.4 38910.2 38979.8 2772.6 3194.0 3293.5 3306.8 3925.8 26185.6 26254.6 26607.6 26698.2 27121.1 3835.7 3883.1 3901.8 3922.7 3936.2 244821.0 245307.0 245780.0 246616.0 246759.0 39784.6 40388.0 40412.4 40470.6 40514.6 40114.2 40364.4 40398.8 40424.2 40451.0 13299.0 13300.2 13316.9 13389.1 13396.2 10823.6 10868.3 10881.6 11034.9 11217.1 13946.2 13948.9 13977.9 14063.2 14105.5 5579.0 5620.8 5640.2 5904.0 6102.3 908.2 940.8 948.1 950.5 964.3 24771.4 25670.6 25742.7 25908.4 25930.6 1017.8 1052.4 1072.0 1133.4 1140.5 13751.9 13837.8 16204.5 16420.3 16436.9 402986.0 405406.0 405778.0 407202.0 410496.0 52157.5 52822.5 52949.2 53252.0 53346.5 1226.3 1244.6 1252.7 1254.7 1265.1 27804.7 28654.0 29019.1 29035.9 29185.9 46371.0 47475.3 47610.3 47621.8 47660.5 238774.0 241957.0 242006.0 242232.0 242307.0 36372.8 44464.0 44631.8 45126.6 45381.3 40620.0 41171.4 41371.6 41400.4 41964.6 30824.5 31215.8 31563.7 31599.0 31694.0 35541.3 39922.8 40604.8 41381.4 42259.6 32172.4 36435.6 37195.3 37331.4 37411.0 30488.8 32950.3 33058.7 33390.5 33395.2 23453.6 23593.0 23778.9 27551.9 27931.4 10:15:08 INFO - PROCESS | 11721 | 10:15:08 INFO - PROCESS | 11721 | [#2] jquery.html Cycles:180 Average:26211.18 Median:205796.63 stddev:75703.13 (36.8%) stddev-sans-first:75890.60 10:15:08 INFO - PROCESS | 11721 | Values: 354.9 357.5 358.5 358.6 361.7 13551.4 14737.0 17065.0 17595.5 18304.5 16116.8 16191.7 16372.8 16383.3 16750.8 4854.2 4928.5 4972.1 4972.4 4977.4 4480.4 4916.5 4930.5 4948.6 5311.0 5373.1 5383.2 5383.3 5399.4 5401.5 4854.5 4943.8 5339.6 5382.1 5385.3 4669.8 4708.5 4715.1 4715.7 4739.6 12572.5 12602.6 19955.5 20710.7 20775.8 2029.6 2125.0 2210.8 2285.4 2433.5 9527.2 9640.6 9923.0 10803.6 13595.7 1839.4 1855.0 1868.3 1871.5 1904.1 59325.9 60244.0 61371.4 61494.0 62046.7 9628.7 9993.0 10003.8 10142.3 10167.0 12700.9 13027.2 13040.3 13060.9 13159.8 7296.5 7423.6 7443.8 7547.6 7577.8 7142.1 7148.7 7186.4 7356.4 7474.1 4384.3 4412.2 4419.1 4435.9 4438.0 1839.3 1850.1 1885.0 1891.0 1894.7 907.7 933.6 952.8 958.7 1045.0 15290.8 16093.0 16437.0 17533.0 17986.8 781.6 896.4 917.0 928.6 968.5 8646.7 8947.2 9153.3 9171.4 9186.0 395108.0 407165.0 407209.0 531114.0 544069.0 78722.6 78893.6 80845.2 82481.0 82886.6 1087.1 1124.7 1127.5 1137.3 1148.7 14684.7 15301.7 15367.3 15412.5 15753.4 30664.4 34346.8 35060.0 35613.8 35926.5 43915.1 45030.0 45708.0 47023.5 47776.3 8869.2 9224.6 9356.7 9372.8 9391.3 10743.5 13343.4 16214.3 16726.0 16816.5 13057.2 13098.9 13105.3 13733.3 13767.5 14000.8 14502.1 14585.4 14610.4 15025.7 13415.7 13725.7 13888.9 14273.0 14556.3 9123.6 9184.6 9216.1 9622.7 9839.5 9616.5 9789.5 9818.5 13664.1 13766.1 10:15:08 INFO - PROCESS | 11721 | 10:15:08 INFO - PROCESS | 11721 | [#3] mootools.html Cycles:180 Average:5305.16 Median:6375.10 stddev:2688.97 (42.2%) stddev-sans-first:2680.01 10:15:08 INFO - PROCESS | 11721 | Values: 1342.8 1373.2 1404.0 1469.8 1511.5 6802.6 6893.7 7326.2 7717.6 7721.4 7212.6 7324.9 7429.7 7439.3 7455.8 2240.2 2295.5 2297.6 2298.2 2300.4 2311.0 2316.6 2356.5 2358.6 2360.4 2254.6 2258.8 2276.6 2281.3 2296.9 2219.9 2222.3 2226.8 2234.6 2236.1 2302.1 2336.0 2336.6 2336.7 2342.8 7382.1 7398.9 7471.0 7486.5 7503.2 4545.7 4589.4 4624.1 4633.7 4634.0 2944.8 2951.9 3009.4 3021.7 3055.9 977.2 993.4 1004.0 1049.6 1062.4 9940.7 9980.9 10037.1 10049.5 10056.7 4138.8 4224.7 4243.7 4270.7 4283.6 8687.4 8714.2 8736.3 8748.6 8748.7 4578.3 4583.6 4630.8 4639.9 4656.5 4137.4 4230.7 4242.6 4267.9 4269.7 3631.5 3635.5 3651.5 3666.6 3672.9 1098.1 1120.3 1140.9 1149.0 1153.3 959.1 1003.7 1167.0 1172.5 1172.9 6870.1 6929.5 6934.8 6936.9 6987.6 1165.1 1209.1 1221.8 1223.2 1225.7 5448.6 5473.1 5506.0 5512.1 5516.7 8691.9 8907.2 8919.6 9093.3 9102.2 8953.6 8997.8 9012.2 9081.8 9095.4 7101.2 7279.5 7353.6 7364.8 7391.0 7136.4 7213.2 7250.3 7273.9 7286.9 8056.8 8250.5 8274.3 8306.5 8314.7 8268.4 8334.6 8374.1 8377.6 8416.0 6043.9 6170.8 6581.0 6876.0 6964.7 7130.6 7138.6 7150.4 7154.9 7176.6 6669.7 6878.8 6879.7 6900.0 7037.9 6828.7 6833.2 6854.6 6906.7 6952.5 6717.1 6721.5 6789.6 6804.0 6812.5 6357.0 6364.5 6401.5 6403.9 6416.3 6307.6 6325.0 6385.7 6389.9 6409.1 10:15:08 INFO - PROCESS | 11721 | 10:15:08 INFO - PROCESS | 11721 | [#4] prototype.html Cycles:180 Average:5570.44 Median:6363.07 stddev:1724.30 (27.1%) stddev-sans-first:1683.49 10:15:08 INFO - PROCESS | 11721 | Values: 319.6 321.3 325.4 327.5 330.5 6134.6 6180.2 6202.8 6208.1 6312.1 6028.8 6144.5 6177.9 6185.5 6208.0 4738.0 4759.5 4762.7 4771.5 4773.3 4765.7 4766.3 4768.0 4770.8 4771.1 4629.2 4705.3 4723.7 4733.3 4737.4 4707.5 4708.4 4709.5 4715.2 4730.6 3963.2 4063.8 4099.7 4114.0 4117.6 5877.8 5881.4 5916.5 5938.3 5973.9 5420.1 5453.6 5471.1 5473.6 5475.5 6638.3 6639.2 6652.3 6653.6 6654.9 4351.2 4479.2 4482.5 4487.9 4498.7 6862.4 6913.9 6923.4 6931.0 6939.6 4570.4 4575.7 4579.1 4581.7 4588.4 4566.5 4569.1 4633.8 4646.9 4653.1 5436.6 5441.6 5444.1 5448.9 5450.8 6695.1 6699.5 6704.3 6717.7 6735.9 1617.6 1628.6 1635.8 1638.6 1640.6 1058.2 1059.7 1070.1 1085.0 1092.9 6426.4 6467.0 6467.7 6475.3 6479.4 6939.5 6940.9 6947.5 6949.9 6958.2 6322.7 6403.4 6412.5 6440.9 6446.1 3798.8 3827.0 3827.6 3828.7 3835.4 6951.2 7124.1 7144.6 7158.4 7159.4 7202.1 7205.0 7207.0 7212.8 7219.0 6987.5 7046.5 7082.3 7096.1 7138.2 6982.7 7007.1 7025.9 7046.4 7048.2 6940.8 6943.6 6949.3 6950.2 6963.0 6919.4 7099.1 7104.8 7142.5 7145.4 4575.4 4603.9 4612.3 4620.1 4626.3 6933.2 6945.1 6970.4 6974.6 7003.4 6654.2 6795.0 6819.8 6823.2 6824.1 6796.3 6798.0 6802.7 6806.9 6834.7 6633.2 6677.7 6686.4 6687.5 6709.5 6650.3 6738.1 6812.7 6829.0 6829.7 6663.6 6681.0 6691.8 6695.3 6707.4 10:15:08 INFO - PROCESS | 11721 | 10:15:08 INFO - PROCESS | 11721 | [#5] yui.html Cycles:180 Average:13502.70 Median:45888.66 stddev:15572.81 (33.9%) stddev-sans-first:15586.96 10:15:08 INFO - PROCESS | 11721 | Values: 730.5 766.9 817.5 819.0 830.5 12416.9 12646.7 12655.5 12657.0 12664.4 12768.4 12881.4 12883.9 12888.7 12901.5 802.7 819.0 822.4 824.4 825.9 799.2 806.3 811.6 813.3 814.4 836.5 837.4 840.7 840.8 843.3 831.6 834.2 834.8 835.5 835.8 614.0 615.4 616.0 616.7 617.8 13358.6 13426.8 13431.4 13495.1 13532.3 11564.7 11635.3 11852.5 11868.8 12300.0 10121.2 10174.1 10192.9 10252.3 10279.5 3490.7 3492.8 3531.5 3541.6 3580.8 44752.3 45364.0 45444.3 45502.8 45834.5 8643.3 8820.4 9147.4 9222.0 9429.0 16611.9 16629.5 16716.0 16745.2 16758.7 7301.7 7306.3 7479.4 7564.1 7568.2 4190.3 4221.6 4263.6 4407.4 4433.8 2795.1 2810.7 2814.7 2817.7 2823.1 521.1 528.9 538.3 550.1 553.4 581.5 637.2 669.5 676.4 678.2 8327.5 8503.7 8517.8 8641.3 8725.5 655.8 657.4 674.1 690.7 718.8 4020.1 4064.7 4207.0 4207.4 4258.5 54685.2 55807.7 55980.0 56701.4 56872.7 49376.5 50176.5 50523.2 51951.0 52561.5 45821.8 45887.5 45889.8 45915.8 46129.5 8077.4 8212.1 8362.2 8898.6 8950.4 33577.2 33688.3 34472.7 34690.5 34763.0 43328.8 43494.8 43938.8 44488.3 45130.5 11032.4 11099.4 11100.2 11108.7 11589.9 12371.2 12381.8 12432.0 12454.5 12627.3 11203.4 11403.5 11482.0 11832.7 11862.6 11689.5 11868.2 12350.8 12403.8 12417.9 9851.8 10956.8 11223.7 11482.1 11783.1 9372.9 9431.5 9462.8 9674.2 9783.5 8732.0 8820.7 8821.3 9020.3 9737.1 10:15:08 INFO - PROCESS | 11721 | -------- Summary: end -------- 10:15:08 INFO - PROCESS | 11721 | 10:15:09 INFO - TEST-INFO | 11721: exit 0 10:15:09 INFO - TEST-OK | dromaeo_css | took 1110783ms 10:15:09 INFO - TEST-START | kraken 10:15:09 INFO - operating with platform_type : linux_ 10:15:09 INFO - Initialising browser for kraken test... 10:15:09 INFO - TEST-INFO | started process 11960 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAmO351/profile http://localhost:59766/getInfo.html) 10:15:13 INFO - PROCESS | 11960 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 10:15:13 INFO - PROCESS | 11960 | __metrics Screen width/height:1600/1200 10:15:13 INFO - PROCESS | 11960 | colorDepth:24 10:15:13 INFO - PROCESS | 11960 | Browser inner width/height: 1024/697 10:15:13 INFO - PROCESS | 11960 | __metrics 10:15:14 INFO - PROCESS | 11960 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:15:14 INFO - TEST-INFO | 11960: exit 0 10:15:14 INFO - Browser initialized. 10:15:14 INFO - Running cycle 1/1 for kraken test... 10:15:14 INFO - TEST-INFO | started process 12083 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAmO351/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:26 INFO - PROCESS | 12083 | RSS: Main: 151179264 10:15:26 INFO - PROCESS | 12083 | 10:15:29 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59766/tests/kraken/driver.html?testName=audio-beat-detection) 10:15:29 INFO - PROCESS | 12083 | RSS: Main: 153100288 10:15:29 INFO - PROCESS | 12083 | 10:15:32 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59766/tests/kraken/driver.html?testName=audio-dft) 10:15:33 INFO - PROCESS | 12083 | RSS: Main: 152154112 10:15:33 INFO - PROCESS | 12083 | 10:15:35 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59766/tests/kraken/driver.html?testName=audio-fft) 10:15:36 INFO - PROCESS | 12083 | RSS: Main: 147263488 10:15:36 INFO - PROCESS | 12083 | 10:15:38 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59766/tests/kraken/driver.html?testName=audio-oscillator) 10:15:39 INFO - PROCESS | 12083 | RSS: Main: 146186240 10:15:39 INFO - PROCESS | 12083 | 10:15:41 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59766/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:15:41 INFO - PROCESS | 12083 | RSS: Main: 147935232 10:15:41 INFO - PROCESS | 12083 | 10:15:44 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59766/tests/kraken/driver.html?testName=imaging-darkroom) 10:15:45 INFO - PROCESS | 12083 | RSS: Main: 147619840 10:15:45 INFO - PROCESS | 12083 | 10:15:48 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59766/tests/kraken/driver.html?testName=imaging-desaturate) 10:15:49 INFO - PROCESS | 12083 | RSS: Main: 147857408 10:15:49 INFO - PROCESS | 12083 | 10:15:52 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59766/tests/kraken/driver.html?testName=json-parse-financial) 10:15:52 INFO - PROCESS | 12083 | RSS: Main: 148021248 10:15:52 INFO - PROCESS | 12083 | 10:15:54 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59766/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:15:54 INFO - PROCESS | 12083 | RSS: Main: 148865024 10:15:54 INFO - PROCESS | 12083 | 10:15:56 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59766/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:15:57 INFO - PROCESS | 12083 | RSS: Main: 148545536 10:15:57 INFO - PROCESS | 12083 | 10:15:59 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59766/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:16:00 INFO - PROCESS | 12083 | RSS: Main: 148295680 10:16:00 INFO - PROCESS | 12083 | 10:16:02 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59766/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:16:03 INFO - PROCESS | 12083 | RSS: Main: 148430848 10:16:03 INFO - PROCESS | 12083 | 10:16:05 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59766/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:16:06 INFO - PROCESS | 12083 | RSS: Main: 150081536 10:16:06 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | Cycle 1(1): loaded http://localhost:59766/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59766/tests/kraken/driver.html?testName=ai-astar) 10:16:08 INFO - PROCESS | 12083 | RSS: Main: 148619264 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | __start_tp_report 10:16:08 INFO - PROCESS | 12083 | _x_x_mozilla_page_load 10:16:08 INFO - PROCESS | 12083 | _x_x_mozilla_page_load_details 10:16:08 INFO - PROCESS | 12083 | |i|pagename|runs| 10:16:08 INFO - PROCESS | 12083 | |0;ai-astar;112;109;113;113;113;123;113;113;112;113 10:16:08 INFO - PROCESS | 12083 | |1;audio-beat-detection;151;129;150;159;127;160;152;132;171;126 10:16:08 INFO - PROCESS | 12083 | |2;audio-dft;161;162;162;163;162;161;164;165;170;162 10:16:08 INFO - PROCESS | 12083 | |3;audio-fft;73;73;74;79;74;148;73;79;72;74 10:16:08 INFO - PROCESS | 12083 | |4;audio-oscillator;93;94;133;92;92;94;136;93;95;135 10:16:08 INFO - PROCESS | 12083 | |5;imaging-gaussian-blur;110;112;111;110;110;110;110;110;112;111 10:16:08 INFO - PROCESS | 12083 | |6;imaging-darkroom;147;147;147;147;146;147;147;148;146;146 10:16:08 INFO - PROCESS | 12083 | |7;imaging-desaturate;97;97;96;96;96;96;96;95;95;96 10:16:08 INFO - PROCESS | 12083 | |8;json-parse-financial;60;59;59;62;61;59;65;61;59;58 10:16:08 INFO - PROCESS | 12083 | |9;json-stringify-tinderbox;67;68;70;69;68;67;67;67;67;68 10:16:08 INFO - PROCESS | 12083 | |10;stanford-crypto-aes;83;86;87;86;88;86;84;92;94;86 10:16:08 INFO - PROCESS | 12083 | |11;stanford-crypto-ccm;127;116;126;121;118;132;120;134;123;122 10:16:08 INFO - PROCESS | 12083 | |12;stanford-crypto-pbkdf2;145;169;158;158;161;147;148;155;148;149 10:16:08 INFO - PROCESS | 12083 | |13;stanford-crypto-sha256-iterative;69;69;76;71;71;72;71;75;71;74 10:16:08 INFO - PROCESS | 12083 | __end_tp_report 10:16:08 INFO - PROCESS | 12083 | __start_cc_report 10:16:08 INFO - PROCESS | 12083 | _x_x_mozilla_cycle_collect,699 10:16:08 INFO - PROCESS | 12083 | __end_cc_report 10:16:08 INFO - PROCESS | 12083 | __startTimestamp1450721768337__endTimestamp 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | ------- Summary: start ------- 10:16:08 INFO - PROCESS | 12083 | Number of tests: 14 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.00 stddev:3.60 (3.2%) stddev-sans-first:3.78 10:16:08 INFO - PROCESS | 12083 | Values: 112.0 109.0 113.0 113.0 113.0 123.0 113.0 113.0 112.0 113.0 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:151.50 stddev:16.03 (10.6%) stddev-sans-first:16.89 10:16:08 INFO - PROCESS | 12083 | Values: 151.0 129.0 150.0 159.0 127.0 160.0 152.0 132.0 171.0 126.0 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:2.70 (1.7%) stddev-sans-first:2.74 10:16:08 INFO - PROCESS | 12083 | Values: 161.0 162.0 162.0 163.0 162.0 161.0 164.0 165.0 170.0 162.0 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#3] audio-fft Cycles:10 Average:81.90 Median:74.00 stddev:23.35 (31.6%) stddev-sans-first:24.55 10:16:08 INFO - PROCESS | 12083 | Values: 73.0 73.0 74.0 79.0 74.0 148.0 73.0 79.0 72.0 74.0 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#4] audio-oscillator Cycles:10 Average:105.70 Median:93.00 stddev:20.02 (21.5%) stddev-sans-first:20.70 10:16:08 INFO - PROCESS | 12083 | Values: 93.0 94.0 133.0 92.0 92.0 94.0 136.0 93.0 95.0 135.0 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:110.50 stddev:0.84 (0.8%) stddev-sans-first:0.87 10:16:08 INFO - PROCESS | 12083 | Values: 110.0 112.0 111.0 110.0 110.0 110.0 110.0 110.0 112.0 111.0 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 10:16:08 INFO - PROCESS | 12083 | Values: 147.0 147.0 147.0 147.0 146.0 147.0 147.0 148.0 146.0 146.0 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 10:16:08 INFO - PROCESS | 12083 | Values: 97.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.50 stddev:2.06 (3.4%) stddev-sans-first:2.18 10:16:08 INFO - PROCESS | 12083 | Values: 60.0 59.0 59.0 62.0 61.0 59.0 65.0 61.0 59.0 58.0 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 10:16:08 INFO - PROCESS | 12083 | Values: 67.0 68.0 70.0 69.0 68.0 67.0 67.0 67.0 67.0 68.0 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:86.50 stddev:3.39 (3.9%) stddev-sans-first:3.24 10:16:08 INFO - PROCESS | 12083 | Values: 83.0 86.0 87.0 86.0 88.0 86.0 84.0 92.0 94.0 86.0 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:124.50 stddev:5.84 (4.7%) stddev-sans-first:6.09 10:16:08 INFO - PROCESS | 12083 | Values: 127.0 116.0 126.0 121.0 118.0 132.0 120.0 134.0 123.0 122.0 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:156.50 stddev:7.70 (4.9%) stddev-sans-first:7.48 10:16:08 INFO - PROCESS | 12083 | Values: 145.0 169.0 158.0 158.0 161.0 147.0 148.0 155.0 148.0 149.0 10:16:08 INFO - PROCESS | 12083 | 10:16:08 INFO - PROCESS | 12083 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:71.50 stddev:2.38 (3.3%) stddev-sans-first:2.28 10:16:08 INFO - PROCESS | 12083 | Values: 69.0 69.0 76.0 71.0 71.0 72.0 71.0 75.0 71.0 74.0 10:16:08 INFO - PROCESS | 12083 | -------- Summary: end -------- 10:16:08 INFO - PROCESS | 12083 | 10:16:09 INFO - TEST-INFO | 12083: exit 0 10:16:09 INFO - TEST-OK | kraken | took 59603ms 10:16:09 INFO - TEST-START | v8_7 10:16:09 INFO - operating with platform_type : linux_ 10:16:09 INFO - Initialising browser for v8_7 test... 10:16:09 INFO - TEST-INFO | started process 12371 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiNS3EV/profile http://localhost:59766/getInfo.html) 10:16:12 INFO - PROCESS | 12371 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 10:16:13 INFO - PROCESS | 12371 | __metrics Screen width/height:1600/1200 10:16:13 INFO - PROCESS | 12371 | colorDepth:24 10:16:13 INFO - PROCESS | 12371 | Browser inner width/height: 1024/697 10:16:13 INFO - PROCESS | 12371 | __metrics 10:16:13 INFO - PROCESS | 12371 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:16:14 INFO - TEST-INFO | 12371: exit 0 10:16:14 INFO - Browser initialized. 10:16:14 INFO - Running cycle 1/1 for v8_7 test... 10:16:14 INFO - TEST-INFO | started process 12491 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiNS3EV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:26 INFO - PROCESS | 12491 | RSS: Main: 151007232 10:16:26 INFO - PROCESS | 12491 | 10:16:47 INFO - PROCESS | 12491 | Cycle 1(1): loaded http://localhost:59766/tests/v8_7/run.html (next: http://localhost:59766/tests/v8_7/run.html) 10:16:47 INFO - PROCESS | 12491 | RSS: Main: 147271680 10:16:47 INFO - PROCESS | 12491 | 10:16:47 INFO - PROCESS | 12491 | __start_tp_report 10:16:47 INFO - PROCESS | 12491 | _x_x_mozilla_page_load 10:16:47 INFO - PROCESS | 12491 | _x_x_mozilla_page_load_details 10:16:47 INFO - PROCESS | 12491 | |i|pagename|runs| 10:16:47 INFO - PROCESS | 12491 | |0;Richards;165.59032952475576 10:16:47 INFO - PROCESS | 12491 | |1;DeltaBlue;188.14675446848543 10:16:47 INFO - PROCESS | 12491 | |2;Encrypt;280.19052956010086 10:16:47 INFO - PROCESS | 12491 | |3;Decrypt;5196.891191709845 10:16:47 INFO - PROCESS | 12491 | |4;RayTrace;1071.8113612004288 10:16:47 INFO - PROCESS | 12491 | |5;Earley;698.3240223463687 10:16:47 INFO - PROCESS | 12491 | |6;Boyer;12219.512195121952 10:16:47 INFO - PROCESS | 12491 | |7;RegExp;26342.105263157893 10:16:47 INFO - PROCESS | 12491 | |8;Splay;571.7552887364208 10:16:47 INFO - PROCESS | 12491 | |9;NavierStokes;4835.748792270531 10:16:47 INFO - PROCESS | 12491 | __end_tp_report 10:16:47 INFO - PROCESS | 12491 | __startTimestamp1450721807950__endTimestamp 10:16:47 INFO - PROCESS | 12491 | 10:16:47 INFO - PROCESS | 12491 | ------- Summary: start ------- 10:16:47 INFO - PROCESS | 12491 | Number of tests: 10 10:16:47 INFO - PROCESS | 12491 | 10:16:47 INFO - PROCESS | 12491 | [#0] Richards Cycles:1 Average:165.59 Median:165.59 stddev:0.00 (0.0%) 10:16:47 INFO - PROCESS | 12491 | Values: 165.6 10:16:47 INFO - PROCESS | 12491 | 10:16:47 INFO - PROCESS | 12491 | [#1] DeltaBlue Cycles:1 Average:188.15 Median:188.15 stddev:0.00 (0.0%) 10:16:47 INFO - PROCESS | 12491 | Values: 188.1 10:16:47 INFO - PROCESS | 12491 | 10:16:47 INFO - PROCESS | 12491 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 10:16:47 INFO - PROCESS | 12491 | Values: 280.2 10:16:47 INFO - PROCESS | 12491 | 10:16:47 INFO - PROCESS | 12491 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 10:16:47 INFO - PROCESS | 12491 | Values: 5196.9 10:16:47 INFO - PROCESS | 12491 | 10:16:47 INFO - PROCESS | 12491 | [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 10:16:47 INFO - PROCESS | 12491 | Values: 1071.8 10:16:47 INFO - PROCESS | 12491 | 10:16:47 INFO - PROCESS | 12491 | [#5] Earley Cycles:1 Average:698.32 Median:698.32 stddev:0.00 (0.0%) 10:16:47 INFO - PROCESS | 12491 | Values: 698.3 10:16:47 INFO - PROCESS | 12491 | 10:16:47 INFO - PROCESS | 12491 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 10:16:47 INFO - PROCESS | 12491 | Values: 12219.5 10:16:47 INFO - PROCESS | 12491 | 10:16:47 INFO - PROCESS | 12491 | [#7] RegExp Cycles:1 Average:26342.11 Median:26342.11 stddev:0.00 (0.0%) 10:16:47 INFO - PROCESS | 12491 | Values: 26342.1 10:16:47 INFO - PROCESS | 12491 | 10:16:47 INFO - PROCESS | 12491 | [#8] Splay Cycles:1 Average:571.76 Median:571.76 stddev:0.00 (0.0%) 10:16:47 INFO - PROCESS | 12491 | Values: 571.8 10:16:47 INFO - PROCESS | 12491 | 10:16:47 INFO - PROCESS | 12491 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 10:16:47 INFO - PROCESS | 12491 | Values: 4835.7 10:16:47 INFO - PROCESS | 12491 | -------- Summary: end -------- 10:16:47 INFO - PROCESS | 12491 | 10:16:48 INFO - TEST-INFO | 12491: exit 0 10:16:48 INFO - TEST-OK | v8_7 | took 39545ms 10:16:48 INFO - SUITE-END | took 1209s 10:16:48 INFO - Completed test suite (00:20:10) 10:16:48 INFO - Working with test: dromaeo_css 10:16:48 INFO - Generating results file: dromaeo_css 10:16:48 INFO - Working with test: kraken 10:16:48 INFO - Generating results file: kraken 10:16:48 INFO - javascript benchmark 10:16:48 INFO - Working with test: v8_7 10:16:48 INFO - Generating results file: v8_7 10:16:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:16:49 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 10:16:49 INFO - process_Request line: dromaeo_css 6953.89 graph.html#tests=[[72,63,43]] 10:16:49 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:16:49 INFO - process_Request line: kraken 1528.20 graph.html#tests=[[232,63,43]] 10:16:49 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:16:49 INFO - process_Request line: v8_7 21452.35 graph.html#tests=[[230,63,43]] 10:16:49 INFO - RETURN: dromaeo_css: 6953.89 10:16:49 INFO - RETURN: kraken: 1528.20 10:16:49 INFO - RETURN: v8_7: 21452.35 10:16:49 INFO - javascript benchmark 10:16:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3191.7127458528726, 3239.4816829307315, 3257.2671148991494, 3292.5225842252876, 3297.6702329767013, 5316.255724198606, 5459.3994660587305, 5475.534579560732, 5495.175723641456, 5523.281973343464, 5411.810586629459, 5416.891662166764, 5429.212764149196, 5513.09034009389, 5536.501714845663, 4985.077760614289, 5026.748662566875, 5107.0, 5110.872228194287, 5130.179171332587, 5088.160453525164, 5113.054084994269, 5122.974385128069, 5127.154019586764, 5149.974250128744, 4951.900961980777, 4975.402951645826, 5044.596432285445, 5101.183810590306, 5159.871003224912, 5080.542751152377, 5094.414142373637, 5103.132467480537, 5105.030044291572, 5105.642605017651, 5072.0870243356185, 5081.949180508184, 5084.51697088776, 5095.031943930641, 5108.514691104339, 5194.480551944813, 5226.372835259755, 5325.467453254682, 5349.331333583302, 5410.513053825135, 5958.374370691102, 5961.076033214816, 5979.730912108966, 6028.728707208143, 6042.57701960863, 5973.611715238496, 6015.3383127855905, 6023.668698221596, 6024.879502409927, 6035.909461358083, 5440.292761940922, 5478.233047373371, 5526.281583394133, 5544.528715059265, 5551.111822108443, 6047.334793172748, 6068.362821903725, 6077.483413909778, 6077.574569780073, 6111.786087486917, 5893.204417403681, 5895.086261629454, 5898.351181370046, 5899.646021238654, 5915.438033386821, 5803.303603567514, 5894.705264736746, 5904.1734157218025, 5908.4091590841435, 5981.760729570856, 5868.031774757117, 5889.646621202742, 5910.704464776744, 5935.910961335583, 5993.520518358608, 5859.267591551056, 5986.161937328778, 6014.428629280212, 6028.728707208186, 6044.969775151096, 4416.867493975186, 4542.545745425497, 4548.704334218265, 4553.33976573395, 4589.770511474413, 3975.5626881043063, 4034.1931613677384, 4053.2704113259306, 4054.0, 4055.128147448254, 5621.353544342372, 5674.517665998354, 5684.971575142098, 5720.542356611461, 5745.080787074048, 5857.062869940874, 6070.998285282967, 6107.4197951194565, 6108.389161083945, 6121.418465245794, 5507.173923911365, 5591.133374326904, 5618.269624948731, 5619.690916999522, 5629.971850140805, 5190.506901844319, 5190.948090519122, 5250.711210883438, 5254.185601231815, 5258.1849813279005, 5817.301923769175, 6119.0, 6144.8771024579255, 6163.414475624809, 6168.0439531872635, 5864.589478736448, 5951.345352011189, 5992.161097446448, 6097.176881120992, 6109.20580324555, 5965.612235204698, 6116.694165291807, 6139.785107521216, 6140.815775526741, 6154.599951003171, 5814.127880817742, 5975.193348898017, 5985.940140598713, 5991.910121348271, 5996.340402555803, 5920.940790592039, 5934.792282270272, 5973.432523910222, 6025.1564780931585, 6061.848453788691, 5804.767809287581, 5854.795082172103, 5862.706864656665, 5863.501602363847, 5868.618539794899, 5768.798092066758, 5790.24726785532, 5839.124131380327, 5854.531637469077, 5859.882802344015, 5747.798827041033, 5792.8551786204, 5794.971025144847, 5807.738651760596, 5856.648601083949, 5879.794207202727, 5895.616784908967, 5910.172575839472, 5925.703714814156, 5929.080992446177, 5651.547876169814, 5673.092305231144, 5759.481646651821, 5771.971140144273, 5779.7110144493445], "unit": "score", "name": "dojo.html", "value": 5489.667279316902}, {"lowerIsBetter": false, "replicates": [560.8906263278661, 572.3332317849704, 573.0430181596734, 588.0913987888712, 612.0543759890968, 38277.80861095698, 39957.20085598286, 40061.39907901384, 40073.1985360293, 40097.59902400975, 41919.790401047954, 42273.57726422735, 42464.0, 42466.150676986515, 42468.575314246846, 8651.221390074908, 8771.254443372321, 8804.0, 8811.339149563777, 8827.073157318486, 8439.409241353107, 8536.78658033548, 8567.443116197428, 8578.18507241811, 8589.656413743443, 8630.697925572606, 8714.782130446727, 8742.388032837704, 8747.431416957877, 8747.431416957908, 8578.571071446402, 8614.05245423003, 8653.740387788377, 8671.046184919654, 8680.565971701453, 8545.359098067669, 8620.396572239946, 8636.956815215946, 8646.437981531244, 8689.348298877609, 38260.61739382598, 38527.0, 38802.417963730564, 38910.22179556393, 38979.8051009746, 2772.5979732938613, 3193.984030079858, 3293.5059741038795, 3306.7519936004896, 3925.823337949799, 26185.607215891778, 26254.6061809073, 26607.600885986725, 26698.199054028217, 27121.05076322339, 3835.7314987950854, 3883.0680636647285, 3901.843926242947, 3922.666573341269, 3936.2127574485216, 244821.0, 245307.0, 245780.0, 246616.0, 246759.0, 39784.60215397867, 40388.0, 40412.393814092815, 40470.59529404727, 40514.59485405167, 40114.19771604551, 40364.394534082014, 40398.79800600978, 40424.191516169514, 40451.0, 13299.0, 13300.201987880759, 13316.933415333055, 13389.129706569041, 13396.196228226338, 10823.621173258898, 10868.293560918515, 10881.619143329945, 11034.944825275823, 11217.102631789438, 13946.232957187249, 13948.86051139496, 13977.860221397656, 14063.226522541154, 14105.506307279196, 5579.0, 5620.831375058755, 5640.210370548045, 5904.0, 6102.298235702862, 908.1508789282043, 940.849464085743, 948.0756262644005, 950.458238803889, 964.2575217082947, 24771.380715481897, 25670.614940775904, 25742.663251089885, 25908.35229119287, 25930.611040834403, 1017.801528701896, 1052.4474650808233, 1072.0, 1133.3879704959395, 1140.5209811878865, 13751.931240343934, 13837.792433113511, 16204.513864584082, 16420.343186272654, 16436.917815410845, 402986.0, 405406.0, 405778.0, 407202.0, 410496.0, 52157.47842521526, 52822.47177528252, 52949.2057619136, 53252.0, 53346.46653533415, 1226.3071364678929, 1244.595506460404, 1252.7494501099816, 1254.6612414647993, 1265.1333836322149, 27804.72195278021, 28654.0, 29019.12942611725, 29035.854820725763, 29185.85407072951, 46371.0, 47475.28787068128, 47610.285845713035, 47621.76189119171, 47660.52339476561, 238774.0, 241957.0, 242006.0, 242232.0, 242307.0, 36372.818135909154, 44464.0, 44631.77684111689, 45126.584809823034, 45381.319280211486, 40620.0, 41171.38242926299, 41371.58628413677, 41400.37899431571, 41964.58035419607, 30824.53763193509, 31215.84392078025, 31563.684363156073, 31599.0, 31694.0, 35541.28917421585, 39922.800385997885, 40604.79697601493, 41381.37927931023, 42259.577404226795, 32172.356552869278, 36435.63564364429, 37195.25609487849, 37331.440028399054, 37411.0, 30488.84755576208, 32950.34099318048, 33058.669413306525, 33390.499142512395, 33395.165120872174, 23453.648195277427, 23593.0, 23778.881105595054, 27551.862240688668, 27931.44137117287], "unit": "score", "name": "ext.html", "value": 17609.24848522066}, {"lowerIsBetter": false, "replicates": [354.893531940418, 357.47094300435356, 358.48199351936444, 358.5894151196878, 361.73412541781784, 13551.390187441564, 14737.0, 17065.0, 17595.472135835913, 18304.542386440346, 16116.75824862628, 16191.676166476664, 16372.83627163728, 16383.344666213367, 16750.83249167511, 4854.247591623304, 4928.457869634337, 4972.105021096201, 4972.353594032771, 4977.402711674604, 4480.372747815309, 4916.532929371704, 4930.457649658535, 4948.554630083292, 5311.0, 5373.086575282192, 5383.219433182187, 5383.300170977787, 5399.433059528732, 5401.4868587484325, 4854.538818812207, 4943.802247910079, 5339.5728341732765, 5382.058139825534, 5385.3268341457315, 4669.836555720533, 4708.529147085298, 4715.127701375257, 4715.740634265114, 4739.64452666048, 12572.497100115985, 12602.558910438182, 19955.501112472306, 20710.68933965992, 20775.792242077536, 2029.6448121578665, 2125.0012494127736, 2210.789974952393, 2285.3829466044076, 2433.5254625348066, 9527.190188833958, 9640.614375425044, 9923.0, 10803.5678572857, 13595.660108497366, 1839.448165550343, 1855.0, 1868.2900497810745, 1871.4946964319693, 1904.114586717183, 59325.89851220776, 60244.0, 61371.38628613746, 61494.0, 62046.68976655133, 9628.71113866585, 9992.950035249778, 10003.79954405476, 10142.340747851513, 10167.0, 12700.872991270155, 13027.218366898016, 13040.347982601023, 13060.934695326652, 13159.802602960963, 7296.489245752852, 7423.628818559158, 7443.776686699408, 7547.622618869034, 7577.810554736176, 7142.073723988659, 7148.678309476086, 7186.389156921616, 7356.411487081128, 7474.103107627011, 4384.254676704968, 4412.161689279091, 4419.0719948810465, 4435.866923992286, 4438.0, 1839.2551016838202, 1850.12119243361, 1884.9528761780791, 1890.9621807563772, 1894.7347371368019, 907.6596276396351, 933.5798890499302, 952.7999120184838, 958.6500927161536, 1044.968650940473, 15290.847091528942, 16093.0, 16437.0, 17533.0, 17986.820131798515, 781.5935713428985, 896.4442045931564, 916.9546716742918, 928.6285485805731, 968.4867020479157, 8646.697365592174, 8947.19475247231, 9153.267738580898, 9171.40385874916, 9185.989541150468, 395108.0, 407165.0, 407209.0, 531114.0, 544069.0, 78722.60638696884, 78893.60553197197, 80845.19154808494, 82481.0, 82886.58556707177, 1087.0542627913765, 1124.707576030238, 1127.5377095391013, 1137.2778285788418, 1148.7243061665308, 14684.706305874037, 15301.693966120838, 15367.308471118602, 15412.46056388021, 15753.369865205263, 30664.386712266078, 34346.82826585851, 35060.0, 35613.82193089018, 35926.461103082955, 43915.12169756651, 45030.0, 45708.0, 47023.52976470192, 47776.28335575038, 8869.157430044394, 9224.631014759334, 9356.719298421058, 9372.812543749224, 9391.342606017513, 10743.462826858782, 13343.399547020214, 16214.270357834162, 16726.0, 16816.495505134866, 13057.151285166434, 13098.934505327412, 13105.27920964356, 13733.313334333443, 13767.518136865161, 14000.789988149982, 14502.1298722077, 14585.416583336548, 14610.415583376545, 15025.699486010437, 13415.731685366432, 13725.656858578615, 13888.930555347159, 14273.0, 14556.344964476835, 9123.582805784274, 9184.632614695605, 9216.124468175512, 9622.711318660451, 9839.508024598885, 9616.471094089893, 9789.46157961319, 9818.45998470091, 13664.098338752328, 13766.105203161762], "unit": "score", "name": "jquery.html", "value": 8592.843988916655}, {"lowerIsBetter": false, "replicates": [1342.8455727591327, 1373.23785299159, 1403.9508617198394, 1469.8089248397707, 1511.4936496273747, 6802.557833740803, 6893.655317234131, 7326.157491888434, 7717.614119294034, 7721.420893432994, 7212.639368031603, 7324.853502929938, 7429.739959101433, 7439.256074392558, 7455.813604659887, 2240.1599400224914, 2295.517941232343, 2297.597920363938, 2298.184144628658, 2300.447892505795, 2310.9653355199684, 2316.5830150572892, 2356.493353928905, 2358.5636657218383, 2360.3745007573007, 2254.6279863822533, 2258.8192944564394, 2276.64711969645, 2281.2927992322434, 2296.8851557422145, 2219.9223027194053, 2222.288867562381, 2226.832987525942, 2234.553089382122, 2236.105557776902, 2302.07916833268, 2335.97664023361, 2336.5910965581124, 2336.7429582745885, 2342.8008619267384, 7382.077240344957, 7398.926010739878, 7471.0, 7486.475946683734, 7503.249675032508, 4545.681802273843, 4589.403377560929, 4624.09830083134, 4633.698809577367, 4634.0, 2944.8085874418093, 2951.8671659775364, 3009.368032713133, 3021.6978302169828, 3055.908322750321, 977.154761131616, 993.3791380387258, 1003.9698809035741, 1049.632628579991, 1062.4315990944885, 9940.652077177265, 9980.900190998069, 10037.096661300446, 10049.547770350351, 10056.74858128538, 4138.8344466221615, 4224.7253928495165, 4243.681723870722, 4270.743755374688, 4283.550227226158, 8687.391882568287, 8714.17215364552, 8736.344774141964, 8748.606312715943, 8748.69379571712, 4578.313253012075, 4583.564561366665, 4630.814767409333, 4639.907201855944, 4656.464506581787, 4137.379393091061, 4230.70385073042, 4242.618164365222, 4267.893302667396, 4269.743815371087, 3631.5460567429072, 3635.5092062571744, 3651.5253017107607, 3666.6150054244454, 3672.908177295589, 1098.0940723902813, 1120.2774210634095, 1140.8573928258968, 1148.9885101149048, 1153.2503872482785, 959.1080295325274, 1003.7340104872214, 1167.0197034491068, 1172.4782471799967, 1172.9061675066146, 6870.106886104774, 6929.480288978347, 6934.826629334307, 6936.895946560806, 6987.615681137485, 1165.056304393444, 1209.1415095282448, 1221.7617564574823, 1223.247702662856, 1225.6506895534908, 5448.645838020516, 5473.124300112043, 5505.9724701376235, 5512.118061110203, 5516.668999860021, 8691.869621955675, 8907.242884354773, 8919.643214271357, 9093.272538197061, 9102.180803727697, 8953.641854325753, 8997.775055623662, 9012.18890299863, 9081.77295567603, 9095.36332456735, 7101.218865924744, 7279.490435669452, 7353.595552244571, 7364.77905662831, 7390.963045184847, 7136.357727804315, 7213.20654727969, 7250.3112204340505, 7273.854522909618, 7286.854262914818, 8056.798580035546, 8250.54621995796, 8274.338052955629, 8306.501609903426, 8314.708985185489, 8268.421210515206, 8334.62494187751, 8374.07885132647, 8377.623006964579, 8415.95792021036, 6043.939560604514, 6170.784022559189, 6580.979948108051, 6875.965620171867, 6964.686589103604, 7130.643467826691, 7138.571685698875, 7150.356467917913, 7154.928450715426, 7176.569405835667, 6669.7332106715185, 6878.793636190922, 6879.6560171992205, 6900.0, 7037.859242815218, 6828.692708828015, 6833.214180369321, 6854.554453960476, 6906.689198985957, 6952.478564107611, 6717.1267735194115, 6721.529492935643, 6789.592624442549, 6804.0, 6812.523123381316, 6357.046443033582, 6364.4908407326375, 6401.487880969418, 6403.8719225614295, 6416.262129855127, 6307.590006649553, 6324.968375158279, 6385.7126429309865, 6389.904151437825, 6409.102725618324], "unit": "score", "name": "mootools.html", "value": 4390.941059191773}, {"lowerIsBetter": false, "replicates": [319.59571142504734, 321.2562916847498, 325.414254342184, 327.46296074437925, 330.4827944267223, 6134.631922084673, 6180.165677633524, 6202.844928876781, 6208.099825525296, 6312.116303717483, 6028.819135425944, 6144.53915956304, 6177.9382206177925, 6185.536084793636, 6208.0, 4737.976310118444, 4759.500252473493, 4762.714237145765, 4771.475137734847, 4773.307870358787, 4765.69023013503, 4766.285057241407, 4768.0, 4770.809167633308, 4771.141194584973, 4629.189891768944, 4705.294205869112, 4723.669343145981, 4733.313669517918, 4737.384140061788, 4707.529247075282, 4708.387909571751, 4709.45841228258, 4715.174844402216, 4730.597899178574, 3963.2271707017144, 4063.7561746295023, 4099.733517321394, 4113.958860411388, 4117.56765539617, 5877.823665290048, 5881.3530511643685, 5916.497097746696, 5938.346781853993, 5973.8805223895715, 5420.051490989101, 5453.618246722731, 5471.124620060811, 5473.589480788957, 5475.534579560742, 6638.336166383371, 6639.203295604559, 6652.268250492442, 6653.600783952978, 6654.933450665529, 4351.151525452538, 4479.216137176014, 4482.5069242383315, 4487.865364039084, 4498.730076195438, 6862.416694580967, 6913.89629155563, 6923.446124310043, 6930.965345173242, 6939.583624982517, 4570.3829982951875, 4575.679702420865, 4579.06129243511, 4581.748003859753, 4588.426446694163, 4566.478305245104, 4569.109023740405, 4633.837815676435, 4646.884747660537, 4653.092646933816, 5436.646617969898, 5441.646292991022, 5444.101723215705, 5448.863778405572, 5450.836474905759, 6695.12963314766, 6699.464042876558, 6704.296048914891, 6717.664116794141, 6735.932640673628, 1617.5551723275958, 1628.5928517870532, 1635.7709920611123, 1638.565780068283, 1640.5898525368657, 1058.1799105692996, 1059.7244716373643, 1070.1011150633349, 1085.0451602589671, 1092.9125669946545, 6426.389492998158, 6467.0, 6467.676616169267, 6475.32009139043, 6479.384458476437, 6939.479539034593, 6940.895886561706, 6947.4789390795895, 6949.861002779916, 6958.199807022257, 6322.715477803418, 6403.423691867754, 6412.4549413299455, 6440.903386449207, 6446.129772480655, 3798.848046078181, 3827.0432391902023, 3827.6363745444137, 3828.7319887608155, 3835.386338185877, 6951.165860096719, 7124.073870396919, 7144.571325720473, 7158.391536719437, 7159.355657990805, 7202.135743710788, 7204.9639751800905, 7207.0, 7212.783616491513, 7218.963905180441, 6987.510874238857, 7046.471514636422, 7082.256363081905, 7096.07750992378, 7138.214796372395, 6982.7206911725, 7007.124109486314, 7025.929740702528, 7046.436285097077, 7048.224695283412, 6940.7917762467205, 6943.618101004493, 6949.30506949301, 6950.20072691647, 6962.965185174042, 6919.446444284546, 7099.148102227766, 7104.786856394317, 7142.535735177197, 7145.428365730625, 4575.359449676981, 4603.884902877455, 4612.285095810154, 4620.09908067937, 4626.259798432235, 6933.168019837652, 6945.131858517685, 6970.407515361251, 6974.58152510851, 7003.439724822104, 6654.168228971379, 6795.048693183057, 6819.761308354184, 6823.1812182538415, 6824.112865327475, 6796.286389928986, 6798.0, 6802.693878775566, 6806.897896531655, 6834.692438840363, 6633.2040155181685, 6677.69950352245, 6686.398224159849, 6687.498437617295, 6709.530332876652, 6650.268470468342, 6738.09035780183, 6812.693428795816, 6829.0, 6829.692663830239, 6663.566868153554, 6681.0, 6691.832704182434, 6695.296993815579, 6707.429868461236], "unit": "score", "name": "prototype.html", "value": 4995.557545389824}, {"lowerIsBetter": false, "replicates": [730.5397599512308, 766.896468976688, 817.5094943034184, 819.0376307838288, 830.4685001598974, 12416.937915310422, 12646.747065058693, 12655.493780248778, 12657.0, 12664.366781660914, 12768.42542085606, 12881.420336084875, 12883.871161288407, 12888.74222515549, 12901.5484458044, 802.6628815897323, 819.0294501016315, 822.4448497264323, 824.3734761581211, 825.8637324841394, 799.2207597592359, 806.2904643913348, 811.6266517401973, 813.259933460551, 814.42989907065, 836.5399030533213, 837.3887062444419, 840.6889450903175, 840.848647243496, 843.3084870406269, 831.6216121664659, 834.2241715204857, 834.837206744685, 835.5028757889046, 835.778518692547, 614.0298328640781, 615.4245780195531, 615.9753609855601, 616.7255571270787, 617.7621615677996, 13358.599242022754, 13426.798598021038, 13431.3955871986, 13495.055346125775, 13532.255725935069, 11564.710882227928, 11635.301881887113, 11852.525898964032, 11868.821967670492, 12300.0, 10121.1903047756, 10174.135198508136, 10192.949035254851, 10252.282340236186, 10279.486025698685, 3490.703290220334, 3492.807895565743, 3531.5055892175114, 3541.557305336833, 3580.838862251205, 44752.3287150693, 45364.0, 45444.318335225, 45502.77248613736, 45834.54165458336, 8643.30853531716, 8820.426672266281, 9147.405418647899, 9222.0, 9429.0, 16611.916940415464, 16629.50111496657, 16716.0, 16745.162741863103, 16758.74861877073, 7301.744438944612, 7306.305900939402, 7479.401647868158, 7564.054493188351, 7568.205338439495, 4190.306008487839, 4221.641160501392, 4263.637590804817, 4407.360932664746, 4433.844815431445, 2795.077624383948, 2810.690824009357, 2814.733369983516, 2817.7323154300307, 2823.124831302303, 521.1176733336657, 528.8915772266677, 538.2867700297122, 550.1445252632195, 553.4133818152771, 581.5492992930513, 637.2098597738864, 669.4610838275138, 676.35746041261, 678.2403707847243, 8327.458715183493, 8503.74488765338, 8517.787055323543, 8641.30869530436, 8725.52009639476, 655.8393193667582, 657.375493281375, 674.1101745695635, 690.6684791300204, 718.8454482286334, 4020.1356708307853, 4064.7357921734992, 4207.037353180491, 4207.410962465257, 4258.518031742254, 54685.179722304194, 55807.720961395746, 55980.0, 56701.43298566961, 56872.71563642238, 49376.50623493791, 50176.498235017185, 50523.24215136776, 51951.0, 52561.47438525642, 45821.77089114533, 45887.54112458833, 45889.770551147696, 45915.77042114768, 46129.538704613195, 8077.434579579373, 8212.096669366485, 8362.247397734232, 8898.644054237759, 8950.373473857027, 33577.16057098592, 33688.326233474705, 34472.65527344795, 34690.47964280487, 34763.0, 43328.78335608302, 43494.78252608717, 43938.78030609826, 44488.33267501055, 45130.54869451263, 11032.393218373067, 11099.445027748741, 11100.222984391015, 11108.666739997812, 11589.942050289694, 12371.195872268274, 12381.814272786096, 12432.0, 12454.49908131477, 12627.305498197687, 11203.383813890314, 11403.543858245908, 11482.0, 11832.70418239551, 11862.584809531625, 11689.473973671375, 11868.169228153947, 12350.75298494043, 12403.813942791046, 12417.875821241672, 9851.753706157404, 10956.780864382827, 11223.66329010131, 11482.13883958723, 11783.057355411718, 9372.906270937476, 9431.481268530297, 9462.763430914281, 9674.22606191489, 9783.46190959504, 8732.0, 8820.74673093572, 8821.250193733347, 9020.278377729635, 9737.07497787709], "unit": "score", "name": "yui.html", "value": 6205.321733276991}], "name": "dromaeo_css", "value": 6953.88510481595}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 113.0, 113.0, 113.0, 123.0, 113.0, 113.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.4}, {"lowerIsBetter": true, "replicates": [151.0, 129.0, 150.0, 159.0, 127.0, 160.0, 152.0, 132.0, 171.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 163.0, 162.0, 161.0, 164.0, 165.0, 170.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 74.0, 79.0, 74.0, 148.0, 73.0, 79.0, 72.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 133.0, 92.0, 92.0, 94.0, 136.0, 93.0, 95.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [110.0, 112.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 112.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 59.0, 62.0, 61.0, 59.0, 65.0, 61.0, 59.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 70.0, 69.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 87.0, 86.0, 88.0, 86.0, 84.0, 92.0, 94.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [127.0, 116.0, 126.0, 121.0, 118.0, 132.0, 120.0, 134.0, 123.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [145.0, 169.0, 158.0, 158.0, 161.0, 147.0, 148.0, 155.0, 148.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 76.0, 71.0, 71.0, 72.0, 71.0, 75.0, 71.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.9}], "name": "kraken", "value": 1528.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.59032952475576], "unit": "score", "name": "Richards", "value": 213.18877800000007}, {"lowerIsBetter": false, "replicates": [188.14675446848543], "unit": "score", "name": "DeltaBlue", "value": 351.41717}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [698.3240223463687], "unit": "score", "name": "Earley", "value": 954.3750159999998}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [26342.105263157893], "unit": "score", "name": "RegExp", "value": 34.58284715284714}, {"lowerIsBetter": false, "replicates": [571.7552887364208], "unit": "score", "name": "Splay", "value": 142.52775899999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21452.35311661928}]} 10:16:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21452.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1528.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6953.89"}}} 10:16:49 INFO - Return code: 0 10:16:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:16:49 INFO - # TBPL SUCCESS # 10:16:49 INFO - Running post-action listener: _resource_record_post_action 10:16:49 INFO - Running post-run listener: _resource_record_post_run 10:16:50 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 558186496; Read time: 12; Write time: 452520 10:16:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234864640; Read time: 0; Write time: 269704 10:16:50 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323321856; Read time: 12; Write time: 182816 10:16:50 INFO - Running post-run listener: _upload_blobber_files 10:16:50 INFO - Blob upload gear active. 10:16:50 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:16:50 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:16:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:16:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:16:50 INFO - (blobuploader) - INFO - Open directory for files ... 10:16:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:16:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:16:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:51 INFO - (blobuploader) - INFO - Done attempting. 10:16:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:16:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:16:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:52 INFO - (blobuploader) - INFO - Done attempting. 10:16:52 INFO - (blobuploader) - INFO - Iteration through files over. 10:16:52 INFO - Return code: 0 10:16:52 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:16:52 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:16:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b3c38cafcfd028428088eecb02b18303e994094fb1c241028d51e9c3c390ab059713b7d55bd6eabb71405264ed4a550d282af7724285d0c8788e31df1c3d6b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e85b886bf4dd1c44f1a304f20121bbd2e873ab14101bd2bd845145fe525cf1fac06c214d0626f8473e93adb68fe9a747e6a19d536a6c1210896f02b496a71a4"} 10:16:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:16:52 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:16:52 INFO - Contents: 10:16:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b3c38cafcfd028428088eecb02b18303e994094fb1c241028d51e9c3c390ab059713b7d55bd6eabb71405264ed4a550d282af7724285d0c8788e31df1c3d6b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e85b886bf4dd1c44f1a304f20121bbd2e873ab14101bd2bd845145fe525cf1fac06c214d0626f8473e93adb68fe9a747e6a19d536a6c1210896f02b496a71a4"} 10:16:52 INFO - Copying logs to upload dir... 10:16:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.043297 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-21 10:16:51.722377) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 10:16:51.726596) ========= 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=61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b3c38cafcfd028428088eecb02b18303e994094fb1c241028d51e9c3c390ab059713b7d55bd6eabb71405264ed4a550d282af7724285d0c8788e31df1c3d6b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e85b886bf4dd1c44f1a304f20121bbd2e873ab14101bd2bd845145fe525cf1fac06c214d0626f8473e93adb68fe9a747e6a19d536a6c1210896f02b496a71a4"} build_url:https://queue.taskcluster.net/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/cHXoC-ZORWKOdPXFLiDvpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b3c38cafcfd028428088eecb02b18303e994094fb1c241028d51e9c3c390ab059713b7d55bd6eabb71405264ed4a550d282af7724285d0c8788e31df1c3d6b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e85b886bf4dd1c44f1a304f20121bbd2e873ab14101bd2bd845145fe525cf1fac06c214d0626f8473e93adb68fe9a747e6a19d536a6c1210896f02b496a71a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 10:16:51.751920) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 10:16:51.752271) ========= 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=61fa6ed41387771909ec0f71000001b3-1450719058.168889-1849110785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 10:16:51.835894) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 10:16:51.836232) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 10:16:51.836563) ========= ========= Total master_lag: 0.23 =========