builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1451454453.15 results: success (0) buildid: 20151229193155 builduid: e2d247078c9b437496b6d06df3af4960 revision: 3becd09c71b176713af62aae2646249cab9ff893 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.154896) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.155521) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.155890) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006426 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.180245) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.180558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.196996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.197272) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.247616) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.248124) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.248743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.249265) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 21:47:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-12-29 21:47:33 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107048 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.376752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.377300) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022473 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.428380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.428736) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3becd09c71b176713af62aae2646249cab9ff893 --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 3becd09c71b176713af62aae2646249cab9ff893 --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=6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 21:47:33,958 truncating revision to first 12 chars 2015-12-29 21:47:33,958 Setting DEBUG logging. 2015-12-29 21:47:33,958 attempt 1/10 2015-12-29 21:47:33,958 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3becd09c71b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 21:47:34,213 unpacking tar archive at: mozilla-inbound-3becd09c71b1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.518696 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.966567) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.966895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.976849) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.977206) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:33.977806) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-29 21:47:33.978107) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:47:34 INFO - MultiFileLogger online at 20151229 21:47:34 in /builds/slave/test-pgo 21:47:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:47:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:47:34 INFO - {'append_to_log': False, 21:47:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:47:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:47:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:47:34 INFO - 'branch': 'Mozilla-Inbound', 21:47:34 INFO - 'buildbot_json_path': 'buildprops.json', 21:47:34 INFO - 'config_files': ('talos/linux_config.py',), 21:47:34 INFO - 'default_actions': ('clobber', 21:47:34 INFO - 'read-buildbot-config', 21:47:34 INFO - 'download-and-extract', 21:47:34 INFO - 'populate-webroot', 21:47:34 INFO - 'create-virtualenv', 21:47:34 INFO - 'install', 21:47:34 INFO - 'run-tests'), 21:47:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:47:34 INFO - 'download_minidump_stackwalk': True, 21:47:34 INFO - 'download_symbols': 'ondemand', 21:47:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:47:34 INFO - 'tooltool.py': '/tools/tooltool.py', 21:47:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:47:34 INFO - '/tools/misc-python/virtualenv.py')}, 21:47:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:47:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:47:34 INFO - 'installer_path': 'installer.exe', 21:47:34 INFO - 'log_level': 'info', 21:47:34 INFO - 'log_name': 'talos', 21:47:34 INFO - 'log_to_console': True, 21:47:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:47:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:47:34 INFO - 'opt_config_files': (), 21:47:34 INFO - 'pip_index': False, 21:47:34 INFO - 'sps_profile': False, 21:47:34 INFO - 'sps_profile_interval': 0, 21:47:34 INFO - 'suite': 'dromaeojs-e10s', 21:47:34 INFO - 'system_bits': '32', 21:47:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:47:34 INFO - 'title': 'talos-linux64-ix-057', 21:47:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:47:34 INFO - 'use_talos_json': True, 21:47:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:47:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:47:34 INFO - 'work_dir': 'build'} 21:47:34 INFO - ##### 21:47:34 INFO - ##### Running clobber step. 21:47:34 INFO - ##### 21:47:34 INFO - Running pre-action listener: _resource_record_pre_action 21:47:34 INFO - Running main action method: clobber 21:47:34 INFO - rmtree: /builds/slave/test-pgo/build 21:47:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:47:35 INFO - Running post-action listener: _resource_record_post_action 21:47:35 INFO - ##### 21:47:35 INFO - ##### Running read-buildbot-config step. 21:47:35 INFO - ##### 21:47:35 INFO - Running pre-action listener: _resource_record_pre_action 21:47:35 INFO - Running main action method: read_buildbot_config 21:47:35 INFO - Using buildbot properties: 21:47:35 INFO - { 21:47:35 INFO - "project": "", 21:47:35 INFO - "product": "firefox", 21:47:35 INFO - "script_repo_revision": "production", 21:47:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:47:35 INFO - "repository": "", 21:47:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:47:35 INFO - "buildid": "20151229193155", 21:47:35 INFO - "pgo_build": "True", 21:47:35 INFO - "basedir": "/builds/slave/test-pgo", 21:47:35 INFO - "buildnumber": 272, 21:47:35 INFO - "slavename": "talos-linux64-ix-057", 21:47:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:47:35 INFO - "platform": "ubuntu64_hw", 21:47:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:47:35 INFO - "branch": "mozilla-inbound", 21:47:35 INFO - "repo_path": "integration/mozilla-inbound", 21:47:35 INFO - "revision": "3becd09c71b176713af62aae2646249cab9ff893", 21:47:35 INFO - "stage_platform": "linux64-pgo", 21:47:35 INFO - "builduid": "e2d247078c9b437496b6d06df3af4960", 21:47:35 INFO - "slavebuilddir": "test" 21:47:35 INFO - } 21:47:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:47:35 INFO - Running post-action listener: _resource_record_post_action 21:47:35 INFO - ##### 21:47:35 INFO - ##### Running download-and-extract step. 21:47:35 INFO - ##### 21:47:35 INFO - Running pre-action listener: _resource_record_pre_action 21:47:35 INFO - Running main action method: download_and_extract 21:47:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:35 INFO - https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:47:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/test_packages.json 21:47:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/test_packages.json 21:47:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:47:39 INFO - Downloaded 1302 bytes. 21:47:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:47:39 INFO - Using the following test package requirements: 21:47:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:47:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:47:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:39 INFO - u'jsshell-linux-x86_64.zip'], 21:47:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:47:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:47:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:47:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:47:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:47:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:47:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:47:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:47:39 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')]} 21:47:39 INFO - https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:47:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:47:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:47:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:40 INFO - Downloaded 23200035 bytes. 21:47:40 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 21:47:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:47:40 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 21:47:41 INFO - Return code: 0 21:47:41 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 21:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:41 INFO - https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:43 INFO - Downloaded 23200035 bytes. 21:47:43 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 21:47:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:47:43 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 21:47:44 INFO - Return code: 0 21:47:44 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')]} 21:47:44 INFO - https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:47:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:47:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:47:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:45 INFO - Downloaded 11132270 bytes. 21:47:45 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 21:47:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:47:45 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 21:47:45 INFO - Return code: 0 21:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:45 INFO - https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:47:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:47:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:47:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:47 INFO - Downloaded 54947110 bytes. 21:47:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:47:47 INFO - mkdir: /builds/slave/test-pgo/properties 21:47:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:47:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:47:47 INFO - Contents: 21:47:47 INFO - build_url:https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:47:47 INFO - Running post-action listener: _resource_record_post_action 21:47:47 INFO - Running post-action listener: set_extra_try_arguments 21:47:47 INFO - ##### 21:47:47 INFO - ##### Running populate-webroot step. 21:47:47 INFO - ##### 21:47:47 INFO - Running pre-action listener: _resource_record_pre_action 21:47:47 INFO - Running main action method: populate_webroot 21:47:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:47:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:47:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:47:47 INFO - '--tppagecycles', 21:47:47 INFO - '7'], 21:47:47 INFO - 'tests': ['tsvgm']}}, 21:47:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:47:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:47:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:47:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:47:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:47:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:47:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:47 INFO - 'talos_options': ['--e10s'], 21:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:47 INFO - 'tests': ['damp', 'tps']}, 21:47:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:47 INFO - 'talos_options': ['--e10s'], 21:47:47 INFO - 'tests': ['damp', 'tps']}, 21:47:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:47:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:47:47 INFO - 'other': {'tests': ['a11yr', 21:47:47 INFO - 'ts_paint', 21:47:47 INFO - 'tpaint', 21:47:47 INFO - 'sessionrestore', 21:47:47 INFO - 'sessionrestore_no_auto_restore']}, 21:47:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:47:47 INFO - 'tests': ['a11yr', 21:47:47 INFO - 'ts_paint', 21:47:47 INFO - 'tpaint', 21:47:47 INFO - 'sessionrestore', 21:47:47 INFO - 'sessionrestore_no_auto_restore']}, 21:47:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:47:47 INFO - 'tests': ['a11yr', 21:47:47 INFO - 'ts_paint', 21:47:47 INFO - 'tpaint', 21:47:47 INFO - 'sessionrestore', 21:47:47 INFO - 'sessionrestore_no_auto_restore']}, 21:47:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:47:47 INFO - 'tests': ['a11yr', 21:47:47 INFO - 'ts_paint', 21:47:47 INFO - 'tpaint', 21:47:47 INFO - 'sessionrestore', 21:47:47 INFO - 'sessionrestore_no_auto_restore']}, 21:47:47 INFO - 'other_l64': {'tests': ['a11yr', 21:47:47 INFO - 'ts_paint', 21:47:47 INFO - 'tpaint', 21:47:47 INFO - 'sessionrestore', 21:47:47 INFO - 'sessionrestore_no_auto_restore']}, 21:47:47 INFO - 'other_nol64': {'tests': ['a11yr', 21:47:47 INFO - 'ts_paint', 21:47:47 INFO - 'tpaint', 21:47:47 INFO - 'sessionrestore', 21:47:47 INFO - 'sessionrestore_no_auto_restore']}, 21:47:47 INFO - 'svgr': {'tests': ['tsvgx', 21:47:47 INFO - 'tsvgr_opacity', 21:47:47 INFO - 'tart', 21:47:47 INFO - 'tscrollx', 21:47:47 INFO - 'cart']}, 21:47:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:47:47 INFO - 'tests': ['tsvgx', 21:47:47 INFO - 'tsvgr_opacity', 21:47:47 INFO - 'tart', 21:47:47 INFO - 'tscrollx', 21:47:47 INFO - 'cart']}, 21:47:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:47 INFO - 'tests': ['tp5o']}, 21:47:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:47 INFO - 'talos_options': ['--e10s'], 21:47:47 INFO - 'tests': ['tp5o']}, 21:47:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:47 INFO - 'talos_options': ['--xperf_path', 21:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:47 INFO - 'tests': ['tp5n']}, 21:47:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:47 INFO - 'talos_options': ['--e10s', 21:47:47 INFO - '--xperf_path', 21:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:47 INFO - 'tests': ['tp5n']}}, 21:47:47 INFO - 'talos.zip': {'path': '', 21:47:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:47:47 INFO - Running post-action listener: _resource_record_post_action 21:47:47 INFO - ##### 21:47:47 INFO - ##### Running create-virtualenv step. 21:47:47 INFO - ##### 21:47:47 INFO - Running pre-action listener: _resource_record_pre_action 21:47:47 INFO - Running main action method: create_virtualenv 21:47:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:47:47 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 21:47:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:47:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:47:47 INFO - Using real prefix '/usr' 21:47:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:47:47 INFO - Installing distribute.............................................................................................................................................................................................done. 21:47:49 INFO - Installing pip.................done. 21:47:49 INFO - Return code: 0 21:47:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:47:49 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')]} 21:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:49 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')]} 21:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:49 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 0x7f3616f19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28187f0>, '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 0x27842d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2784760>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', '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 21:47:49 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 21:47:49 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 21:47:49 INFO - Using env: {'DISPLAY': ':0', 21:47:49 INFO - 'HOME': '/home/cltbld', 21:47:49 INFO - 'LANG': 'en_US.UTF-8', 21:47:49 INFO - 'LANGUAGE': 'en_US:en', 21:47:49 INFO - 'LOGNAME': 'cltbld', 21:47:49 INFO - 'MAIL': '/var/mail/cltbld', 21:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:49 INFO - 'MOZ_NO_REMOTE': '1', 21:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:49 INFO - 'NO_EM_RESTART': '1', 21:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:47:49 INFO - 'PWD': '/builds/slave/test-pgo', 21:47:49 INFO - 'SHELL': '/bin/bash', 21:47:49 INFO - 'SHLVL': '1', 21:47:49 INFO - 'TERM': 'linux', 21:47:49 INFO - 'TMOUT': '86400', 21:47:49 INFO - 'USER': 'cltbld', 21:47:49 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', 21:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:49 INFO - '_': '/tools/buildbot/bin/python'} 21:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:49 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 21:47:49 INFO - Cleaning up... 21:47:49 INFO - Return code: 0 21:47:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:47:49 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')]} 21:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:49 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')]} 21:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:49 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 0x7f3616f19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28187f0>, '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 0x27842d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2784760>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', '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 21:47:49 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 21:47:49 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 21:47:49 INFO - Using env: {'DISPLAY': ':0', 21:47:49 INFO - 'HOME': '/home/cltbld', 21:47:49 INFO - 'LANG': 'en_US.UTF-8', 21:47:49 INFO - 'LANGUAGE': 'en_US:en', 21:47:49 INFO - 'LOGNAME': 'cltbld', 21:47:49 INFO - 'MAIL': '/var/mail/cltbld', 21:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:49 INFO - 'MOZ_NO_REMOTE': '1', 21:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:49 INFO - 'NO_EM_RESTART': '1', 21:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:47:49 INFO - 'PWD': '/builds/slave/test-pgo', 21:47:49 INFO - 'SHELL': '/bin/bash', 21:47:49 INFO - 'SHLVL': '1', 21:47:49 INFO - 'TERM': 'linux', 21:47:49 INFO - 'TMOUT': '86400', 21:47:49 INFO - 'USER': 'cltbld', 21:47:49 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', 21:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:49 INFO - '_': '/tools/buildbot/bin/python'} 21:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:50 INFO - Downloading/unpacking psutil>=0.7.1 21:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:47:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:47:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:47:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:51 INFO - Installing collected packages: psutil 21:47:51 INFO - Running setup.py install for psutil 21:47:51 INFO - building 'psutil._psutil_linux' extension 21:47:51 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 21:47:52 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 21:47:52 INFO - building 'psutil._psutil_posix' extension 21:47:52 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 21:47:52 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 21:47:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:52 INFO - Successfully installed psutil 21:47:52 INFO - Cleaning up... 21:47:52 INFO - Return code: 0 21:47:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3616f19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28187f0>, '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 0x27842d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2784760>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', '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 21:47:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21:47:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:47:52 INFO - Using env: {'DISPLAY': ':0', 21:47:52 INFO - 'HOME': '/home/cltbld', 21:47:52 INFO - 'LANG': 'en_US.UTF-8', 21:47:52 INFO - 'LANGUAGE': 'en_US:en', 21:47:52 INFO - 'LOGNAME': 'cltbld', 21:47:52 INFO - 'MAIL': '/var/mail/cltbld', 21:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:52 INFO - 'MOZ_NO_REMOTE': '1', 21:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:52 INFO - 'NO_EM_RESTART': '1', 21:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:47:52 INFO - 'PWD': '/builds/slave/test-pgo', 21:47:52 INFO - 'SHELL': '/bin/bash', 21:47:52 INFO - 'SHLVL': '1', 21:47:52 INFO - 'TERM': 'linux', 21:47:52 INFO - 'TMOUT': '86400', 21:47:52 INFO - 'USER': 'cltbld', 21:47:52 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', 21:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:52 INFO - '_': '/tools/buildbot/bin/python'} 21:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:47:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:47:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:47:54 INFO - Installing collected packages: mozsystemmonitor 21:47:54 INFO - Running setup.py install for mozsystemmonitor 21:47:54 INFO - Successfully installed mozsystemmonitor 21:47:54 INFO - Cleaning up... 21:47:54 INFO - Return code: 0 21:47:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3616f19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28187f0>, '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 0x27842d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2784760>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', '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 21:47:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:47:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:47:54 INFO - Using env: {'DISPLAY': ':0', 21:47:54 INFO - 'HOME': '/home/cltbld', 21:47:54 INFO - 'LANG': 'en_US.UTF-8', 21:47:54 INFO - 'LANGUAGE': 'en_US:en', 21:47:54 INFO - 'LOGNAME': 'cltbld', 21:47:54 INFO - 'MAIL': '/var/mail/cltbld', 21:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:54 INFO - 'MOZ_NO_REMOTE': '1', 21:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:54 INFO - 'NO_EM_RESTART': '1', 21:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 21:47:54 INFO - 'SHELL': '/bin/bash', 21:47:54 INFO - 'SHLVL': '1', 21:47:54 INFO - 'TERM': 'linux', 21:47:54 INFO - 'TMOUT': '86400', 21:47:54 INFO - 'USER': 'cltbld', 21:47:54 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', 21:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:54 INFO - '_': '/tools/buildbot/bin/python'} 21:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:54 INFO - Downloading/unpacking blobuploader==1.2.4 21:47:54 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 21:47:54 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 21:47:54 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 21:47:54 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 21:47:54 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 21:47:54 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 21:47:56 INFO - Downloading blobuploader-1.2.4.tar.gz 21:47:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:47:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:47:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:47:56 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 21:47:56 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 21:47:56 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 21:47:56 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 21:47:56 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 21:47:56 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 21:47:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:47:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:47:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:47:56 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 21:47:56 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 21:47:56 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 21:47:56 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 21:47:56 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 21:47:56 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 21:47:57 INFO - Downloading docopt-0.6.1.tar.gz 21:47:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:47:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:47:57 INFO - Installing collected packages: blobuploader, requests, docopt 21:47:57 INFO - Running setup.py install for blobuploader 21:47:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:47:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:47:57 INFO - Running setup.py install for requests 21:47:57 INFO - Running setup.py install for docopt 21:47:57 INFO - Successfully installed blobuploader requests docopt 21:47:57 INFO - Cleaning up... 21:47:57 INFO - Return code: 0 21:47:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:57 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 0x7f3616f19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28187f0>, '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 0x27842d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2784760>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', '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 21:47:57 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 21:47:57 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 21:47:57 INFO - Using env: {'DISPLAY': ':0', 21:47:57 INFO - 'HOME': '/home/cltbld', 21:47:57 INFO - 'LANG': 'en_US.UTF-8', 21:47:57 INFO - 'LANGUAGE': 'en_US:en', 21:47:57 INFO - 'LOGNAME': 'cltbld', 21:47:57 INFO - 'MAIL': '/var/mail/cltbld', 21:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:57 INFO - 'MOZ_NO_REMOTE': '1', 21:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:57 INFO - 'NO_EM_RESTART': '1', 21:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:47:57 INFO - 'PWD': '/builds/slave/test-pgo', 21:47:57 INFO - 'SHELL': '/bin/bash', 21:47:57 INFO - 'SHLVL': '1', 21:47:57 INFO - 'TERM': 'linux', 21:47:57 INFO - 'TMOUT': '86400', 21:47:57 INFO - 'USER': 'cltbld', 21:47:57 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', 21:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:57 INFO - '_': '/tools/buildbot/bin/python'} 21:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:47:57 INFO - Running setup.py (path:/tmp/pip-ThwMNY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:47:58 INFO - Running setup.py (path:/tmp/pip-YYivS7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:47:58 INFO - Running setup.py (path:/tmp/pip-87xnHC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:47:58 INFO - Running setup.py (path:/tmp/pip-nbnEQ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:47:58 INFO - Running setup.py (path:/tmp/pip-_fkB47-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:47:58 INFO - Running setup.py (path:/tmp/pip-y6Opk9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:47:58 INFO - Running setup.py (path:/tmp/pip-FTnj1O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:47:58 INFO - Running setup.py (path:/tmp/pip-5OaQ5U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:47:58 INFO - Running setup.py (path:/tmp/pip-54juLK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:47:58 INFO - Running setup.py (path:/tmp/pip-cgnwtU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:47:58 INFO - Running setup.py (path:/tmp/pip-ZRQTNT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:47:58 INFO - Running setup.py (path:/tmp/pip-uy6TpX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:47:58 INFO - Running setup.py (path:/tmp/pip-DwQHUc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:47:58 INFO - Running setup.py (path:/tmp/pip-YXX6zI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:47:58 INFO - Running setup.py (path:/tmp/pip-b4R5Ny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:47:59 INFO - Running setup.py (path:/tmp/pip-p8HjPW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:47:59 INFO - Running setup.py (path:/tmp/pip-8URpgE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:47:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:47:59 INFO - Running setup.py install for manifestparser 21:47:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:47:59 INFO - Running setup.py install for mozcrash 21:47:59 INFO - Running setup.py install for mozdebug 21:47:59 INFO - Running setup.py install for mozdevice 21:47:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:47:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:47:59 INFO - Running setup.py install for mozfile 21:47:59 INFO - Running setup.py install for mozhttpd 21:47:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:47:59 INFO - Running setup.py install for mozinfo 21:47:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:47:59 INFO - Running setup.py install for mozInstall 21:47:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:47:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:47:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:47:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:47:59 INFO - Running setup.py install for mozleak 21:48:00 INFO - Running setup.py install for mozlog 21:48:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:48:00 INFO - Running setup.py install for moznetwork 21:48:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:48:00 INFO - Running setup.py install for mozprocess 21:48:00 INFO - Running setup.py install for mozprofile 21:48:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:48:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:48:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:48:00 INFO - Running setup.py install for mozrunner 21:48:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:48:00 INFO - Running setup.py install for mozscreenshot 21:48:00 INFO - Running setup.py install for moztest 21:48:00 INFO - Running setup.py install for mozversion 21:48:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:48:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:48:00 INFO - Cleaning up... 21:48:00 INFO - Return code: 0 21:48:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:00 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 0x7f3616f19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28187f0>, '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 0x27842d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2784760>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', '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 21:48:00 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 21:48:00 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 21:48:00 INFO - Using env: {'DISPLAY': ':0', 21:48:00 INFO - 'HOME': '/home/cltbld', 21:48:00 INFO - 'LANG': 'en_US.UTF-8', 21:48:00 INFO - 'LANGUAGE': 'en_US:en', 21:48:00 INFO - 'LOGNAME': 'cltbld', 21:48:00 INFO - 'MAIL': '/var/mail/cltbld', 21:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:00 INFO - 'MOZ_NO_REMOTE': '1', 21:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:00 INFO - 'NO_EM_RESTART': '1', 21:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:00 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:00 INFO - 'SHELL': '/bin/bash', 21:48:00 INFO - 'SHLVL': '1', 21:48:00 INFO - 'TERM': 'linux', 21:48:00 INFO - 'TMOUT': '86400', 21:48:00 INFO - 'USER': 'cltbld', 21:48:00 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', 21:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:00 INFO - '_': '/tools/buildbot/bin/python'} 21:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:48:01 INFO - Running setup.py (path:/tmp/pip-omPF5P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:48:01 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)) 21:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:48:01 INFO - Running setup.py (path:/tmp/pip-7LI5d_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:48:01 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)) 21:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:48:01 INFO - Running setup.py (path:/tmp/pip-hVapis-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:48:01 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)) 21:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:48:01 INFO - Running setup.py (path:/tmp/pip-d4wG0y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:48:01 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)) 21:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:48:01 INFO - Running setup.py (path:/tmp/pip-D5Ni3d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:48:01 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)) 21:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:48:01 INFO - Running setup.py (path:/tmp/pip-oCs66V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:48:01 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)) 21:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:48:01 INFO - Running setup.py (path:/tmp/pip-qTKcfv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:48:01 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)) 21:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:48:01 INFO - Running setup.py (path:/tmp/pip-zYWnnZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:48:01 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)) 21:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:48:01 INFO - Running setup.py (path:/tmp/pip-isbRKt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:48:01 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)) 21:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:48:01 INFO - Running setup.py (path:/tmp/pip-oK_ItD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:48:01 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)) 21:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:48:01 INFO - Running setup.py (path:/tmp/pip-CP1H7F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:48:01 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)) 21:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:48:01 INFO - Running setup.py (path:/tmp/pip-Uulynx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:48:02 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)) 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:48:02 INFO - Running setup.py (path:/tmp/pip-8arOGU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:48:02 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)) 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:48:02 INFO - Running setup.py (path:/tmp/pip-n0ue8z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:48:02 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)) 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:48:02 INFO - Running setup.py (path:/tmp/pip-mO1aGj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:48:02 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)) 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:48:02 INFO - Running setup.py (path:/tmp/pip-ZA9ZhK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:48:02 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)) 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:48:02 INFO - Running setup.py (path:/tmp/pip-YqodOA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:48:02 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)) 21:48:02 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)) 21:48:02 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)) 21:48:02 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)) 21:48:02 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)) 21:48:02 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)) 21:48:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:48:02 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 21:48:02 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 21:48:02 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 21:48:02 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 21:48:02 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 21:48:02 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 21:48:04 INFO - Downloading blessings-1.5.1.tar.gz 21:48:04 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 21:48:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:48:04 INFO - Installing collected packages: blessings 21:48:04 INFO - Running setup.py install for blessings 21:48:04 INFO - Successfully installed blessings 21:48:04 INFO - Cleaning up... 21:48:04 INFO - Return code: 0 21:48:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:48:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:48:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:48:04 INFO - Reading from file tmpfile_stdout 21:48:04 INFO - Current package versions: 21:48:04 INFO - argparse == 1.2.1 21:48:04 INFO - blessings == 1.5.1 21:48:04 INFO - blobuploader == 1.2.4 21:48:04 INFO - docopt == 0.6.1 21:48:04 INFO - manifestparser == 1.1 21:48:04 INFO - mozInstall == 1.12 21:48:04 INFO - mozcrash == 0.16 21:48:04 INFO - mozdebug == 0.1 21:48:04 INFO - mozdevice == 0.47 21:48:04 INFO - mozfile == 1.2 21:48:04 INFO - mozhttpd == 0.7 21:48:04 INFO - mozinfo == 0.9 21:48:04 INFO - mozleak == 0.1 21:48:04 INFO - mozlog == 3.1 21:48:04 INFO - moznetwork == 0.27 21:48:04 INFO - mozprocess == 0.22 21:48:04 INFO - mozprofile == 0.28 21:48:04 INFO - mozrunner == 6.11 21:48:04 INFO - mozscreenshot == 0.1 21:48:04 INFO - mozsystemmonitor == 0.0 21:48:04 INFO - moztest == 0.7 21:48:04 INFO - mozversion == 1.4 21:48:04 INFO - psutil == 3.1.1 21:48:04 INFO - requests == 1.2.3 21:48:04 INFO - wsgiref == 0.1.2 21:48:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:48: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')]} 21:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48: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')]} 21:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48: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', '-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 0x7f3616f19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28187f0>, '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 0x27842d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2784760>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', '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 21:48:04 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 21:48:04 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 21:48:04 INFO - Using env: {'DISPLAY': ':0', 21:48:04 INFO - 'HOME': '/home/cltbld', 21:48:04 INFO - 'LANG': 'en_US.UTF-8', 21:48:04 INFO - 'LANGUAGE': 'en_US:en', 21:48:04 INFO - 'LOGNAME': 'cltbld', 21:48:04 INFO - 'MAIL': '/var/mail/cltbld', 21:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:04 INFO - 'MOZ_NO_REMOTE': '1', 21:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:04 INFO - 'NO_EM_RESTART': '1', 21:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:04 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:04 INFO - 'SHELL': '/bin/bash', 21:48:04 INFO - 'SHLVL': '1', 21:48:04 INFO - 'TERM': 'linux', 21:48:04 INFO - 'TMOUT': '86400', 21:48:04 INFO - 'USER': 'cltbld', 21:48:04 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', 21:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:04 INFO - '_': '/tools/buildbot/bin/python'} 21:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:04 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)) 21:48:04 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)) 21:48:04 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)) 21:48:04 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)) 21:48:04 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)) 21:48:04 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)) 21:48:04 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)) 21:48:04 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)) 21:48:04 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)) 21:48:04 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)) 21:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:48:04 INFO - Cleaning up... 21:48:04 INFO - Return code: 0 21:48:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:48: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')]} 21:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48: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')]} 21:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3616f19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28187f0>, '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 0x27842d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2784760>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', '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 21:48: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', 'jsonschema'] in /builds/slave/test-pgo/build 21:48: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 jsonschema 21:48:04 INFO - Using env: {'DISPLAY': ':0', 21:48:04 INFO - 'HOME': '/home/cltbld', 21:48:04 INFO - 'LANG': 'en_US.UTF-8', 21:48:04 INFO - 'LANGUAGE': 'en_US:en', 21:48:04 INFO - 'LOGNAME': 'cltbld', 21:48:04 INFO - 'MAIL': '/var/mail/cltbld', 21:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:04 INFO - 'MOZ_NO_REMOTE': '1', 21:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:04 INFO - 'NO_EM_RESTART': '1', 21:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:04 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:04 INFO - 'SHELL': '/bin/bash', 21:48:04 INFO - 'SHLVL': '1', 21:48:04 INFO - 'TERM': 'linux', 21:48:04 INFO - 'TMOUT': '86400', 21:48:04 INFO - 'USER': 'cltbld', 21:48:04 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', 21:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:04 INFO - '_': '/tools/buildbot/bin/python'} 21:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:04 INFO - Downloading/unpacking jsonschema 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:48:06 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 21:48:06 INFO - Downloading/unpacking functools32 (from jsonschema) 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48:06 INFO - Downloading functools32-3.2.3-2.tar.gz 21:48:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:48:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:48:06 INFO - warning: no files found matching '*.txt' 21:48:06 INFO - no previously-included directories found matching 'build' 21:48:06 INFO - no previously-included directories found matching 'dist' 21:48:06 INFO - no previously-included directories found matching '.git*' 21:48:06 INFO - Installing collected packages: jsonschema, functools32 21:48:06 INFO - Running setup.py install for functools32 21:48:07 INFO - warning: no files found matching '*.txt' 21:48:07 INFO - no previously-included directories found matching 'build' 21:48:07 INFO - no previously-included directories found matching 'dist' 21:48:07 INFO - no previously-included directories found matching '.git*' 21:48:07 INFO - Successfully installed jsonschema functools32 21:48:07 INFO - Cleaning up... 21:48:07 INFO - Return code: 0 21:48:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3616f19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28187f0>, '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 0x27842d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2784760>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', '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 21:48:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 21:48:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:48:07 INFO - Using env: {'DISPLAY': ':0', 21:48:07 INFO - 'HOME': '/home/cltbld', 21:48:07 INFO - 'LANG': 'en_US.UTF-8', 21:48:07 INFO - 'LANGUAGE': 'en_US:en', 21:48:07 INFO - 'LOGNAME': 'cltbld', 21:48:07 INFO - 'MAIL': '/var/mail/cltbld', 21:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:07 INFO - 'MOZ_NO_REMOTE': '1', 21:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:07 INFO - 'NO_EM_RESTART': '1', 21:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:07 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:07 INFO - 'SHELL': '/bin/bash', 21:48:07 INFO - 'SHLVL': '1', 21:48:07 INFO - 'TERM': 'linux', 21:48:07 INFO - 'TMOUT': '86400', 21:48:07 INFO - 'USER': 'cltbld', 21:48:07 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', 21:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:07 INFO - '_': '/tools/buildbot/bin/python'} 21:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:07 INFO - Downloading/unpacking flake8 21:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:48:08 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 21:48:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:48:09 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 21:48:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:09 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 21:48:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:48:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:48:09 INFO - no previously-included directories found matching 'docs/_build' 21:48:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:48:09 INFO - Running setup.py install for pep8 21:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:48:09 INFO - no previously-included directories found matching 'docs/_build' 21:48:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:48:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:48:09 INFO - Cleaning up... 21:48:09 INFO - Return code: 0 21:48:09 INFO - Running post-action listener: _resource_record_post_action 21:48:09 INFO - Running post-action listener: _start_resource_monitoring 21:48:09 INFO - Starting resource monitoring. 21:48:09 INFO - ##### 21:48:09 INFO - ##### Running install step. 21:48:09 INFO - ##### 21:48:09 INFO - Running pre-action listener: _resource_record_pre_action 21:48:09 INFO - Running main action method: install 21:48:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:48:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:48:10 INFO - Reading from file tmpfile_stdout 21:48:10 INFO - Detecting whether we're running mozinstall >=1.0... 21:48:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:48:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:48:10 INFO - Reading from file tmpfile_stdout 21:48:10 INFO - Output received: 21:48:10 INFO - Usage: mozinstall [options] installer 21:48:10 INFO - Options: 21:48:10 INFO - -h, --help show this help message and exit 21:48:10 INFO - -d DEST, --destination=DEST 21:48:10 INFO - Directory to install application into. [default: 21:48:10 INFO - "/builds/slave/test-pgo"] 21:48:10 INFO - --app=APP Application being installed. [default: firefox] 21:48:10 INFO - mkdir: /builds/slave/test-pgo/build/application 21:48:10 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'] 21:48:10 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 21:48:26 INFO - Reading from file tmpfile_stdout 21:48:26 INFO - Output received: 21:48:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:48:26 INFO - Running post-action listener: _resource_record_post_action 21:48:26 INFO - ##### 21:48:26 INFO - ##### Running run-tests step. 21:48:26 INFO - ##### 21:48:26 INFO - Running pre-action listener: _resource_record_pre_action 21:48:26 INFO - Running main action method: run_tests 21:48:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:48:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:48:26 INFO - Python 2.7.3 21:48:26 INFO - Return code: 0 21:48:26 INFO - grabbing minidump binary from tooltool 21:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:26 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 0x28187f0>, '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 0x27842d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2784760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:48:26 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 21:48:26 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 21:48:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:48:26 INFO - Return code: 0 21:48:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:48:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:48:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:48:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:48:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:48:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:48:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:48:27 INFO - Return code: 0 21:48:27 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/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 21:48:27 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/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 21:48:27 INFO - Using env: {'DISPLAY': ':0', 21:48:27 INFO - 'HOME': '/home/cltbld', 21:48:27 INFO - 'LANG': 'en_US.UTF-8', 21:48:27 INFO - 'LANGUAGE': 'en_US:en', 21:48:27 INFO - 'LOGNAME': 'cltbld', 21:48:27 INFO - 'MAIL': '/var/mail/cltbld', 21:48:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:48:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:27 INFO - 'MOZ_NO_REMOTE': '1', 21:48:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:27 INFO - 'NO_EM_RESTART': '1', 21:48:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:27 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:48:27 INFO - 'SHELL': '/bin/bash', 21:48:27 INFO - 'SHLVL': '1', 21:48:27 INFO - 'TERM': 'linux', 21:48:27 INFO - 'TMOUT': '86400', 21:48:27 INFO - 'USER': 'cltbld', 21:48:27 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759', 21:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:27 INFO - '_': '/tools/buildbot/bin/python'} 21:48:27 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/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 21:48:27 INFO - mozversion application_buildid: 20151229193155 21:48:27 INFO - mozversion application_changeset: 3becd09c71b176713af62aae2646249cab9ff893 21:48:27 INFO - mozversion application_display_name: Nightly 21:48:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:48:27 INFO - mozversion application_name: Firefox 21:48:27 INFO - mozversion application_remotingname: firefox 21:48:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:48:27 INFO - mozversion application_vendor: Mozilla 21:48:27 INFO - mozversion application_version: 46.0a1 21:48:27 INFO - mozversion platform_buildid: 20151229193155 21:48:27 INFO - mozversion platform_changeset: 3becd09c71b176713af62aae2646249cab9ff893 21:48:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:48:27 INFO - mozversion platform_version: 46.0a1 21:48:27 INFO - using testdate: 1451454507 21:48:27 INFO - actual date: 1451454507 21:48:27 INFO - starting webserver on 'localhost:35720' 21:48:27 INFO - SUITE-START | Running 3 tests 21:48:27 INFO - TEST-START | dromaeo_css 21:48:27 INFO - operating with platform_type : linux_ 21:48:27 INFO - Initialising browser for dromaeo_css test... 21:48:27 INFO - TEST-INFO | started process 6992 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppi4ncy/profile http://localhost:35720/getInfo.html) 21:48:28 INFO - PROCESS | 6992 | Failed to load Oculus VR library! 21:48:31 INFO - PROCESS | 6992 | Failed to load Oculus VR library! 21:48:31 INFO - PROCESS | 6992 | __metrics Screen width/height:1600/1200 21:48:31 INFO - PROCESS | 6992 | colorDepth:24 21:48:31 INFO - PROCESS | 6992 | Browser inner width/height: 1024/697 21:48:31 INFO - PROCESS | 6992 | __metrics 21:48:31 INFO - PROCESS | 6992 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:48:32 INFO - TEST-INFO | 6992: exit 0 21:48:32 INFO - Browser initialized. 21:48:32 INFO - Running cycle 1/1 for dromaeo_css test... 21:48:32 INFO - TEST-INFO | started process 7125 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppi4ncy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:48:33 INFO - PROCESS | 7125 | Failed to load Oculus VR library! 21:48:34 INFO - PROCESS | 7125 | Failed to load Oculus VR library! 21:48:44 INFO - PROCESS | 7125 | RSS: Main: 149286912 21:48:44 INFO - PROCESS | 7125 | 21:49:34 INFO - PROCESS | 7125 | 1451454574241 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] 21:51:43 INFO - PROCESS | 7125 | Cycle 1(1): loaded http://localhost:35720/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35720/tests/dromaeo/cssquery-ext.html) 21:51:44 INFO - PROCESS | 7125 | RSS: Main: 157442048 21:51:44 INFO - PROCESS | 7125 | 21:54:46 INFO - PROCESS | 7125 | Cycle 1(1): loaded http://localhost:35720/tests/dromaeo/cssquery-ext.html (next: http://localhost:35720/tests/dromaeo/cssquery-jquery.html) 21:54:47 INFO - PROCESS | 7125 | RSS: Main: 151670784 21:54:47 INFO - PROCESS | 7125 | 21:57:49 INFO - PROCESS | 7125 | Cycle 1(1): loaded http://localhost:35720/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35720/tests/dromaeo/cssquery-mootools.html) 21:57:49 INFO - PROCESS | 7125 | RSS: Main: 153382912 21:57:49 INFO - PROCESS | 7125 | 22:00:51 INFO - PROCESS | 7125 | Cycle 1(1): loaded http://localhost:35720/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35720/tests/dromaeo/cssquery-prototype.html) 22:00:51 INFO - PROCESS | 7125 | RSS: Main: 152170496 22:00:51 INFO - PROCESS | 7125 | 22:03:54 INFO - PROCESS | 7125 | Cycle 1(1): loaded http://localhost:35720/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35720/tests/dromaeo/cssquery-yui.html) 22:03:54 INFO - PROCESS | 7125 | RSS: Main: 152600576 22:03:54 INFO - PROCESS | 7125 | 22:06:57 INFO - PROCESS | 7125 | Cycle 1(1): loaded http://localhost:35720/tests/dromaeo/cssquery-yui.html (next: http://localhost:35720/tests/dromaeo/cssquery-dojo.html) 22:06:57 INFO - PROCESS | 7125 | RSS: Main: 155357184 22:06:57 INFO - PROCESS | 7125 | 22:06:57 INFO - PROCESS | 7125 | __start_tp_report 22:06:57 INFO - PROCESS | 7125 | _x_x_mozilla_page_load 22:06:57 INFO - PROCESS | 7125 | _x_x_mozilla_page_load_details 22:06:57 INFO - PROCESS | 7125 | |i|pagename|runs| 22:06:57 INFO - PROCESS | 7125 | |0;dojo.html;3218.1632775478374;3284.9343013139724;3287.9506807397893;3324.999999999999;3328;5215.869603259911;5408.594355423339;5430.728463576826;5440.918386224205;5453.154761012044;5274.841754747355;5329.094054010818;5346.1713434417725;5361.839144825662;5390.838274851751;4571.1771881061395;4848.975755121228;5090.898182036357;5099.08216521026;5116.309298244745;4863.465018847924;4977.900441991158;5028.7485625718755;5088.669236499616;5090.567301779353;4857.902841943177;4868.56182943535;4939.259111133359;4945.8268960586565;4975.577075948549;4940.6788558743565;4957.727324997124;4975.7263350515705;4991.575716064139;4997.6001919846685;4877.365942427462;4941.234108713155;4953.727544985024;4965.453800082024;5036.445990940993;5222.477752224785;5246.947530524684;5291.28567643367;5328.6802791832615;5375.354957405098;5721.542276617861;5825.475707186331;5830.708464576796;5830.82507524775;5832.504237139849;5750.108733146369;5770.278715160605;5842.269716285465;5863.296404431496;5877.177195192677;5407.215953686733;5410.91883621746;5416.674999500043;5417.106177480711;5424.294841670558;5933.703314834241;5935.584509084322;5939.673317967553;5941.970290148522;5947.762089516371;5595.608307418442;5601.60788744784;5746.051901436216;5762.078067509262;5776;5828.300603927556;5830.7084645767545;5843.590948633555;5860.765569377262;5872.970635146797;5745.569082318842;5749.9425005750245;5773.422657734277;5790.855228619318;5791.594588378857;5626.887462250814;5672.886542269214;5750.137479378043;5778.768849245983;5791;4389.275769498061;4415.205263052681;4430.224710675619;4431;4433.357163211316;3943.960560394417;3947.585503522089;3962.841486340572;4001.09975255571;4011.7793521356607;5309.522143007148;5387.138057910794;5404.405515393303;5411.161270003156;5418.91871621926;5689.743961521742;5705.686187259741;5706.572007099484;5731.799387021434;5743.971280143573;5370.516653501204;5371.248025276464;5383.515483606494;5418.458154184629;5533.612647114744;5018.648694591344;5022.246663000579;5022.397312322471;5028.17035189197;5070.518300761421;5972.462478376967;5987.580869339192;5991.430814072656;6002.309734380515;6013.368596297413;5640.71796410186;5740.1102829061565;5790.986577349031;5794.681292528951;5795.536357091339;5890.52875769946;5895.616784908967;5906.173135761082;5915.201447804491;5917.881642367042;5646.971765141148;5649.039663257174;5668.914966275427;5697.116946873241;5824.068149096124;5855.092460668603;5861.6189947653265;5869.735861886311;5873.2658417697785;5891.351951285441;5702.714864256854;5702.857428564319;5710;5710.571707122065;5712.37163911961;5552.583556233218;5662.915056274077;5674.460926212003;5756.539476841926;5807.070868660994;5553.777848885999;5571.470710282517;5588.748506317144;5597.244372009726;5615;5567.47109024642;5675.914861277167;5723.484886360247;5733.885322293448;5751.137329400456;5525.668459892419;5544.889102218014;5607.80372686954;5631.63394379364;5681.801136960186 22:06:57 INFO - PROCESS | 7125 | |1;ext.html;527.4119356917037;539.9244105825184;554.271133459501;561.5058748301495;566.8922904648117;35576.2884742305;36483;36549.45175822365;36644.26711465773;36773.632263677355;39143.41284880729;39615.20769584607;39618.8019059905;39727.205455890864;39747.40378894312;8570.442921210133;8711.60797764099;8762.86855697165;8768.035516093225;8802.427842190269;8303.169683031709;8416.242538171564;8557.272631826303;8582.184692454206;8585.270252028586;8675.913240867574;8862.86705699415;8870.512121833297;8871.733847984571;8884.733457996239;8629.093945135764;8720.8691869622;8755;8765.824683506295;8788.8681669775;8580.871286930702;8654.264387527004;8751.299896008304;8777.122287771235;8789.296856251485;39723;40019;40295.39556906649;40321.59678403208;40366.59633403687;3173.825439600821;3247.8213698246586;3314.5691060162267;3351.949720754191;3477.4436090225695;28898.855505722546;29503;29795.25511862199;29851.552226716616;30489.695103048907;3787.6780473659774;3849.8087036125175;3897.4738410314526;3982.9402558961638;4018.3771515415156;254624;254993;255777;257626.99999999814;257881;42135;42534.149317013485;58785;59341.70329148413;59354;42829;42928.78535607365;43271.783641081594;43344.3498347525;43550.56449435528;15120.621984450478;15198.240087995557;15243.23783810805;15253.38986440552;15264.542063738105;10682.946585267024;10784.78430431387;10791.40647264408;10848.240623156304;10850.186236032328;14278.643033924234;14447.422103115758;14485.493007744679;14548.490802822062;14552.417903283962;5753.712314384264;5762.279715035621;5796.855078623068;5874.471297583238;5896.970515147397;923.9769005774909;955.6368579939717;1002.548853016131;1012.1700205831295;1012.427978192319;29132.126036218946;31220.219494512818;31309.530357044663;32256.516152257736;32530.512042319384;1079.6922876980022;1091.6615849086809;1119.2333251722596;1162.4129814443652;1180.9055275577932;14735.55793326202;14778.408863645334;14823.851761482247;14923.626909327137;15074.924625376803;396401;401471;404795;405935;407947;52519.73740131275;52541.2118818218;52646.21030684543;52759.736201318745;52958.14646487431;1358.8844948179515;1365.2491129878526;1374.0793668242302;1376.8072469854228;1382.2604906375243;28069.298267543476;28818.27954301159;29182;29517;29715.55426668645;45861.31208031949;46328;46448.53551464442;46539.76730116328;46579;313190;314640;316549;317295;319448;32583.837080814443;43067.353989690804;43294.567054329054;44009.77995110004;44074.11851762883;41659.7917010413;43432.34851477167;43749;43794.56205437905;44120.33819492775;36487.249294403104;36951.445728313556;37080.25839483249;37406;37958.43062354122;36986.26027479489;39039.41440878446;42239.57760422357;42295.57704422916;43181.56818431775;35373.46939795957;36404.27191456209;36521.452178216816;36551.45172822463;36579.634203657624;30617.387652247275;33164.50253246155;33580.83209584034;33773.49339759856;33938;25791.871040644677;26034.218973430827;26349.341266467723;26840;27710.307242318297 22:06:57 INFO - PROCESS | 7125 | |2;jquery.html;344.42652982783665;346.5065567404487;349.14285429271143;350.0670712551051;350.4777880957374;14265.928670356634;14590.197539135343;16367.263473143707;16715.414960476384;17586.1206939653;15240.69518609627;15523.301451434685;16126.113063781488;16219.918900405512;16421.17894105293;5047.293378926953;5297.417284098746;5327.653702509344;5344.331958505187;5353.250544923714;5044.39467263927;5206.479352064782;5215.765290561915;5247.370315562138;5253.185756207775;5194.766235519392;5214.947850521503;5231.633785635007;5244.79020839166;5991.520678345743;5932.88134237315;5983.640981541122;6004.879902401949;6011.879762404771;6019.157317975465;5241.554467870235;5253.947460525423;5316.840494785162;5352.357717073937;5353.9732301338245;12333.075019373493;12596.748065038648;12633.2420054797;14706.411743530245;20699.27552535669;2129.7337832770904;2161.7189765330563;2169.0889826272846;2177.412098733349;2280.7947284744287;9430.481323527203;9668.419894806264;9790.461524616143;9922.454265015422;13353.86646133536;1749.2041121289783;1784.8304411080926;1786.1069465267367;1816.6820806358967;1853.4161739052156;59035.704821475614;59366.703166483894;59838;62525.74948501005;63252.68373658102;9651.565679544437;10018.998100190069;10034.197264218845;10051.195904327637;10156;12739.171953822972;12893.806592901114;12896.871031289567;12929.030322725834;12934;7334.413246940232;7350.117985841626;7356.595387253752;7383.593902335423;7470.477066605394;6962.408195303456;7034.331738484836;7037.753678621224;7073.823154421078;7084.893726594105;4225.514065882401;4231.746095234295;4324.308110702335;4357.716748411406;4374.934375984363;1806.2955447375534;1806.6206096719573;1835.0824587706147;1837.6324735053042;1845.4002449204063;860.9870851937226;866.5580553917422;883.6553744039829;1002.6089824968268;1019.0359501539019;16844;17078.658426831393;17259.13704314779;17457.47627571175;17748.467545973643;905.9003509613938;922.0594993106994;974.8147851908114;991.2813210422386;1004.352192835617;8900.109989001048;9167.724968250963;9598.232141428669;10150.847737283946;10209.591616335412;538200;540722;541039;551645;590900;78849.21150788419;81368.18631813607;82316;83016;83091.58454207811;1157.0512180012477;1159.8202278646822;1173.102576528973;1176.311857563335;1180.7107258721496;15699.372025118868;15797.131157786433;15974.760378594097;16069.919650401673;16212.918935405247;35204.823975879954;35874.28251435009;36186.63813361938;36213.63786362103;36993.44509832408;47063.764681177745;48953.818001829764;49140.50859491359;49333.506664932895;53529.19706204488;9449.763755906157;9461.574229159567;9617.374870633386;9891.159251463418;9961.50192490387;13639.931800340935;13917;16621.750673740145;16873.91563042177;17857.910710446366;13467.3939672713;14016.509422170582;14809.703805924037;15153.54539363821;15245.847541524443;14007.299635018413;14087.929560352133;14249.928750356183;14811.629709257355;15061.924690376478;14295.28523573838;14607;14643.780343295071;14918.552443426715;15111.622209444851;9312.255019598551;9467.289953253396;9503.19222866064;9684.85472717924;9695.9030409695;14108.153510788974;14118.43526258938;14404.711905762035;14584.343704533534;14697.41210351574 22:06:57 INFO - PROCESS | 7125 | |3;mootools.html;1156.9016633586145;1187.5012494752202;1269.9365031748414;1670.6408122253713;1672.5985763416777;6985.5459395139405;7044.577325360482;7070.186928503217;7115.18175409828;7177.60523171226;7133.714651413938;7183.928160718391;7249.876269178272;7256.310650488195;7308.415326773858;2176.4341271269427;2212.590670725913;2213.1368766181204;2213.8339624528144;2220.034285085993;2175.9782402176015;2203.4381232785618;2205.9227927022557;2214.3135627955385;2225.9554808903813;2186.967195492061;2216.312942987671;2231.866088034723;2236.541508990661;2240.4622890506243;2192.1012384922105;2214.202886960693;2226.398872304485;2241.204372447774;2242.618754811686;2217.6119179143584;2260.288009277089;2261.830362722786;2263.219189379661;2264.4338915271182;6853.897191542131;6885.036094946711;6904.3095690431055;6940.236573976858;6945.340192681687;4361.149575832714;4428.623566996777;4438.42300500936;4444.688871778977;4447.0661161156195;2925.3856690095104;2988;2997.220722612115;3008.9548656770166;3009.1423944175804;948.2366694810675;953.7901661634429;979.1236843025453;1040.5785656809005;1080.0927221134207;9497.5726092326;9528.142467177919;9534.52327383635;9539.618415263381;9558.378705384128;3841.0013396516547;3858.9421158682644;3917.275304068756;3933.4296527004;3976.204759048202;7992.080910695228;8019.719309824128;8022.0774610919325;8028.397870159762;8048.678052877936;4341.674374421931;4345.34819777036;4346.47842258931;4362.847300344472;4366.868993930188;3987.4218238355274;3997.4803275574573;4017.3773065174946;4022.7787471688753;4029.9798501007895;3278.1968417737808;3290.621578518501;3295.4068267711564;3305.520699498559;3306;981.3719219699398;994.796066806303;999.7750506136207;1011.5549158370441;1012.5342342522375;1006.4514839412537;1025.0723095598496;1025.876894772632;1122.241695212294;1279.0598909801288;6623.039659249382;6688.230853451818;6702.095217145623;6773.288804675537;6794.0827988221945;1113.4098927568239;1120.3503713717164;1121.725177331559;1149.7930372533024;1150.0914277720674;5268.631195816332;5280.471952804689;5303.310569626001;5314.681119132864;5322.414534401213;8083.110857805636;8293.875591866126;8336.041355244104;8342.37432192588;8391.538465384341;8177.509349438934;8229.835403291901;8245.257926786619;8258.958705206436;8298.792530186673;6601.801945941629;6647.268800431949;6692.531522793358;6747.966260168668;6768.864622707519;6774.8645027100165;6794.218664853407;6826.965865170841;6840.863182736417;6850.691718872563;7391.593462359622;7489.251074892467;7507.174210836913;7528.736494222676;7538.3592394644875;7572.8485430292185;7625.313721765067;7634.312911837739;7714.768556943301;7754.612269386621;6032.909506357496;6093.75624974996;6181.721822518088;6186.876262474815;6197.566170368212;6689.866202675822;6704.4301234395625;6744.7976560703255;6747.831304217434;6759.5606285591275;6602.240742314503;6700.731970721116;6712.798616041527;6766.255711871789;6801.727930882709;6167.229096362955;6208.2239720034995;6262.436380725757;6331.715072821642;6372.872542549216;6351.555391122577;6397.904031439625;6407.2631647359285;6413.198350206224;6413.871722565429;5632.831015069554;5894.852628684317;5966.76132954677;5977.193078934288;5977.850553736192;5829.15477255804;5838.678872662044;5874.559408044328;5877.73550190251;5880.941190588211 22:06:57 INFO - PROCESS | 7125 | |4;prototype.html;326.84311530465374;333.33666004650735;337.4853348643317;339.9167204035011;342.52560204117304;6275.5920865143735;6275.807596556657;6307.621542707435;6326.715297811598;6441.935580644192;6228.439440450358;6262.12330273762;6269.9373006269925;6288.528360372968;6291.591046581969;4744.406949131368;4765.142274390609;4770.85687429376;4777.211760059586;4789.832355867546;4773;4776.307435421862;4776.80892764289;4782.7608619569055;4793.472718001017;4568.954310456887;4720.811167553294;4733.526647335273;4733.881652958687;4736.621070314367;4721.055788842245;4726.031163611468;4733.219018861883;4737.45519265282;4747.098051370229;4092.2224777292217;4094.0992981544014;4100.630943215125;4103.220388126247;4135.069609337905;5943.167956486095;5953.1070339449;5971.940280597182;5976.910346344808;5996.13056106862;5455.427180146067;5465.890682186334;5487.506124448779;5508.283923090013;5509.47659972306;6604.735810567571;6605.339466053356;6620.205575330943;6621.470282377399;6639.136912201383;4555.430571178603;4556.977215113936;4559.316102584606;4563.178627846986;4577.8397756078375;6832.658367081675;6868.965655171693;6902.309769023058;6987.231404545496;6992.895106573456;4653.046125544255;4670.439547254283;4672.415948006499;4674;4676.158291507561;4733.95266047342;4734.1241870253425;4735.905281894412;4740.739259340769;4743.051389722001;5481.150421684645;5490.80782172622;5492.917606235909;5496.5053145217125;5518.613697041169;6561.311062338481;6654.168228971379;6713.63075030878;6733.091032710619;6739.224989126314;1628.8778341624188;1656.5941344370706;1681.100611173041;1681.5880109373281;1682.470021943084;1074.940878251688;1111.2499063132516;1120.2830188679088;1120.4061847220985;1126.3861195648392;6208.348123447064;6215.720292586844;6233.875322493615;6262.780802671976;6263.029230469194;6778.084958530634;6782.593044417351;6788.59268443895;6794.150731158606;6817.113775209191;6107.267127944675;6257.311695713468;6260.843478913063;6263.404976527223;6266.561340706198;3696.7597106188014;3701.2967536168044;3701.3522633539023;3701.61133081028;3731.1231860512758;6995.705794428047;7095.467839912028;7119.96440017807;7129.572225666477;7130.821729456805;6782.253952065269;6930.480213983971;6949.409300209438;6959.4432445405255;6967.198772141167;7042;7061.881435569308;7062.15254169503;7070.257622949516;7098.148222213367;6771.052052712723;6804.21751498584;6805.727770889109;6811.931880681328;6820.522563420513;6613.900791488035;6698.526324208667;6734.225564060196;6742.797716068526;6747.628880411428;7083.079199704005;7086.39765619928;7089.220185779664;7095.609741464269;7099.36105750485;4664.277037059262;4668;4670.883227919329;4680.742559159279;4683.203855344667;6793.93206067933;6819.863602728017;6849.589024658537;6860.5540639858245;7063.25835787235;6764.594124352555;6771.119754432089;6803.795886123424;6805.251422343439;6822.079019332326;6761.188657361148;6771.593704377753;6790;6790.185177778698;6803.251642319242;6526.9020964686515;6624.436922861611;6642.83392915181;6672.799816005528;6675;6744.5616034957575;6795.354441328066;6828.760993365408;6829.419499342612;6849.1438570178725;6583.572067815577;6593.934060659332;6647.767328143492;6661.3338666132995;6680.933190668031 22:06:57 INFO - PROCESS | 7125 | |5;yui.html;614.2015380005996;711.8327193109621;733.1056111543918;839.4459656626626;843.4644001059328;11981.460834262458;12002.159848810586;12020.759584808298;12162.087843411746;12194.390280485984;11330.376829274386;11426.428678566059;11446.48490817913;11451;11452.312861228333;800.9359251259885;810.6757297081156;818.5293456262643;818.9344852411823;821.5604651511443;810.8013536683521;822.0710597025383;823.8022874510104;824.6083110522484;824.6289169873581;849.2865992566243;850.4897061762955;853.7438768369495;860.806318578318;861.530465896085;842.0232530264894;846.936479764014;848.2789628815489;849.6813694864426;850.7447765670305;615.230961298377;621.1273161208464;621.7885918787589;623.8770213615473;627.0500192208762;11778.646640600795;11866.169368144234;11919.225250358699;11925.403729813475;11950.46222919962;10007;11042.668719938414;11257.605983790529;11300.94349528247;11481.483333250024;9741;9896.406215627014;10098.141657959082;10119.392836429837;10316.123129533999;3361.0757041813695;3391.6608339166132;3393.728501719881;3400.659934006604;3431.4509678451327;47178.52821471776;47584.286235706495;47680.28479572809;47758.283625745644;47826.52173478255;8157.592120393957;8204.630791614392;8289.4197406181;8604.48373097616;8622.568871556397;14447.78328325076;14508;14528.346224419927;14562.199079050753;14609.853901461061;6965.373116419445;7124.857502850017;7133.500654954207;7216.60308683017;7267.4549408794555;4024.4768180136393;4117.608827161415;4126.381042843537;4151.6886233532005;4219.620234178878;2922.415516896629;2941.794074414813;2947.322115913352;2949.911502654924;2953.527435610292;539.8164624027771;544.5453046705966;553.3249435688454;553.7923278770461;555.081340381669;501.7792171444553;511.3914441814229;582.9329627092853;635.7679447001811;700.7666506947706;7349.63251837406;8123.350131989427;8208;8238.176182381714;8424;529.5207836907605;602.9608075475168;604.2658170323078;627.3224917089532;651.4397618048474;3843.3177886723356;3868.207017561393;4060.614241647039;4146.087860670647;4188.267053265667;58607.120893186635;59201.40798591959;59408;59436.40563594309;59519;51086.23370649443;52029;52234.73882630563;52341;52341.47658523366;45908.770456147504;46218.53781462142;46222;46483.53516464792;46850.29724554135;8144.633491492778;8391.081501749775;8476.915230847859;8568.871466927876;8703.869441958503;33924.32151357008;33986.3202735939;34123.317533649686;34398.14004649804;34419.311613768084;42449.36325955175;46147.76926115348;46225.92971852417;46565.3015204779;46612.300815488474;10499.895001049892;10672;10750.139988801033;10764.192685548773;10824.56701731922;11574.884251157717;11669.474873630877;11781.234219775688;12022.158448908493;12114.636560903187;10281.383117013003;10482.737931551772;10503.842442363219;10550;11326.37704926204;10292.845607315747;10478.318909271178;10561.683149505527;10564.418956957441;10773.24587278883;9349.532523373668;9703.854442183232;9816;9841.557129929313;10774.784504309713;9107.544622768968;9492.810143797224;9507.286953478655;9524.666636667684;9610.807783844424;8556.657733690832;9138.406003609743;9338.906610934075;9347.117407211477;9564.13922746956 22:06:57 INFO - PROCESS | 7125 | __end_tp_report 22:06:57 INFO - PROCESS | 7125 | __start_cc_report 22:06:57 INFO - PROCESS | 7125 | _x_x_mozilla_cycle_collect,312 22:06:57 INFO - PROCESS | 7125 | __end_cc_report 22:06:57 INFO - PROCESS | 7125 | __startTimestamp1451455617493__endTimestamp 22:06:57 INFO - PROCESS | 7125 | 22:06:57 INFO - PROCESS | 7125 | ------- Summary: start ------- 22:06:57 INFO - PROCESS | 7125 | Number of tests: 6 22:06:57 INFO - PROCESS | 7125 | 22:06:57 INFO - PROCESS | 7125 | [#0] dojo.html Cycles:165 Average:5380.83 Median:5595.61 stddev:587.59 (10.5%) stddev-sans-first:564.37 22:06:57 INFO - PROCESS | 7125 | Values: 3218.2 3284.9 3288.0 3325.0 3328.0 5215.9 5408.6 5430.7 5440.9 5453.2 5274.8 5329.1 5346.2 5361.8 5390.8 4571.2 4849.0 5090.9 5099.1 5116.3 4863.5 4977.9 5028.7 5088.7 5090.6 4857.9 4868.6 4939.3 4945.8 4975.6 4940.7 4957.7 4975.7 4991.6 4997.6 4877.4 4941.2 4953.7 4965.5 5036.4 5222.5 5246.9 5291.3 5328.7 5375.4 5721.5 5825.5 5830.7 5830.8 5832.5 5750.1 5770.3 5842.3 5863.3 5877.2 5407.2 5410.9 5416.7 5417.1 5424.3 5933.7 5935.6 5939.7 5942.0 5947.8 5595.6 5601.6 5746.1 5762.1 5776.0 5828.3 5830.7 5843.6 5860.8 5873.0 5745.6 5749.9 5773.4 5790.9 5791.6 5626.9 5672.9 5750.1 5778.8 5791.0 4389.3 4415.2 4430.2 4431.0 4433.4 3944.0 3947.6 3962.8 4001.1 4011.8 5309.5 5387.1 5404.4 5411.2 5418.9 5689.7 5705.7 5706.6 5731.8 5744.0 5370.5 5371.2 5383.5 5418.5 5533.6 5018.6 5022.2 5022.4 5028.2 5070.5 5972.5 5987.6 5991.4 6002.3 6013.4 5640.7 5740.1 5791.0 5794.7 5795.5 5890.5 5895.6 5906.2 5915.2 5917.9 5647.0 5649.0 5668.9 5697.1 5824.1 5855.1 5861.6 5869.7 5873.3 5891.4 5702.7 5702.9 5710.0 5710.6 5712.4 5552.6 5662.9 5674.5 5756.5 5807.1 5553.8 5571.5 5588.7 5597.2 5615.0 5567.5 5675.9 5723.5 5733.9 5751.1 5525.7 5544.9 5607.8 5631.6 5681.8 22:06:57 INFO - PROCESS | 7125 | 22:06:57 INFO - PROCESS | 7125 | [#1] ext.html Cycles:180 Average:48637.90 Median:20904.12 stddev:86998.20 (416.2%) stddev-sans-first:87167.27 22:06:57 INFO - PROCESS | 7125 | Values: 527.4 539.9 554.3 561.5 566.9 35576.3 36483.0 36549.5 36644.3 36773.6 39143.4 39615.2 39618.8 39727.2 39747.4 8570.4 8711.6 8762.9 8768.0 8802.4 8303.2 8416.2 8557.3 8582.2 8585.3 8675.9 8862.9 8870.5 8871.7 8884.7 8629.1 8720.9 8755.0 8765.8 8788.9 8580.9 8654.3 8751.3 8777.1 8789.3 39723.0 40019.0 40295.4 40321.6 40366.6 3173.8 3247.8 3314.6 3351.9 3477.4 28898.9 29503.0 29795.3 29851.6 30489.7 3787.7 3849.8 3897.5 3982.9 4018.4 254624.0 254993.0 255777.0 257627.0 257881.0 42135.0 42534.1 58785.0 59341.7 59354.0 42829.0 42928.8 43271.8 43344.3 43550.6 15120.6 15198.2 15243.2 15253.4 15264.5 10682.9 10784.8 10791.4 10848.2 10850.2 14278.6 14447.4 14485.5 14548.5 14552.4 5753.7 5762.3 5796.9 5874.5 5897.0 924.0 955.6 1002.5 1012.2 1012.4 29132.1 31220.2 31309.5 32256.5 32530.5 1079.7 1091.7 1119.2 1162.4 1180.9 14735.6 14778.4 14823.9 14923.6 15074.9 396401.0 401471.0 404795.0 405935.0 407947.0 52519.7 52541.2 52646.2 52759.7 52958.1 1358.9 1365.2 1374.1 1376.8 1382.3 28069.3 28818.3 29182.0 29517.0 29715.6 45861.3 46328.0 46448.5 46539.8 46579.0 313190.0 314640.0 316549.0 317295.0 319448.0 32583.8 43067.4 43294.6 44009.8 44074.1 41659.8 43432.3 43749.0 43794.6 44120.3 36487.2 36951.4 37080.3 37406.0 37958.4 36986.3 39039.4 42239.6 42295.6 43181.6 35373.5 36404.3 36521.5 36551.5 36579.6 30617.4 33164.5 33580.8 33773.5 33938.0 25791.9 26034.2 26349.3 26840.0 27710.3 22:06:57 INFO - PROCESS | 7125 | 22:06:57 INFO - PROCESS | 7125 | [#2] jquery.html Cycles:180 Average:29205.71 Median:35539.55 stddev:90376.22 (254.3%) stddev-sans-first:90603.76 22:06:57 INFO - PROCESS | 7125 | Values: 344.4 346.5 349.1 350.1 350.5 14265.9 14590.2 16367.3 16715.4 17586.1 15240.7 15523.3 16126.1 16219.9 16421.2 5047.3 5297.4 5327.7 5344.3 5353.3 5044.4 5206.5 5215.8 5247.4 5253.2 5194.8 5214.9 5231.6 5244.8 5991.5 5932.9 5983.6 6004.9 6011.9 6019.2 5241.6 5253.9 5316.8 5352.4 5354.0 12333.1 12596.7 12633.2 14706.4 20699.3 2129.7 2161.7 2169.1 2177.4 2280.8 9430.5 9668.4 9790.5 9922.5 13353.9 1749.2 1784.8 1786.1 1816.7 1853.4 59035.7 59366.7 59838.0 62525.7 63252.7 9651.6 10019.0 10034.2 10051.2 10156.0 12739.2 12893.8 12896.9 12929.0 12934.0 7334.4 7350.1 7356.6 7383.6 7470.5 6962.4 7034.3 7037.8 7073.8 7084.9 4225.5 4231.7 4324.3 4357.7 4374.9 1806.3 1806.6 1835.1 1837.6 1845.4 861.0 866.6 883.7 1002.6 1019.0 16844.0 17078.7 17259.1 17457.5 17748.5 905.9 922.1 974.8 991.3 1004.4 8900.1 9167.7 9598.2 10150.8 10209.6 538200.0 540722.0 541039.0 551645.0 590900.0 78849.2 81368.2 82316.0 83016.0 83091.6 1157.1 1159.8 1173.1 1176.3 1180.7 15699.4 15797.1 15974.8 16069.9 16212.9 35204.8 35874.3 36186.6 36213.6 36993.4 47063.8 48953.8 49140.5 49333.5 53529.2 9449.8 9461.6 9617.4 9891.2 9961.5 13639.9 13917.0 16621.8 16873.9 17857.9 13467.4 14016.5 14809.7 15153.5 15245.8 14007.3 14087.9 14249.9 14811.6 15061.9 14295.3 14607.0 14643.8 14918.6 15111.6 9312.3 9467.3 9503.2 9684.9 9695.9 14108.2 14118.4 14404.7 14584.3 14697.4 22:06:57 INFO - PROCESS | 7125 | 22:06:57 INFO - PROCESS | 7125 | [#3] mootools.html Cycles:180 Average:4990.86 Median:6130.49 stddev:2493.53 (40.7%) stddev-sans-first:2483.86 22:06:57 INFO - PROCESS | 7125 | Values: 1156.9 1187.5 1269.9 1670.6 1672.6 6985.5 7044.6 7070.2 7115.2 7177.6 7133.7 7183.9 7249.9 7256.3 7308.4 2176.4 2212.6 2213.1 2213.8 2220.0 2176.0 2203.4 2205.9 2214.3 2226.0 2187.0 2216.3 2231.9 2236.5 2240.5 2192.1 2214.2 2226.4 2241.2 2242.6 2217.6 2260.3 2261.8 2263.2 2264.4 6853.9 6885.0 6904.3 6940.2 6945.3 4361.1 4428.6 4438.4 4444.7 4447.1 2925.4 2988.0 2997.2 3009.0 3009.1 948.2 953.8 979.1 1040.6 1080.1 9497.6 9528.1 9534.5 9539.6 9558.4 3841.0 3858.9 3917.3 3933.4 3976.2 7992.1 8019.7 8022.1 8028.4 8048.7 4341.7 4345.3 4346.5 4362.8 4366.9 3987.4 3997.5 4017.4 4022.8 4030.0 3278.2 3290.6 3295.4 3305.5 3306.0 981.4 994.8 999.8 1011.6 1012.5 1006.5 1025.1 1025.9 1122.2 1279.1 6623.0 6688.2 6702.1 6773.3 6794.1 1113.4 1120.4 1121.7 1149.8 1150.1 5268.6 5280.5 5303.3 5314.7 5322.4 8083.1 8293.9 8336.0 8342.4 8391.5 8177.5 8229.8 8245.3 8259.0 8298.8 6601.8 6647.3 6692.5 6748.0 6768.9 6774.9 6794.2 6827.0 6840.9 6850.7 7391.6 7489.3 7507.2 7528.7 7538.4 7572.8 7625.3 7634.3 7714.8 7754.6 6032.9 6093.8 6181.7 6186.9 6197.6 6689.9 6704.4 6744.8 6747.8 6759.6 6602.2 6700.7 6712.8 6766.3 6801.7 6167.2 6208.2 6262.4 6331.7 6372.9 6351.6 6397.9 6407.3 6413.2 6413.9 5632.8 5894.9 5966.8 5977.2 5977.9 5829.2 5838.7 5874.6 5877.7 5880.9 22:06:57 INFO - PROCESS | 7125 | 22:06:57 INFO - PROCESS | 7125 | [#4] prototype.html Cycles:180 Average:5549.23 Median:6264.98 stddev:1687.48 (26.9%) stddev-sans-first:1646.06 22:06:57 INFO - PROCESS | 7125 | Values: 326.8 333.3 337.5 339.9 342.5 6275.6 6275.8 6307.6 6326.7 6441.9 6228.4 6262.1 6269.9 6288.5 6291.6 4744.4 4765.1 4770.9 4777.2 4789.8 4773.0 4776.3 4776.8 4782.8 4793.5 4569.0 4720.8 4733.5 4733.9 4736.6 4721.1 4726.0 4733.2 4737.5 4747.1 4092.2 4094.1 4100.6 4103.2 4135.1 5943.2 5953.1 5971.9 5976.9 5996.1 5455.4 5465.9 5487.5 5508.3 5509.5 6604.7 6605.3 6620.2 6621.5 6639.1 4555.4 4557.0 4559.3 4563.2 4577.8 6832.7 6869.0 6902.3 6987.2 6992.9 4653.0 4670.4 4672.4 4674.0 4676.2 4734.0 4734.1 4735.9 4740.7 4743.1 5481.2 5490.8 5492.9 5496.5 5518.6 6561.3 6654.2 6713.6 6733.1 6739.2 1628.9 1656.6 1681.1 1681.6 1682.5 1074.9 1111.2 1120.3 1120.4 1126.4 6208.3 6215.7 6233.9 6262.8 6263.0 6778.1 6782.6 6788.6 6794.2 6817.1 6107.3 6257.3 6260.8 6263.4 6266.6 3696.8 3701.3 3701.4 3701.6 3731.1 6995.7 7095.5 7120.0 7129.6 7130.8 6782.3 6930.5 6949.4 6959.4 6967.2 7042.0 7061.9 7062.2 7070.3 7098.1 6771.1 6804.2 6805.7 6811.9 6820.5 6613.9 6698.5 6734.2 6742.8 6747.6 7083.1 7086.4 7089.2 7095.6 7099.4 4664.3 4668.0 4670.9 4680.7 4683.2 6793.9 6819.9 6849.6 6860.6 7063.3 6764.6 6771.1 6803.8 6805.3 6822.1 6761.2 6771.6 6790.0 6790.2 6803.3 6526.9 6624.4 6642.8 6672.8 6675.0 6744.6 6795.4 6828.8 6829.4 6849.1 6583.6 6593.9 6647.8 6661.3 6680.9 22:06:57 INFO - PROCESS | 7125 | 22:06:57 INFO - PROCESS | 7125 | [#5] yui.html Cycles:180 Average:13364.69 Median:25798.81 stddev:16173.50 (62.7%) stddev-sans-first:16190.53 22:06:57 INFO - PROCESS | 7125 | Values: 614.2 711.8 733.1 839.4 843.5 11981.5 12002.2 12020.8 12162.1 12194.4 11330.4 11426.4 11446.5 11451.0 11452.3 800.9 810.7 818.5 818.9 821.6 810.8 822.1 823.8 824.6 824.6 849.3 850.5 853.7 860.8 861.5 842.0 846.9 848.3 849.7 850.7 615.2 621.1 621.8 623.9 627.1 11778.6 11866.2 11919.2 11925.4 11950.5 10007.0 11042.7 11257.6 11300.9 11481.5 9741.0 9896.4 10098.1 10119.4 10316.1 3361.1 3391.7 3393.7 3400.7 3431.5 47178.5 47584.3 47680.3 47758.3 47826.5 8157.6 8204.6 8289.4 8604.5 8622.6 14447.8 14508.0 14528.3 14562.2 14609.9 6965.4 7124.9 7133.5 7216.6 7267.5 4024.5 4117.6 4126.4 4151.7 4219.6 2922.4 2941.8 2947.3 2949.9 2953.5 539.8 544.5 553.3 553.8 555.1 501.8 511.4 582.9 635.8 700.8 7349.6 8123.4 8208.0 8238.2 8424.0 529.5 603.0 604.3 627.3 651.4 3843.3 3868.2 4060.6 4146.1 4188.3 58607.1 59201.4 59408.0 59436.4 59519.0 51086.2 52029.0 52234.7 52341.0 52341.5 45908.8 46218.5 46222.0 46483.5 46850.3 8144.6 8391.1 8476.9 8568.9 8703.9 33924.3 33986.3 34123.3 34398.1 34419.3 42449.4 46147.8 46225.9 46565.3 46612.3 10499.9 10672.0 10750.1 10764.2 10824.6 11574.9 11669.5 11781.2 12022.2 12114.6 10281.4 10482.7 10503.8 10550.0 11326.4 10292.8 10478.3 10561.7 10564.4 10773.2 9349.5 9703.9 9816.0 9841.6 10774.8 9107.5 9492.8 9507.3 9524.7 9610.8 8556.7 9138.4 9338.9 9347.1 9564.1 22:06:57 INFO - PROCESS | 7125 | -------- Summary: end -------- 22:06:57 INFO - PROCESS | 7125 | 22:06:58 INFO - TEST-INFO | 7125: exit 0 22:06:58 INFO - TEST-OK | dromaeo_css | took 1110834ms 22:06:58 INFO - TEST-START | kraken 22:06:58 INFO - operating with platform_type : linux_ 22:06:58 INFO - Initialising browser for kraken test... 22:06:58 INFO - TEST-INFO | started process 7369 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZlPmG3/profile http://localhost:35720/getInfo.html) 22:06:59 INFO - PROCESS | 7369 | Failed to load Oculus VR library! 22:07:01 INFO - PROCESS | 7369 | Failed to load Oculus VR library! 22:07:02 INFO - PROCESS | 7369 | __metrics Screen width/height:1600/1200 22:07:02 INFO - PROCESS | 7369 | colorDepth:24 22:07:02 INFO - PROCESS | 7369 | Browser inner width/height: 1024/697 22:07:02 INFO - PROCESS | 7369 | __metrics 22:07:02 INFO - PROCESS | 7369 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:07:03 INFO - TEST-INFO | 7369: exit 0 22:07:03 INFO - Browser initialized. 22:07:03 INFO - Running cycle 1/1 for kraken test... 22:07:03 INFO - TEST-INFO | started process 7491 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZlPmG3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:07:03 INFO - PROCESS | 7491 | Failed to load Oculus VR library! 22:07:05 INFO - PROCESS | 7491 | Failed to load Oculus VR library! 22:07:15 INFO - PROCESS | 7491 | RSS: Main: 149573632 22:07:15 INFO - PROCESS | 7491 | 22:07:17 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35720/tests/kraken/driver.html?testName=audio-beat-detection) 22:07:18 INFO - PROCESS | 7491 | RSS: Main: 150749184 22:07:18 INFO - PROCESS | 7491 | 22:07:20 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35720/tests/kraken/driver.html?testName=audio-dft) 22:07:21 INFO - PROCESS | 7491 | RSS: Main: 151379968 22:07:21 INFO - PROCESS | 7491 | 22:07:24 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35720/tests/kraken/driver.html?testName=audio-fft) 22:07:25 INFO - PROCESS | 7491 | RSS: Main: 145944576 22:07:25 INFO - PROCESS | 7491 | 22:07:27 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35720/tests/kraken/driver.html?testName=audio-oscillator) 22:07:27 INFO - PROCESS | 7491 | RSS: Main: 145690624 22:07:27 INFO - PROCESS | 7491 | 22:07:29 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35720/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:07:30 INFO - PROCESS | 7491 | RSS: Main: 146538496 22:07:30 INFO - PROCESS | 7491 | 22:07:33 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35720/tests/kraken/driver.html?testName=imaging-darkroom) 22:07:33 INFO - PROCESS | 7491 | RSS: Main: 146591744 22:07:33 INFO - PROCESS | 7491 | 22:07:37 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35720/tests/kraken/driver.html?testName=imaging-desaturate) 22:07:37 INFO - PROCESS | 7491 | RSS: Main: 148094976 22:07:37 INFO - PROCESS | 7491 | 22:07:40 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35720/tests/kraken/driver.html?testName=json-parse-financial) 22:07:41 INFO - PROCESS | 7491 | RSS: Main: 148197376 22:07:41 INFO - PROCESS | 7491 | 22:07:42 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35720/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:07:43 INFO - PROCESS | 7491 | RSS: Main: 147521536 22:07:43 INFO - PROCESS | 7491 | 22:07:45 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35720/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:07:45 INFO - PROCESS | 7491 | RSS: Main: 148385792 22:07:45 INFO - PROCESS | 7491 | 22:07:48 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35720/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:07:48 INFO - PROCESS | 7491 | RSS: Main: 148930560 22:07:48 INFO - PROCESS | 7491 | 22:07:51 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:07:51 INFO - PROCESS | 7491 | RSS: Main: 148598784 22:07:51 INFO - PROCESS | 7491 | 22:07:54 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:07:54 INFO - PROCESS | 7491 | RSS: Main: 148119552 22:07:54 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:35720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35720/tests/kraken/driver.html?testName=ai-astar) 22:07:56 INFO - PROCESS | 7491 | RSS: Main: 148262912 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | __start_tp_report 22:07:56 INFO - PROCESS | 7491 | _x_x_mozilla_page_load 22:07:56 INFO - PROCESS | 7491 | _x_x_mozilla_page_load_details 22:07:56 INFO - PROCESS | 7491 | |i|pagename|runs| 22:07:56 INFO - PROCESS | 7491 | |0;ai-astar;114;107;111;111;112;121;112;113;110;112 22:07:56 INFO - PROCESS | 7491 | |1;audio-beat-detection;147;124;147;168;125;145;149;130;158;127 22:07:56 INFO - PROCESS | 7491 | |2;audio-dft;161;163;163;161;162;161;161;163;181;166 22:07:56 INFO - PROCESS | 7491 | |3;audio-fft;73;72;73;71;74;135;74;73;75;74 22:07:56 INFO - PROCESS | 7491 | |4;audio-oscillator;96;97;150;96;99;98;137;96;96;139 22:07:56 INFO - PROCESS | 7491 | |5;imaging-gaussian-blur;110;110;110;110;110;110;110;111;109;111 22:07:56 INFO - PROCESS | 7491 | |6;imaging-darkroom;147;146;146;147;147;146;147;147;147;147 22:07:56 INFO - PROCESS | 7491 | |7;imaging-desaturate;101;96;96;96;97;98;96;95;96;97 22:07:56 INFO - PROCESS | 7491 | |8;json-parse-financial;59;59;59;61;58;60;58;61;56;59 22:07:56 INFO - PROCESS | 7491 | |9;json-stringify-tinderbox;68;67;68;68;69;68;68;69;68;69 22:07:56 INFO - PROCESS | 7491 | |10;stanford-crypto-aes;89;96;89;88;87;88;88;87;88;89 22:07:56 INFO - PROCESS | 7491 | |11;stanford-crypto-ccm;116;118;125;130;117;137;121;123;129;132 22:07:56 INFO - PROCESS | 7491 | |12;stanford-crypto-pbkdf2;144;156;159;155;154;153;157;159;155;142 22:07:56 INFO - PROCESS | 7491 | |13;stanford-crypto-sha256-iterative;69;67;67;72;68;77;68;70;71;71 22:07:56 INFO - PROCESS | 7491 | __end_tp_report 22:07:56 INFO - PROCESS | 7491 | __start_cc_report 22:07:56 INFO - PROCESS | 7491 | _x_x_mozilla_cycle_collect,737 22:07:56 INFO - PROCESS | 7491 | __end_cc_report 22:07:56 INFO - PROCESS | 7491 | __startTimestamp1451455676859__endTimestamp 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | ------- Summary: start ------- 22:07:56 INFO - PROCESS | 7491 | Number of tests: 14 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:3.59 (3.2%) stddev-sans-first:3.76 22:07:56 INFO - PROCESS | 7491 | Values: 114.0 107.0 111.0 111.0 112.0 121.0 112.0 113.0 110.0 112.0 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:147.00 stddev:14.99 (10.2%) stddev-sans-first:15.79 22:07:56 INFO - PROCESS | 7491 | Values: 147.0 124.0 147.0 168.0 125.0 145.0 149.0 130.0 158.0 127.0 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.00 stddev:6.11 (3.7%) stddev-sans-first:6.37 22:07:56 INFO - PROCESS | 7491 | Values: 161.0 163.0 163.0 161.0 162.0 161.0 161.0 163.0 181.0 166.0 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#3] audio-fft Cycles:10 Average:79.40 Median:73.50 stddev:19.57 (26.6%) stddev-sans-first:20.62 22:07:56 INFO - PROCESS | 7491 | Values: 73.0 72.0 73.0 71.0 74.0 135.0 74.0 73.0 75.0 74.0 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:96.00 stddev:22.08 (23.0%) stddev-sans-first:22.79 22:07:56 INFO - PROCESS | 7491 | Values: 96.0 97.0 150.0 96.0 99.0 98.0 137.0 96.0 96.0 139.0 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 22:07:56 INFO - PROCESS | 7491 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 109.0 111.0 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 22:07:56 INFO - PROCESS | 7491 | Values: 147.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.69 (1.8%) stddev-sans-first:0.87 22:07:56 INFO - PROCESS | 7491 | Values: 101.0 96.0 96.0 96.0 97.0 98.0 96.0 95.0 96.0 97.0 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:1.49 (2.5%) stddev-sans-first:1.58 22:07:56 INFO - PROCESS | 7491 | Values: 59.0 59.0 59.0 61.0 58.0 60.0 58.0 61.0 56.0 59.0 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 22:07:56 INFO - PROCESS | 7491 | Values: 68.0 67.0 68.0 68.0 69.0 68.0 68.0 69.0 68.0 69.0 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:88.50 stddev:2.60 (2.9%) stddev-sans-first:2.76 22:07:56 INFO - PROCESS | 7491 | Values: 89.0 96.0 89.0 88.0 87.0 88.0 88.0 87.0 88.0 89.0 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:127.00 stddev:7.05 (5.6%) stddev-sans-first:6.72 22:07:56 INFO - PROCESS | 7491 | Values: 116.0 118.0 125.0 130.0 117.0 137.0 121.0 123.0 129.0 132.0 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:155.50 stddev:5.83 (3.8%) stddev-sans-first:5.10 22:07:56 INFO - PROCESS | 7491 | Values: 144.0 156.0 159.0 155.0 154.0 153.0 157.0 159.0 155.0 142.0 22:07:56 INFO - PROCESS | 7491 | 22:07:56 INFO - PROCESS | 7491 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:3.02 (4.3%) stddev-sans-first:3.18 22:07:56 INFO - PROCESS | 7491 | Values: 69.0 67.0 67.0 72.0 68.0 77.0 68.0 70.0 71.0 71.0 22:07:56 INFO - PROCESS | 7491 | -------- Summary: end -------- 22:07:56 INFO - PROCESS | 7491 | 22:07:57 INFO - TEST-INFO | 7491: exit 0 22:07:57 INFO - TEST-OK | kraken | took 59611ms 22:07:57 INFO - TEST-START | v8_7 22:07:57 INFO - operating with platform_type : linux_ 22:07:57 INFO - Initialising browser for v8_7 test... 22:07:57 INFO - TEST-INFO | started process 7779 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk1sagV/profile http://localhost:35720/getInfo.html) 22:07:58 INFO - PROCESS | 7779 | Failed to load Oculus VR library! 22:08:01 INFO - PROCESS | 7779 | Failed to load Oculus VR library! 22:08:02 INFO - PROCESS | 7779 | __metrics Screen width/height:1600/1200 22:08:02 INFO - PROCESS | 7779 | colorDepth:24 22:08:02 INFO - PROCESS | 7779 | Browser inner width/height: 1024/697 22:08:02 INFO - PROCESS | 7779 | __metrics 22:08:02 INFO - PROCESS | 7779 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:08:03 INFO - TEST-INFO | 7779: exit 0 22:08:03 INFO - Browser initialized. 22:08:03 INFO - Running cycle 1/1 for v8_7 test... 22:08:03 INFO - TEST-INFO | started process 7900 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk1sagV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:03 INFO - PROCESS | 7900 | Failed to load Oculus VR library! 22:08:04 INFO - PROCESS | 7900 | Failed to load Oculus VR library! 22:08:15 INFO - PROCESS | 7900 | RSS: Main: 149454848 22:08:15 INFO - PROCESS | 7900 | 22:08:36 INFO - PROCESS | 7900 | Cycle 1(1): loaded http://localhost:35720/tests/v8_7/run.html (next: http://localhost:35720/tests/v8_7/run.html) 22:08:36 INFO - PROCESS | 7900 | RSS: Main: 146481152 22:08:36 INFO - PROCESS | 7900 | 22:08:36 INFO - PROCESS | 7900 | __start_tp_report 22:08:36 INFO - PROCESS | 7900 | _x_x_mozilla_page_load 22:08:36 INFO - PROCESS | 7900 | _x_x_mozilla_page_load_details 22:08:36 INFO - PROCESS | 7900 | |i|pagename|runs| 22:08:36 INFO - PROCESS | 7900 | |0;Richards;169.1188905800778 22:08:36 INFO - PROCESS | 7900 | |1;DeltaBlue;188.5014137606032 22:08:36 INFO - PROCESS | 7900 | |2;Encrypt;279.87685418415896 22:08:36 INFO - PROCESS | 7900 | |3;Decrypt;5246.073298429319 22:08:36 INFO - PROCESS | 7900 | |4;RayTrace;1071.8113612004288 22:08:36 INFO - PROCESS | 7900 | |5;Earley;726.7441860465116 22:08:36 INFO - PROCESS | 7900 | |6;Boyer;12231.707317073171 22:08:36 INFO - PROCESS | 7900 | |7;RegExp;25200 22:08:36 INFO - PROCESS | 7900 | |8;Splay;570.4506560182544 22:08:36 INFO - PROCESS | 7900 | |9;NavierStokes;4840.579710144928 22:08:36 INFO - PROCESS | 7900 | __end_tp_report 22:08:36 INFO - PROCESS | 7900 | __startTimestamp1451455716689__endTimestamp 22:08:36 INFO - PROCESS | 7900 | 22:08:36 INFO - PROCESS | 7900 | ------- Summary: start ------- 22:08:36 INFO - PROCESS | 7900 | Number of tests: 10 22:08:36 INFO - PROCESS | 7900 | 22:08:36 INFO - PROCESS | 7900 | [#0] Richards Cycles:1 Average:169.12 Median:169.12 stddev:0.00 (0.0%) 22:08:36 INFO - PROCESS | 7900 | Values: 169.1 22:08:36 INFO - PROCESS | 7900 | 22:08:36 INFO - PROCESS | 7900 | [#1] DeltaBlue Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 22:08:36 INFO - PROCESS | 7900 | Values: 188.5 22:08:36 INFO - PROCESS | 7900 | 22:08:36 INFO - PROCESS | 7900 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 22:08:36 INFO - PROCESS | 7900 | Values: 279.9 22:08:36 INFO - PROCESS | 7900 | 22:08:36 INFO - PROCESS | 7900 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 22:08:36 INFO - PROCESS | 7900 | Values: 5246.1 22:08:36 INFO - PROCESS | 7900 | 22:08:36 INFO - PROCESS | 7900 | [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 22:08:36 INFO - PROCESS | 7900 | Values: 1071.8 22:08:36 INFO - PROCESS | 7900 | 22:08:36 INFO - PROCESS | 7900 | [#5] Earley Cycles:1 Average:726.74 Median:726.74 stddev:0.00 (0.0%) 22:08:36 INFO - PROCESS | 7900 | Values: 726.7 22:08:36 INFO - PROCESS | 7900 | 22:08:36 INFO - PROCESS | 7900 | [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 22:08:36 INFO - PROCESS | 7900 | Values: 12231.7 22:08:36 INFO - PROCESS | 7900 | 22:08:36 INFO - PROCESS | 7900 | [#7] RegExp Cycles:1 Average:25200.00 Median:25200.00 stddev:0.00 (0.0%) 22:08:36 INFO - PROCESS | 7900 | Values: 25200.0 22:08:36 INFO - PROCESS | 7900 | 22:08:36 INFO - PROCESS | 7900 | [#8] Splay Cycles:1 Average:570.45 Median:570.45 stddev:0.00 (0.0%) 22:08:36 INFO - PROCESS | 7900 | Values: 570.5 22:08:36 INFO - PROCESS | 7900 | 22:08:36 INFO - PROCESS | 7900 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 22:08:36 INFO - PROCESS | 7900 | Values: 4840.6 22:08:36 INFO - PROCESS | 7900 | -------- Summary: end -------- 22:08:36 INFO - PROCESS | 7900 | 22:08:37 INFO - TEST-INFO | 7900: exit 0 22:08:37 INFO - TEST-OK | v8_7 | took 39770ms 22:08:37 INFO - SUITE-END | took 1210s 22:08:37 INFO - Completed test suite (00:20:10) 22:08:37 INFO - Working with test: dromaeo_css 22:08:37 INFO - Generating results file: dromaeo_css 22:08:37 INFO - Working with test: kraken 22:08:37 INFO - Generating results file: kraken 22:08:37 INFO - javascript benchmark 22:08:37 INFO - Working with test: v8_7 22:08:37 INFO - Generating results file: v8_7 22:08:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:08:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 22:08:37 INFO - process_Request line: dromaeo_css 6893.66 graph.html#tests=[[72,63,43]] 22:08:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:08:37 INFO - process_Request line: kraken 1526.20 graph.html#tests=[[232,63,43]] 22:08:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:08:38 INFO - process_Request line: v8_7 21393.31 graph.html#tests=[[230,63,43]] 22:08:38 INFO - RETURN: dromaeo_css: 6893.66 22:08:38 INFO - RETURN: kraken: 1526.20 22:08:38 INFO - RETURN: v8_7: 21393.31 22:08:38 INFO - javascript benchmark 22:08:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3218.1632775478374, 3284.9343013139724, 3287.9506807397893, 3324.999999999999, 3328.0, 5215.869603259911, 5408.594355423339, 5430.728463576826, 5440.918386224205, 5453.154761012044, 5274.841754747355, 5329.094054010818, 5346.1713434417725, 5361.839144825662, 5390.838274851751, 4571.1771881061395, 4848.975755121228, 5090.898182036357, 5099.08216521026, 5116.309298244745, 4863.465018847924, 4977.900441991158, 5028.7485625718755, 5088.669236499616, 5090.567301779353, 4857.902841943177, 4868.56182943535, 4939.259111133359, 4945.8268960586565, 4975.577075948549, 4940.6788558743565, 4957.727324997124, 4975.7263350515705, 4991.575716064139, 4997.6001919846685, 4877.365942427462, 4941.234108713155, 4953.727544985024, 4965.453800082024, 5036.445990940993, 5222.477752224785, 5246.947530524684, 5291.28567643367, 5328.6802791832615, 5375.354957405098, 5721.542276617861, 5825.475707186331, 5830.708464576796, 5830.82507524775, 5832.504237139849, 5750.108733146369, 5770.278715160605, 5842.269716285465, 5863.296404431496, 5877.177195192677, 5407.215953686733, 5410.91883621746, 5416.674999500043, 5417.106177480711, 5424.294841670558, 5933.703314834241, 5935.584509084322, 5939.673317967553, 5941.970290148522, 5947.762089516371, 5595.608307418442, 5601.60788744784, 5746.051901436216, 5762.078067509262, 5776.0, 5828.300603927556, 5830.7084645767545, 5843.590948633555, 5860.765569377262, 5872.970635146797, 5745.569082318842, 5749.9425005750245, 5773.422657734277, 5790.855228619318, 5791.594588378857, 5626.887462250814, 5672.886542269214, 5750.137479378043, 5778.768849245983, 5791.0, 4389.275769498061, 4415.205263052681, 4430.224710675619, 4431.0, 4433.357163211316, 3943.960560394417, 3947.585503522089, 3962.841486340572, 4001.09975255571, 4011.7793521356607, 5309.522143007148, 5387.138057910794, 5404.405515393303, 5411.161270003156, 5418.91871621926, 5689.743961521742, 5705.686187259741, 5706.572007099484, 5731.799387021434, 5743.971280143573, 5370.516653501204, 5371.248025276464, 5383.515483606494, 5418.458154184629, 5533.612647114744, 5018.648694591344, 5022.246663000579, 5022.397312322471, 5028.17035189197, 5070.518300761421, 5972.462478376967, 5987.580869339192, 5991.430814072656, 6002.309734380515, 6013.368596297413, 5640.71796410186, 5740.1102829061565, 5790.986577349031, 5794.681292528951, 5795.536357091339, 5890.52875769946, 5895.616784908967, 5906.173135761082, 5915.201447804491, 5917.881642367042, 5646.971765141148, 5649.039663257174, 5668.914966275427, 5697.116946873241, 5824.068149096124, 5855.092460668603, 5861.6189947653265, 5869.735861886311, 5873.2658417697785, 5891.351951285441, 5702.714864256854, 5702.857428564319, 5710.0, 5710.571707122065, 5712.37163911961, 5552.583556233218, 5662.915056274077, 5674.460926212003, 5756.539476841926, 5807.070868660994, 5553.777848885999, 5571.470710282517, 5588.748506317144, 5597.244372009726, 5615.0, 5567.47109024642, 5675.914861277167, 5723.484886360247, 5733.885322293448, 5751.137329400456, 5525.668459892419, 5544.889102218014, 5607.80372686954, 5631.63394379364, 5681.801136960186], "unit": "score", "name": "dojo.html", "value": 5343.553825298329}, {"lowerIsBetter": false, "replicates": [527.4119356917037, 539.9244105825184, 554.271133459501, 561.5058748301495, 566.8922904648117, 35576.2884742305, 36483.0, 36549.45175822365, 36644.26711465773, 36773.632263677355, 39143.41284880729, 39615.20769584607, 39618.8019059905, 39727.205455890864, 39747.40378894312, 8570.442921210133, 8711.60797764099, 8762.86855697165, 8768.035516093225, 8802.427842190269, 8303.169683031709, 8416.242538171564, 8557.272631826303, 8582.184692454206, 8585.270252028586, 8675.913240867574, 8862.86705699415, 8870.512121833297, 8871.733847984571, 8884.733457996239, 8629.093945135764, 8720.8691869622, 8755.0, 8765.824683506295, 8788.8681669775, 8580.871286930702, 8654.264387527004, 8751.299896008304, 8777.122287771235, 8789.296856251485, 39723.0, 40019.0, 40295.39556906649, 40321.59678403208, 40366.59633403687, 3173.825439600821, 3247.8213698246586, 3314.5691060162267, 3351.949720754191, 3477.4436090225695, 28898.855505722546, 29503.0, 29795.25511862199, 29851.552226716616, 30489.695103048907, 3787.6780473659774, 3849.8087036125175, 3897.4738410314526, 3982.9402558961638, 4018.3771515415156, 254624.0, 254993.0, 255777.0, 257626.99999999814, 257881.0, 42135.0, 42534.149317013485, 58785.0, 59341.70329148413, 59354.0, 42829.0, 42928.78535607365, 43271.783641081594, 43344.3498347525, 43550.56449435528, 15120.621984450478, 15198.240087995557, 15243.23783810805, 15253.38986440552, 15264.542063738105, 10682.946585267024, 10784.78430431387, 10791.40647264408, 10848.240623156304, 10850.186236032328, 14278.643033924234, 14447.422103115758, 14485.493007744679, 14548.490802822062, 14552.417903283962, 5753.712314384264, 5762.279715035621, 5796.855078623068, 5874.471297583238, 5896.970515147397, 923.9769005774909, 955.6368579939717, 1002.548853016131, 1012.1700205831295, 1012.427978192319, 29132.126036218946, 31220.219494512818, 31309.530357044663, 32256.516152257736, 32530.512042319384, 1079.6922876980022, 1091.6615849086809, 1119.2333251722596, 1162.4129814443652, 1180.9055275577932, 14735.55793326202, 14778.408863645334, 14823.851761482247, 14923.626909327137, 15074.924625376803, 396401.0, 401471.0, 404795.0, 405935.0, 407947.0, 52519.73740131275, 52541.2118818218, 52646.21030684543, 52759.736201318745, 52958.14646487431, 1358.8844948179515, 1365.2491129878526, 1374.0793668242302, 1376.8072469854228, 1382.2604906375243, 28069.298267543476, 28818.27954301159, 29182.0, 29517.0, 29715.55426668645, 45861.31208031949, 46328.0, 46448.53551464442, 46539.76730116328, 46579.0, 313190.0, 314640.0, 316549.0, 317295.0, 319448.0, 32583.837080814443, 43067.353989690804, 43294.567054329054, 44009.77995110004, 44074.11851762883, 41659.7917010413, 43432.34851477167, 43749.0, 43794.56205437905, 44120.33819492775, 36487.249294403104, 36951.445728313556, 37080.25839483249, 37406.0, 37958.43062354122, 36986.26027479489, 39039.41440878446, 42239.57760422357, 42295.57704422916, 43181.56818431775, 35373.46939795957, 36404.27191456209, 36521.452178216816, 36551.45172822463, 36579.634203657624, 30617.387652247275, 33164.50253246155, 33580.83209584034, 33773.49339759856, 33938.0, 25791.871040644677, 26034.218973430827, 26349.341266467723, 26840.0, 27710.307242318297], "unit": "score", "name": "ext.html", "value": 18281.108707172454}, {"lowerIsBetter": false, "replicates": [344.42652982783665, 346.5065567404487, 349.14285429271143, 350.0670712551051, 350.4777880957374, 14265.928670356634, 14590.197539135343, 16367.263473143707, 16715.414960476384, 17586.1206939653, 15240.69518609627, 15523.301451434685, 16126.113063781488, 16219.918900405512, 16421.17894105293, 5047.293378926953, 5297.417284098746, 5327.653702509344, 5344.331958505187, 5353.250544923714, 5044.39467263927, 5206.479352064782, 5215.765290561915, 5247.370315562138, 5253.185756207775, 5194.766235519392, 5214.947850521503, 5231.633785635007, 5244.79020839166, 5991.520678345743, 5932.88134237315, 5983.640981541122, 6004.879902401949, 6011.879762404771, 6019.157317975465, 5241.554467870235, 5253.947460525423, 5316.840494785162, 5352.357717073937, 5353.9732301338245, 12333.075019373493, 12596.748065038648, 12633.2420054797, 14706.411743530245, 20699.27552535669, 2129.7337832770904, 2161.7189765330563, 2169.0889826272846, 2177.412098733349, 2280.7947284744287, 9430.481323527203, 9668.419894806264, 9790.461524616143, 9922.454265015422, 13353.86646133536, 1749.2041121289783, 1784.8304411080926, 1786.1069465267367, 1816.6820806358967, 1853.4161739052156, 59035.704821475614, 59366.703166483894, 59838.0, 62525.74948501005, 63252.68373658102, 9651.565679544437, 10018.998100190069, 10034.197264218845, 10051.195904327637, 10156.0, 12739.171953822972, 12893.806592901114, 12896.871031289567, 12929.030322725834, 12934.0, 7334.413246940232, 7350.117985841626, 7356.595387253752, 7383.593902335423, 7470.477066605394, 6962.408195303456, 7034.331738484836, 7037.753678621224, 7073.823154421078, 7084.893726594105, 4225.514065882401, 4231.746095234295, 4324.308110702335, 4357.716748411406, 4374.934375984363, 1806.2955447375534, 1806.6206096719573, 1835.0824587706147, 1837.6324735053042, 1845.4002449204063, 860.9870851937226, 866.5580553917422, 883.6553744039829, 1002.6089824968268, 1019.0359501539019, 16844.0, 17078.658426831393, 17259.13704314779, 17457.47627571175, 17748.467545973643, 905.9003509613938, 922.0594993106994, 974.8147851908114, 991.2813210422386, 1004.352192835617, 8900.109989001048, 9167.724968250963, 9598.232141428669, 10150.847737283946, 10209.591616335412, 538200.0, 540722.0, 541039.0, 551645.0, 590900.0, 78849.21150788419, 81368.18631813607, 82316.0, 83016.0, 83091.58454207811, 1157.0512180012477, 1159.8202278646822, 1173.102576528973, 1176.311857563335, 1180.7107258721496, 15699.372025118868, 15797.131157786433, 15974.760378594097, 16069.919650401673, 16212.918935405247, 35204.823975879954, 35874.28251435009, 36186.63813361938, 36213.63786362103, 36993.44509832408, 47063.764681177745, 48953.818001829764, 49140.50859491359, 49333.506664932895, 53529.19706204488, 9449.763755906157, 9461.574229159567, 9617.374870633386, 9891.159251463418, 9961.50192490387, 13639.931800340935, 13917.0, 16621.750673740145, 16873.91563042177, 17857.910710446366, 13467.3939672713, 14016.509422170582, 14809.703805924037, 15153.54539363821, 15245.847541524443, 14007.299635018413, 14087.929560352133, 14249.928750356183, 14811.629709257355, 15061.924690376478, 14295.28523573838, 14607.0, 14643.780343295071, 14918.552443426715, 15111.622209444851, 9312.255019598551, 9467.289953253396, 9503.19222866064, 9684.85472717924, 9695.9030409695, 14108.153510788974, 14118.43526258938, 14404.711905762035, 14584.343704533534, 14697.41210351574], "unit": "score", "name": "jquery.html", "value": 8830.942313061185}, {"lowerIsBetter": false, "replicates": [1156.9016633586145, 1187.5012494752202, 1269.9365031748414, 1670.6408122253713, 1672.5985763416777, 6985.5459395139405, 7044.577325360482, 7070.186928503217, 7115.18175409828, 7177.60523171226, 7133.714651413938, 7183.928160718391, 7249.876269178272, 7256.310650488195, 7308.415326773858, 2176.4341271269427, 2212.590670725913, 2213.1368766181204, 2213.8339624528144, 2220.034285085993, 2175.9782402176015, 2203.4381232785618, 2205.9227927022557, 2214.3135627955385, 2225.9554808903813, 2186.967195492061, 2216.312942987671, 2231.866088034723, 2236.541508990661, 2240.4622890506243, 2192.1012384922105, 2214.202886960693, 2226.398872304485, 2241.204372447774, 2242.618754811686, 2217.6119179143584, 2260.288009277089, 2261.830362722786, 2263.219189379661, 2264.4338915271182, 6853.897191542131, 6885.036094946711, 6904.3095690431055, 6940.236573976858, 6945.340192681687, 4361.149575832714, 4428.623566996777, 4438.42300500936, 4444.688871778977, 4447.0661161156195, 2925.3856690095104, 2988.0, 2997.220722612115, 3008.9548656770166, 3009.1423944175804, 948.2366694810675, 953.7901661634429, 979.1236843025453, 1040.5785656809005, 1080.0927221134207, 9497.5726092326, 9528.142467177919, 9534.52327383635, 9539.618415263381, 9558.378705384128, 3841.0013396516547, 3858.9421158682644, 3917.275304068756, 3933.4296527004, 3976.204759048202, 7992.080910695228, 8019.719309824128, 8022.0774610919325, 8028.397870159762, 8048.678052877936, 4341.674374421931, 4345.34819777036, 4346.47842258931, 4362.847300344472, 4366.868993930188, 3987.4218238355274, 3997.4803275574573, 4017.3773065174946, 4022.7787471688753, 4029.9798501007895, 3278.1968417737808, 3290.621578518501, 3295.4068267711564, 3305.520699498559, 3306.0, 981.3719219699398, 994.796066806303, 999.7750506136207, 1011.5549158370441, 1012.5342342522375, 1006.4514839412537, 1025.0723095598496, 1025.876894772632, 1122.241695212294, 1279.0598909801288, 6623.039659249382, 6688.230853451818, 6702.095217145623, 6773.288804675537, 6794.0827988221945, 1113.4098927568239, 1120.3503713717164, 1121.725177331559, 1149.7930372533024, 1150.0914277720674, 5268.631195816332, 5280.471952804689, 5303.310569626001, 5314.681119132864, 5322.414534401213, 8083.110857805636, 8293.875591866126, 8336.041355244104, 8342.37432192588, 8391.538465384341, 8177.509349438934, 8229.835403291901, 8245.257926786619, 8258.958705206436, 8298.792530186673, 6601.801945941629, 6647.268800431949, 6692.531522793358, 6747.966260168668, 6768.864622707519, 6774.8645027100165, 6794.218664853407, 6826.965865170841, 6840.863182736417, 6850.691718872563, 7391.593462359622, 7489.251074892467, 7507.174210836913, 7528.736494222676, 7538.3592394644875, 7572.8485430292185, 7625.313721765067, 7634.312911837739, 7714.768556943301, 7754.612269386621, 6032.909506357496, 6093.75624974996, 6181.721822518088, 6186.876262474815, 6197.566170368212, 6689.866202675822, 6704.4301234395625, 6744.7976560703255, 6747.831304217434, 6759.5606285591275, 6602.240742314503, 6700.731970721116, 6712.798616041527, 6766.255711871789, 6801.727930882709, 6167.229096362955, 6208.2239720034995, 6262.436380725757, 6331.715072821642, 6372.872542549216, 6351.555391122577, 6397.904031439625, 6407.2631647359285, 6413.198350206224, 6413.871722565429, 5632.831015069554, 5894.852628684317, 5966.76132954677, 5977.193078934288, 5977.850553736192, 5829.15477255804, 5838.678872662044, 5874.559408044328, 5877.73550190251, 5880.941190588211], "unit": "score", "name": "mootools.html", "value": 4153.358973364797}, {"lowerIsBetter": false, "replicates": [326.84311530465374, 333.33666004650735, 337.4853348643317, 339.9167204035011, 342.52560204117304, 6275.5920865143735, 6275.807596556657, 6307.621542707435, 6326.715297811598, 6441.935580644192, 6228.439440450358, 6262.12330273762, 6269.9373006269925, 6288.528360372968, 6291.591046581969, 4744.406949131368, 4765.142274390609, 4770.85687429376, 4777.211760059586, 4789.832355867546, 4773.0, 4776.307435421862, 4776.80892764289, 4782.7608619569055, 4793.472718001017, 4568.954310456887, 4720.811167553294, 4733.526647335273, 4733.881652958687, 4736.621070314367, 4721.055788842245, 4726.031163611468, 4733.219018861883, 4737.45519265282, 4747.098051370229, 4092.2224777292217, 4094.0992981544014, 4100.630943215125, 4103.220388126247, 4135.069609337905, 5943.167956486095, 5953.1070339449, 5971.940280597182, 5976.910346344808, 5996.13056106862, 5455.427180146067, 5465.890682186334, 5487.506124448779, 5508.283923090013, 5509.47659972306, 6604.735810567571, 6605.339466053356, 6620.205575330943, 6621.470282377399, 6639.136912201383, 4555.430571178603, 4556.977215113936, 4559.316102584606, 4563.178627846986, 4577.8397756078375, 6832.658367081675, 6868.965655171693, 6902.309769023058, 6987.231404545496, 6992.895106573456, 4653.046125544255, 4670.439547254283, 4672.415948006499, 4674.0, 4676.158291507561, 4733.95266047342, 4734.1241870253425, 4735.905281894412, 4740.739259340769, 4743.051389722001, 5481.150421684645, 5490.80782172622, 5492.917606235909, 5496.5053145217125, 5518.613697041169, 6561.311062338481, 6654.168228971379, 6713.63075030878, 6733.091032710619, 6739.224989126314, 1628.8778341624188, 1656.5941344370706, 1681.100611173041, 1681.5880109373281, 1682.470021943084, 1074.940878251688, 1111.2499063132516, 1120.2830188679088, 1120.4061847220985, 1126.3861195648392, 6208.348123447064, 6215.720292586844, 6233.875322493615, 6262.780802671976, 6263.029230469194, 6778.084958530634, 6782.593044417351, 6788.59268443895, 6794.150731158606, 6817.113775209191, 6107.267127944675, 6257.311695713468, 6260.843478913063, 6263.404976527223, 6266.561340706198, 3696.7597106188014, 3701.2967536168044, 3701.3522633539023, 3701.61133081028, 3731.1231860512758, 6995.705794428047, 7095.467839912028, 7119.96440017807, 7129.572225666477, 7130.821729456805, 6782.253952065269, 6930.480213983971, 6949.409300209438, 6959.4432445405255, 6967.198772141167, 7042.0, 7061.881435569308, 7062.15254169503, 7070.257622949516, 7098.148222213367, 6771.052052712723, 6804.21751498584, 6805.727770889109, 6811.931880681328, 6820.522563420513, 6613.900791488035, 6698.526324208667, 6734.225564060196, 6742.797716068526, 6747.628880411428, 7083.079199704005, 7086.39765619928, 7089.220185779664, 7095.609741464269, 7099.36105750485, 4664.277037059262, 4668.0, 4670.883227919329, 4680.742559159279, 4683.203855344667, 6793.93206067933, 6819.863602728017, 6849.589024658537, 6860.5540639858245, 7063.25835787235, 6764.594124352555, 6771.119754432089, 6803.795886123424, 6805.251422343439, 6822.079019332326, 6761.188657361148, 6771.593704377753, 6790.0, 6790.185177778698, 6803.251642319242, 6526.9020964686515, 6624.436922861611, 6642.83392915181, 6672.799816005528, 6675.0, 6744.5616034957575, 6795.354441328066, 6828.760993365408, 6829.419499342612, 6849.1438570178725, 6583.572067815577, 6593.934060659332, 6647.767328143492, 6661.3338666132995, 6680.933190668031], "unit": "score", "name": "prototype.html", "value": 4993.782443532037}, {"lowerIsBetter": false, "replicates": [614.2015380005996, 711.8327193109621, 733.1056111543918, 839.4459656626626, 843.4644001059328, 11981.460834262458, 12002.159848810586, 12020.759584808298, 12162.087843411746, 12194.390280485984, 11330.376829274386, 11426.428678566059, 11446.48490817913, 11451.0, 11452.312861228333, 800.9359251259885, 810.6757297081156, 818.5293456262643, 818.9344852411823, 821.5604651511443, 810.8013536683521, 822.0710597025383, 823.8022874510104, 824.6083110522484, 824.6289169873581, 849.2865992566243, 850.4897061762955, 853.7438768369495, 860.806318578318, 861.530465896085, 842.0232530264894, 846.936479764014, 848.2789628815489, 849.6813694864426, 850.7447765670305, 615.230961298377, 621.1273161208464, 621.7885918787589, 623.8770213615473, 627.0500192208762, 11778.646640600795, 11866.169368144234, 11919.225250358699, 11925.403729813475, 11950.46222919962, 10007.0, 11042.668719938414, 11257.605983790529, 11300.94349528247, 11481.483333250024, 9741.0, 9896.406215627014, 10098.141657959082, 10119.392836429837, 10316.123129533999, 3361.0757041813695, 3391.6608339166132, 3393.728501719881, 3400.659934006604, 3431.4509678451327, 47178.52821471776, 47584.286235706495, 47680.28479572809, 47758.283625745644, 47826.52173478255, 8157.592120393957, 8204.630791614392, 8289.4197406181, 8604.48373097616, 8622.568871556397, 14447.78328325076, 14508.0, 14528.346224419927, 14562.199079050753, 14609.853901461061, 6965.373116419445, 7124.857502850017, 7133.500654954207, 7216.60308683017, 7267.4549408794555, 4024.4768180136393, 4117.608827161415, 4126.381042843537, 4151.6886233532005, 4219.620234178878, 2922.415516896629, 2941.794074414813, 2947.322115913352, 2949.911502654924, 2953.527435610292, 539.8164624027771, 544.5453046705966, 553.3249435688454, 553.7923278770461, 555.081340381669, 501.7792171444553, 511.3914441814229, 582.9329627092853, 635.7679447001811, 700.7666506947706, 7349.63251837406, 8123.350131989427, 8208.0, 8238.176182381714, 8424.0, 529.5207836907605, 602.9608075475168, 604.2658170323078, 627.3224917089532, 651.4397618048474, 3843.3177886723356, 3868.207017561393, 4060.614241647039, 4146.087860670647, 4188.267053265667, 58607.120893186635, 59201.40798591959, 59408.0, 59436.40563594309, 59519.0, 51086.23370649443, 52029.0, 52234.73882630563, 52341.0, 52341.47658523366, 45908.770456147504, 46218.53781462142, 46222.0, 46483.53516464792, 46850.29724554135, 8144.633491492778, 8391.081501749775, 8476.915230847859, 8568.871466927876, 8703.869441958503, 33924.32151357008, 33986.3202735939, 34123.317533649686, 34398.14004649804, 34419.311613768084, 42449.36325955175, 46147.76926115348, 46225.92971852417, 46565.3015204779, 46612.300815488474, 10499.895001049892, 10672.0, 10750.139988801033, 10764.192685548773, 10824.56701731922, 11574.884251157717, 11669.474873630877, 11781.234219775688, 12022.158448908493, 12114.636560903187, 10281.383117013003, 10482.737931551772, 10503.842442363219, 10550.0, 11326.37704926204, 10292.845607315747, 10478.318909271178, 10561.683149505527, 10564.418956957441, 10773.24587278883, 9349.532523373668, 9703.854442183232, 9816.0, 9841.557129929313, 10774.784504309713, 9107.544622768968, 9492.810143797224, 9507.286953478655, 9524.666636667684, 9610.807783844424, 8556.657733690832, 9138.406003609743, 9338.906610934075, 9347.117407211477, 9564.13922746956], "unit": "score", "name": "yui.html", "value": 5997.791096343521}], "name": "dromaeo_css", "value": 6893.663108146767}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 111.0, 111.0, 112.0, 121.0, 112.0, 113.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [147.0, 124.0, 147.0, 168.0, 125.0, 145.0, 149.0, 130.0, 158.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 142.0}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 163.0, 161.0, 162.0, 161.0, 161.0, 163.0, 181.0, 166.0], "unit": "score", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 71.0, 74.0, 135.0, 74.0, 73.0, 75.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 150.0, 96.0, 99.0, 98.0, 137.0, 96.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [101.0, 96.0, 96.0, 96.0, 97.0, 98.0, 96.0, 95.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 61.0, 58.0, 60.0, 58.0, 61.0, 56.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [89.0, 96.0, 89.0, 88.0, 87.0, 88.0, 88.0, 87.0, 88.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.9}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 125.0, 130.0, 117.0, 137.0, 121.0, 123.0, 129.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.8}, {"lowerIsBetter": true, "replicates": [144.0, 156.0, 159.0, 155.0, 154.0, 153.0, 157.0, 159.0, 155.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.4}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 67.0, 72.0, 68.0, 77.0, 68.0, 70.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1526.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.1188905800778], "unit": "score", "name": "Richards", "value": 208.74072599999994}, {"lowerIsBetter": false, "replicates": [188.5014137606032], "unit": "score", "name": "DeltaBlue", "value": 350.7559900000001}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [726.7441860465116], "unit": "score", "name": "Earley", "value": 917.0530880000003}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [25200.0], "unit": "score", "name": "RegExp", "value": 36.150198412698415}, {"lowerIsBetter": false, "replicates": [570.4506560182544], "unit": "score", "name": "Splay", "value": 142.853723}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21393.31126209587}]} 22:08:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21393.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1526.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6893.66"}}} 22:08:38 INFO - Return code: 0 22:08:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:08:38 INFO - # TBPL SUCCESS # 22:08:38 INFO - Running post-action listener: _resource_record_post_action 22:08:38 INFO - Running post-run listener: _resource_record_post_run 22:08:39 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 567623680; Read time: 0; Write time: 598724 22:08:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 247222272; Read time: 0; Write time: 319432 22:08:39 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 320401408; Read time: 0; Write time: 279292 22:08:39 INFO - Running post-run listener: _upload_blobber_files 22:08:39 INFO - Blob upload gear active. 22:08:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:08:39 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 22:08:39 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'] 22:08:39 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 22:08:39 INFO - (blobuploader) - INFO - Open directory for files ... 22:08:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:08:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:40 INFO - (blobuploader) - INFO - Done attempting. 22:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:41 INFO - (blobuploader) - INFO - Done attempting. 22:08:41 INFO - (blobuploader) - INFO - Iteration through files over. 22:08:41 INFO - Return code: 0 22:08:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:08:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:08:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2136dda08b4cc36ed98cc044172d240eadfafd16a7563339287d25b9efa4380bf79c5b129cd336f54ef43679aba6bdda12ca149ae1ce63165f13f12c395896ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a2b83e05134c0ffa7306a53cd21ba0967590f86d2ca65725392d124d53f3e7d7d6cd50f319bffa6ef88b00e5f1a559a7ae25e8e603bd3c790bf99a444a34b04"} 22:08:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:08:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:08:41 INFO - Contents: 22:08:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2136dda08b4cc36ed98cc044172d240eadfafd16a7563339287d25b9efa4380bf79c5b129cd336f54ef43679aba6bdda12ca149ae1ce63165f13f12c395896ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a2b83e05134c0ffa7306a53cd21ba0967590f86d2ca65725392d124d53f3e7d7d6cd50f319bffa6ef88b00e5f1a559a7ae25e8e603bd3c790bf99a444a34b04"} 22:08:41 INFO - Copying logs to upload dir... 22:08:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.697929 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-29 22:08:40.691329) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 22:08:40.694824) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759 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/2136dda08b4cc36ed98cc044172d240eadfafd16a7563339287d25b9efa4380bf79c5b129cd336f54ef43679aba6bdda12ca149ae1ce63165f13f12c395896ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a2b83e05134c0ffa7306a53cd21ba0967590f86d2ca65725392d124d53f3e7d7d6cd50f319bffa6ef88b00e5f1a559a7ae25e8e603bd3c790bf99a444a34b04"} build_url:https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/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/2136dda08b4cc36ed98cc044172d240eadfafd16a7563339287d25b9efa4380bf79c5b129cd336f54ef43679aba6bdda12ca149ae1ce63165f13f12c395896ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a2b83e05134c0ffa7306a53cd21ba0967590f86d2ca65725392d124d53f3e7d7d6cd50f319bffa6ef88b00e5f1a559a7ae25e8e603bd3c790bf99a444a34b04"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 22:08:40.720079) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:08:40.720777) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451450222.217643-422971759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:08:40.803237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 22:08:40.803579) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 22:08:40.803880) ========= ========= Total master_lag: 0.24 =========