builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1452222411.33 results: success (0) buildid: 20160107163004 builduid: 7ca013e06e03453fb834321594ac0929 revision: b4d9c2dd5f7aa41a59138482956400da38b8b9f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.329799) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.330186) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.330495) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006387 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.356661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.356945) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.382205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.382471) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004627 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.431960) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.432224) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.432567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.432898) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 19:06:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2016-01-07 19:06:52 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101759 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.546422) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.546720) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014225 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.596892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.597194) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b4d9c2dd5f7aa41a59138482956400da38b8b9f1 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b4d9c2dd5f7aa41a59138482956400da38b8b9f1 --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=516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 19:06:52,205 truncating revision to first 12 chars 2016-01-07 19:06:52,206 Setting DEBUG logging. 2016-01-07 19:06:52,206 attempt 1/10 2016-01-07 19:06:52,206 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b4d9c2dd5f7a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 19:06:52,453 unpacking tar archive at: mozilla-central-b4d9c2dd5f7a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546725 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:52.157733) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:52.158029) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:52.170295) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:52.170562) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:52.170913) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-07 19:06:52.171188) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:06:52 INFO - MultiFileLogger online at 20160107 19:06:52 in /builds/slave/test-pgo 19:06:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:06:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:06:52 INFO - {'append_to_log': False, 19:06:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:06:52 INFO - 'blob_upload_branch': 'Firefox', 19:06:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:06:52 INFO - 'branch': 'Firefox', 19:06:52 INFO - 'buildbot_json_path': 'buildprops.json', 19:06:52 INFO - 'config_files': ('talos/linux_config.py',), 19:06:52 INFO - 'default_actions': ('clobber', 19:06:52 INFO - 'read-buildbot-config', 19:06:52 INFO - 'download-and-extract', 19:06:52 INFO - 'populate-webroot', 19:06:52 INFO - 'create-virtualenv', 19:06:52 INFO - 'install', 19:06:52 INFO - 'run-tests'), 19:06:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:06:52 INFO - 'download_minidump_stackwalk': True, 19:06:52 INFO - 'download_symbols': 'ondemand', 19:06:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:06:52 INFO - 'tooltool.py': '/tools/tooltool.py', 19:06:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:06:52 INFO - '/tools/misc-python/virtualenv.py')}, 19:06:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:06:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:06:52 INFO - 'installer_path': 'installer.exe', 19:06:52 INFO - 'log_level': 'info', 19:06:52 INFO - 'log_name': 'talos', 19:06:52 INFO - 'log_to_console': True, 19:06:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:06:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:06:52 INFO - 'opt_config_files': (), 19:06:52 INFO - 'pip_index': False, 19:06:52 INFO - 'sps_profile': False, 19:06:52 INFO - 'sps_profile_interval': 0, 19:06:52 INFO - 'suite': 'dromaeojs', 19:06:52 INFO - 'system_bits': '32', 19:06:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:06:52 INFO - 'title': 'talos-linux64-ix-061', 19:06:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:06:52 INFO - 'use_talos_json': True, 19:06:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:06:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:06:52 INFO - 'work_dir': 'build'} 19:06:52 INFO - ##### 19:06:52 INFO - ##### Running clobber step. 19:06:52 INFO - ##### 19:06:52 INFO - Running pre-action listener: _resource_record_pre_action 19:06:52 INFO - Running main action method: clobber 19:06:52 INFO - rmtree: /builds/slave/test-pgo/build 19:06:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:06:53 INFO - Running post-action listener: _resource_record_post_action 19:06:53 INFO - ##### 19:06:53 INFO - ##### Running read-buildbot-config step. 19:06:53 INFO - ##### 19:06:53 INFO - Running pre-action listener: _resource_record_pre_action 19:06:53 INFO - Running main action method: read_buildbot_config 19:06:53 INFO - Using buildbot properties: 19:06:53 INFO - { 19:06:53 INFO - "project": "", 19:06:53 INFO - "product": "firefox", 19:06:53 INFO - "script_repo_revision": "production", 19:06:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:06:53 INFO - "repository": "", 19:06:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:06:53 INFO - "buildid": "20160107163004", 19:06:53 INFO - "pgo_build": "True", 19:06:53 INFO - "basedir": "/builds/slave/test-pgo", 19:06:53 INFO - "buildnumber": 154, 19:06:53 INFO - "slavename": "talos-linux64-ix-061", 19:06:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:06:53 INFO - "platform": "ubuntu64_hw", 19:06:53 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:06:53 INFO - "branch": "mozilla-central", 19:06:53 INFO - "repo_path": "mozilla-central", 19:06:53 INFO - "revision": "b4d9c2dd5f7aa41a59138482956400da38b8b9f1", 19:06:53 INFO - "stage_platform": "linux64-pgo", 19:06:53 INFO - "builduid": "7ca013e06e03453fb834321594ac0929", 19:06:53 INFO - "slavebuilddir": "test" 19:06:53 INFO - } 19:06:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:06:53 INFO - Running post-action listener: _resource_record_post_action 19:06:53 INFO - ##### 19:06:53 INFO - ##### Running download-and-extract step. 19:06:53 INFO - ##### 19:06:53 INFO - Running pre-action listener: _resource_record_pre_action 19:06:53 INFO - Running main action method: download_and_extract 19:06:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:53 INFO - https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:06:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/test_packages.json 19:06:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/test_packages.json 19:06:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:06:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:06:57 INFO - Downloaded 1302 bytes. 19:06:57 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:06:57 INFO - Using the following test package requirements: 19:06:57 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:06:57 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:06:57 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:57 INFO - u'jsshell-linux-x86_64.zip'], 19:06:57 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:06:57 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:06:57 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:06:57 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:06:57 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:06:57 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:06:57 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:06:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:06: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')]} 19:06:57 INFO - https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:06:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:06:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:06:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:06:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:07:02 INFO - Downloaded 24056302 bytes. 19:07:02 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 19:07:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:07:02 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 19:07:03 INFO - Return code: 0 19:07:03 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 19:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:03 INFO - https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:07:04 INFO - Downloaded 24056302 bytes. 19:07:04 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 19:07:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:07:04 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 19:07:05 INFO - Return code: 0 19:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:05 INFO - https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:07:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:07:06 INFO - Downloaded 11132285 bytes. 19:07:06 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 19:07:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:06 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 19:07:07 INFO - Return code: 0 19:07: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')]} 19:07:07 INFO - https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:07:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:07:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:07:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:07:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:07:08 INFO - Downloaded 55915867 bytes. 19:07:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:07:08 INFO - mkdir: /builds/slave/test-pgo/properties 19:07:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:07:08 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:07:08 INFO - Contents: 19:07:08 INFO - build_url:https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:07:08 INFO - Running post-action listener: _resource_record_post_action 19:07:08 INFO - Running post-action listener: set_extra_try_arguments 19:07:08 INFO - ##### 19:07:08 INFO - ##### Running populate-webroot step. 19:07:08 INFO - ##### 19:07:08 INFO - Running pre-action listener: _resource_record_pre_action 19:07:08 INFO - Running main action method: populate_webroot 19:07:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:07:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:07:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:07:08 INFO - '--tppagecycles', 19:07:08 INFO - '7'], 19:07:08 INFO - 'tests': ['tsvgm']}}, 19:07:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:07:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:07:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:07:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:07:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:07:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:07:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:08 INFO - 'talos_options': ['--e10s'], 19:07:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:08 INFO - 'tests': ['damp', 'tps']}, 19:07:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:08 INFO - 'talos_options': ['--e10s'], 19:07:08 INFO - 'tests': ['damp', 'tps']}, 19:07:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:07:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:07:08 INFO - 'other': {'tests': ['a11yr', 19:07:08 INFO - 'ts_paint', 19:07:08 INFO - 'tpaint', 19:07:08 INFO - 'sessionrestore', 19:07:08 INFO - 'sessionrestore_no_auto_restore']}, 19:07:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:07:08 INFO - 'tests': ['a11yr', 19:07:08 INFO - 'ts_paint', 19:07:08 INFO - 'tpaint', 19:07:08 INFO - 'sessionrestore', 19:07:08 INFO - 'sessionrestore_no_auto_restore']}, 19:07:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:07:08 INFO - 'tests': ['a11yr', 19:07:08 INFO - 'ts_paint', 19:07:08 INFO - 'tpaint', 19:07:08 INFO - 'sessionrestore', 19:07:08 INFO - 'sessionrestore_no_auto_restore']}, 19:07:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:07:08 INFO - 'tests': ['a11yr', 19:07:08 INFO - 'ts_paint', 19:07:08 INFO - 'tpaint', 19:07:08 INFO - 'sessionrestore', 19:07:08 INFO - 'sessionrestore_no_auto_restore']}, 19:07:08 INFO - 'other_l64': {'tests': ['a11yr', 19:07:08 INFO - 'ts_paint', 19:07:08 INFO - 'tpaint', 19:07:08 INFO - 'sessionrestore', 19:07:08 INFO - 'sessionrestore_no_auto_restore']}, 19:07:08 INFO - 'other_nol64': {'tests': ['a11yr', 19:07:08 INFO - 'ts_paint', 19:07:08 INFO - 'tpaint', 19:07:08 INFO - 'sessionrestore', 19:07:08 INFO - 'sessionrestore_no_auto_restore']}, 19:07:08 INFO - 'svgr': {'tests': ['tsvgx', 19:07:08 INFO - 'tsvgr_opacity', 19:07:08 INFO - 'tart', 19:07:08 INFO - 'tscrollx', 19:07:08 INFO - 'cart']}, 19:07:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:07:08 INFO - 'tests': ['tsvgx', 19:07:08 INFO - 'tsvgr_opacity', 19:07:08 INFO - 'tart', 19:07:08 INFO - 'tscrollx', 19:07:08 INFO - 'cart']}, 19:07:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:08 INFO - 'tests': ['tp5o']}, 19:07:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:08 INFO - 'talos_options': ['--e10s'], 19:07:08 INFO - 'tests': ['tp5o']}, 19:07:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:08 INFO - 'talos_options': ['--xperf_path', 19:07:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:08 INFO - 'tests': ['tp5n']}, 19:07:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:08 INFO - 'talos_options': ['--e10s', 19:07:08 INFO - '--xperf_path', 19:07:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:08 INFO - 'tests': ['tp5n']}}, 19:07:08 INFO - 'talos.zip': {'path': '', 19:07:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:07:08 INFO - Running post-action listener: _resource_record_post_action 19:07:08 INFO - ##### 19:07:08 INFO - ##### Running create-virtualenv step. 19:07:08 INFO - ##### 19:07:08 INFO - Running pre-action listener: _resource_record_pre_action 19:07:08 INFO - Running main action method: create_virtualenv 19:07:08 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:07:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 19:07:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:07:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:07:08 INFO - Using real prefix '/usr' 19:07:08 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:07:09 INFO - Installing distribute.............................................................................................................................................................................................done. 19:07:11 INFO - Installing pip.................done. 19:07:11 INFO - Return code: 0 19:07:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:11 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 0x7fedd3a06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afd660>, '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 0x2afe560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afea10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:07:11 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 19:07:11 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 19:07:11 INFO - Using env: {'DISPLAY': ':0', 19:07:11 INFO - 'HOME': '/home/cltbld', 19:07:11 INFO - 'LANG': 'en_US.UTF-8', 19:07:11 INFO - 'LANGUAGE': 'en_US:en', 19:07:11 INFO - 'LOGNAME': 'cltbld', 19:07:11 INFO - 'MAIL': '/var/mail/cltbld', 19:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:11 INFO - 'MOZ_NO_REMOTE': '1', 19:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:11 INFO - 'NO_EM_RESTART': '1', 19:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:11 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:11 INFO - 'SHELL': '/bin/bash', 19:07:11 INFO - 'SHLVL': '1', 19:07:11 INFO - 'TERM': 'linux', 19:07:11 INFO - 'TMOUT': '86400', 19:07:11 INFO - 'USER': 'cltbld', 19:07:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 19:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:11 INFO - '_': '/tools/buildbot/bin/python'} 19:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:07:11 INFO - Cleaning up... 19:07:11 INFO - Return code: 0 19:07:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:11 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 0x7fedd3a06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afd660>, '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 0x2afe560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afea10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:07:11 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 19:07:11 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 19:07:11 INFO - Using env: {'DISPLAY': ':0', 19:07:11 INFO - 'HOME': '/home/cltbld', 19:07:11 INFO - 'LANG': 'en_US.UTF-8', 19:07:11 INFO - 'LANGUAGE': 'en_US:en', 19:07:11 INFO - 'LOGNAME': 'cltbld', 19:07:11 INFO - 'MAIL': '/var/mail/cltbld', 19:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:11 INFO - 'MOZ_NO_REMOTE': '1', 19:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:11 INFO - 'NO_EM_RESTART': '1', 19:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:11 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:11 INFO - 'SHELL': '/bin/bash', 19:07:11 INFO - 'SHLVL': '1', 19:07:11 INFO - 'TERM': 'linux', 19:07:11 INFO - 'TMOUT': '86400', 19:07:11 INFO - 'USER': 'cltbld', 19:07:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 19:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:11 INFO - '_': '/tools/buildbot/bin/python'} 19:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:11 INFO - Downloading/unpacking psutil>=0.7.1 19:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:13 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:07:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:07:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:07:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:13 INFO - Installing collected packages: psutil 19:07:13 INFO - Running setup.py install for psutil 19:07:13 INFO - building 'psutil._psutil_linux' extension 19:07:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:07:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:07:13 INFO - building 'psutil._psutil_posix' extension 19:07:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:07:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:07:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:13 INFO - Successfully installed psutil 19:07:13 INFO - Cleaning up... 19:07:13 INFO - Return code: 0 19:07:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:13 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 0x7fedd3a06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afd660>, '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 0x2afe560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afea10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:07:13 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 19:07:13 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 19:07:13 INFO - Using env: {'DISPLAY': ':0', 19:07:13 INFO - 'HOME': '/home/cltbld', 19:07:13 INFO - 'LANG': 'en_US.UTF-8', 19:07:13 INFO - 'LANGUAGE': 'en_US:en', 19:07:13 INFO - 'LOGNAME': 'cltbld', 19:07:13 INFO - 'MAIL': '/var/mail/cltbld', 19:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:13 INFO - 'MOZ_NO_REMOTE': '1', 19:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:13 INFO - 'NO_EM_RESTART': '1', 19:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:13 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:13 INFO - 'SHELL': '/bin/bash', 19:07:13 INFO - 'SHLVL': '1', 19:07:13 INFO - 'TERM': 'linux', 19:07:13 INFO - 'TMOUT': '86400', 19:07:13 INFO - 'USER': 'cltbld', 19:07:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 19:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:13 INFO - '_': '/tools/buildbot/bin/python'} 19:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:07:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:07:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:07:15 INFO - Installing collected packages: mozsystemmonitor 19:07:15 INFO - Running setup.py install for mozsystemmonitor 19:07:15 INFO - Successfully installed mozsystemmonitor 19:07:15 INFO - Cleaning up... 19:07:16 INFO - Return code: 0 19:07:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fedd3a06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afd660>, '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 0x2afe560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afea10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:07:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:07:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:07:16 INFO - Using env: {'DISPLAY': ':0', 19:07:16 INFO - 'HOME': '/home/cltbld', 19:07:16 INFO - 'LANG': 'en_US.UTF-8', 19:07:16 INFO - 'LANGUAGE': 'en_US:en', 19:07:16 INFO - 'LOGNAME': 'cltbld', 19:07:16 INFO - 'MAIL': '/var/mail/cltbld', 19:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:16 INFO - 'MOZ_NO_REMOTE': '1', 19:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:16 INFO - 'NO_EM_RESTART': '1', 19:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:16 INFO - 'SHELL': '/bin/bash', 19:07:16 INFO - 'SHLVL': '1', 19:07:16 INFO - 'TERM': 'linux', 19:07:16 INFO - 'TMOUT': '86400', 19:07:16 INFO - 'USER': 'cltbld', 19:07:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 19:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:16 INFO - '_': '/tools/buildbot/bin/python'} 19:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:16 INFO - Downloading/unpacking blobuploader==1.2.4 19:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:17 INFO - Downloading blobuploader-1.2.4.tar.gz 19:07:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:07:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:07:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:07:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:07:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:18 INFO - Downloading docopt-0.6.1.tar.gz 19:07:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:07:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:07:18 INFO - Installing collected packages: blobuploader, requests, docopt 19:07:18 INFO - Running setup.py install for blobuploader 19:07:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:07:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:07:18 INFO - Running setup.py install for requests 19:07:19 INFO - Running setup.py install for docopt 19:07:19 INFO - Successfully installed blobuploader requests docopt 19:07:19 INFO - Cleaning up... 19:07:19 INFO - Return code: 0 19:07:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:19 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 0x7fedd3a06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afd660>, '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 0x2afe560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afea10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:07:19 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 19:07:19 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 19:07:19 INFO - Using env: {'DISPLAY': ':0', 19:07:19 INFO - 'HOME': '/home/cltbld', 19:07:19 INFO - 'LANG': 'en_US.UTF-8', 19:07:19 INFO - 'LANGUAGE': 'en_US:en', 19:07:19 INFO - 'LOGNAME': 'cltbld', 19:07:19 INFO - 'MAIL': '/var/mail/cltbld', 19:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:19 INFO - 'MOZ_NO_REMOTE': '1', 19:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:19 INFO - 'NO_EM_RESTART': '1', 19:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:19 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:19 INFO - 'SHELL': '/bin/bash', 19:07:19 INFO - 'SHLVL': '1', 19:07:19 INFO - 'TERM': 'linux', 19:07:19 INFO - 'TMOUT': '86400', 19:07:19 INFO - 'USER': 'cltbld', 19:07:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 19:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:19 INFO - '_': '/tools/buildbot/bin/python'} 19:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:07:19 INFO - Running setup.py (path:/tmp/pip-WdTGAS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:07:19 INFO - Running setup.py (path:/tmp/pip-7gUStE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:07:19 INFO - Running setup.py (path:/tmp/pip-fZl3cQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:07:19 INFO - Running setup.py (path:/tmp/pip-UEK6yL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:07:19 INFO - Running setup.py (path:/tmp/pip-kZ_6LP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:07:19 INFO - Running setup.py (path:/tmp/pip-fB13L4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:07:19 INFO - Running setup.py (path:/tmp/pip-yorTGG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:07:20 INFO - Running setup.py (path:/tmp/pip-oiCvPy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:07:20 INFO - Running setup.py (path:/tmp/pip-UHYktE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:07:20 INFO - Running setup.py (path:/tmp/pip-0q6IWL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:07:20 INFO - Running setup.py (path:/tmp/pip-Jl31dH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:07:20 INFO - Running setup.py (path:/tmp/pip-DOJ2pc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:07:20 INFO - Running setup.py (path:/tmp/pip-XzMIEJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:07:20 INFO - Running setup.py (path:/tmp/pip-cW8Jzz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:07:20 INFO - Running setup.py (path:/tmp/pip-Vmu2vz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:07:20 INFO - Running setup.py (path:/tmp/pip-A0Owys-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:07:20 INFO - Running setup.py (path:/tmp/pip-p8N9r6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:07:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:07:20 INFO - Running setup.py install for manifestparser 19:07:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:07:20 INFO - Running setup.py install for mozcrash 19:07:20 INFO - Running setup.py install for mozdebug 19:07:21 INFO - Running setup.py install for mozdevice 19:07:21 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:07:21 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:07:21 INFO - Running setup.py install for mozfile 19:07:21 INFO - Running setup.py install for mozhttpd 19:07:21 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:07:21 INFO - Running setup.py install for mozinfo 19:07:21 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:07:21 INFO - Running setup.py install for mozInstall 19:07:21 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:07:21 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:07:21 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:07:21 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:07:21 INFO - Running setup.py install for mozleak 19:07:21 INFO - Running setup.py install for mozlog 19:07:21 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:07:21 INFO - Running setup.py install for moznetwork 19:07:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:07:21 INFO - Running setup.py install for mozprocess 19:07:21 INFO - Running setup.py install for mozprofile 19:07:22 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:07:22 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:07:22 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:07:22 INFO - Running setup.py install for mozrunner 19:07:22 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:07:22 INFO - Running setup.py install for mozscreenshot 19:07:22 INFO - Running setup.py install for moztest 19:07:22 INFO - Running setup.py install for mozversion 19:07:22 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:07:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:07:22 INFO - Cleaning up... 19:07:22 INFO - Return code: 0 19:07:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:22 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 0x7fedd3a06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afd660>, '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 0x2afe560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afea10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:07:22 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 19:07:22 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 19:07:22 INFO - Using env: {'DISPLAY': ':0', 19:07:22 INFO - 'HOME': '/home/cltbld', 19:07:22 INFO - 'LANG': 'en_US.UTF-8', 19:07:22 INFO - 'LANGUAGE': 'en_US:en', 19:07:22 INFO - 'LOGNAME': 'cltbld', 19:07:22 INFO - 'MAIL': '/var/mail/cltbld', 19:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:22 INFO - 'MOZ_NO_REMOTE': '1', 19:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:22 INFO - 'NO_EM_RESTART': '1', 19:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:22 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:22 INFO - 'SHELL': '/bin/bash', 19:07:22 INFO - 'SHLVL': '1', 19:07:22 INFO - 'TERM': 'linux', 19:07:22 INFO - 'TMOUT': '86400', 19:07:22 INFO - 'USER': 'cltbld', 19:07:22 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 19:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:22 INFO - '_': '/tools/buildbot/bin/python'} 19:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:07:22 INFO - Running setup.py (path:/tmp/pip-LR_LLq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 19:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:07:22 INFO - Running setup.py (path:/tmp/pip-GDh7QO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:07:22 INFO - Running setup.py (path:/tmp/pip-nSDwGZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:07:22 INFO - Running setup.py (path:/tmp/pip-4ydSSP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:07:23 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)) 19:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:07:23 INFO - Running setup.py (path:/tmp/pip-K0WSuw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:07:23 INFO - Running setup.py (path:/tmp/pip-CzViCj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:07:23 INFO - Running setup.py (path:/tmp/pip-lgK30g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:07:23 INFO - Running setup.py (path:/tmp/pip-RhniL_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:07:23 INFO - Running setup.py (path:/tmp/pip-cE4ghx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:07:23 INFO - Running setup.py (path:/tmp/pip-ijwvBG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:07:23 INFO - Running setup.py (path:/tmp/pip-6qDUxu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 19:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:07:23 INFO - Running setup.py (path:/tmp/pip-wLou2x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:07:23 INFO - Running setup.py (path:/tmp/pip-RvRkwl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:07:23 INFO - Running setup.py (path:/tmp/pip-71s7pM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 19:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:07:23 INFO - Running setup.py (path:/tmp/pip-Nq6UHo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 19:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:07:23 INFO - Running setup.py (path:/tmp/pip-y1M8Ff-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 19:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:07:23 INFO - Running setup.py (path:/tmp/pip-GuqHBk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:07:23 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)) 19:07:23 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)) 19:07:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:25 INFO - Downloading blessings-1.5.1.tar.gz 19:07:25 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 19:07:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:07:25 INFO - Installing collected packages: blessings 19:07:25 INFO - Running setup.py install for blessings 19:07:25 INFO - Successfully installed blessings 19:07:25 INFO - Cleaning up... 19:07:25 INFO - Return code: 0 19:07:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:07:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:07:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:07:26 INFO - Reading from file tmpfile_stdout 19:07:26 INFO - Current package versions: 19:07:26 INFO - argparse == 1.2.1 19:07:26 INFO - blessings == 1.5.1 19:07:26 INFO - blobuploader == 1.2.4 19:07:26 INFO - docopt == 0.6.1 19:07:26 INFO - manifestparser == 1.1 19:07:26 INFO - mozInstall == 1.12 19:07:26 INFO - mozcrash == 0.16 19:07:26 INFO - mozdebug == 0.1 19:07:26 INFO - mozdevice == 0.47 19:07:26 INFO - mozfile == 1.2 19:07:26 INFO - mozhttpd == 0.7 19:07:26 INFO - mozinfo == 0.9 19:07:26 INFO - mozleak == 0.1 19:07:26 INFO - mozlog == 3.1 19:07:26 INFO - moznetwork == 0.27 19:07:26 INFO - mozprocess == 0.22 19:07:26 INFO - mozprofile == 0.28 19:07:26 INFO - mozrunner == 6.11 19:07:26 INFO - mozscreenshot == 0.1 19:07:26 INFO - mozsystemmonitor == 0.0 19:07:26 INFO - moztest == 0.7 19:07:26 INFO - mozversion == 1.4 19:07:26 INFO - psutil == 3.1.1 19:07:26 INFO - requests == 1.2.3 19:07:26 INFO - wsgiref == 0.1.2 19:07:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:26 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 0x7fedd3a06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afd660>, '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 0x2afe560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afea10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:07:26 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 19:07:26 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 19:07:26 INFO - Using env: {'DISPLAY': ':0', 19:07:26 INFO - 'HOME': '/home/cltbld', 19:07:26 INFO - 'LANG': 'en_US.UTF-8', 19:07:26 INFO - 'LANGUAGE': 'en_US:en', 19:07:26 INFO - 'LOGNAME': 'cltbld', 19:07:26 INFO - 'MAIL': '/var/mail/cltbld', 19:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:26 INFO - 'MOZ_NO_REMOTE': '1', 19:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:26 INFO - 'NO_EM_RESTART': '1', 19:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:26 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:26 INFO - 'SHELL': '/bin/bash', 19:07:26 INFO - 'SHLVL': '1', 19:07:26 INFO - 'TERM': 'linux', 19:07:26 INFO - 'TMOUT': '86400', 19:07:26 INFO - 'USER': 'cltbld', 19:07:26 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 19:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:26 INFO - '_': '/tools/buildbot/bin/python'} 19:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 19:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 19:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 19:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 19:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 19:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 19:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:07:26 INFO - Cleaning up... 19:07:26 INFO - Return code: 0 19:07:26 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:26 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 0x7fedd3a06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afd660>, '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 0x2afe560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afea10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:07:26 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 19:07:26 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 19:07:26 INFO - Using env: {'DISPLAY': ':0', 19:07:26 INFO - 'HOME': '/home/cltbld', 19:07:26 INFO - 'LANG': 'en_US.UTF-8', 19:07:26 INFO - 'LANGUAGE': 'en_US:en', 19:07:26 INFO - 'LOGNAME': 'cltbld', 19:07:26 INFO - 'MAIL': '/var/mail/cltbld', 19:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:26 INFO - 'MOZ_NO_REMOTE': '1', 19:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:26 INFO - 'NO_EM_RESTART': '1', 19:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:26 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:26 INFO - 'SHELL': '/bin/bash', 19:07:26 INFO - 'SHLVL': '1', 19:07:26 INFO - 'TERM': 'linux', 19:07:26 INFO - 'TMOUT': '86400', 19:07:26 INFO - 'USER': 'cltbld', 19:07:26 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 19:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:26 INFO - '_': '/tools/buildbot/bin/python'} 19:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:26 INFO - Downloading/unpacking jsonschema 19:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:07:28 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 19:07:28 INFO - Downloading/unpacking functools32 (from jsonschema) 19:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:28 INFO - Downloading functools32-3.2.3-2.tar.gz 19:07:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:07:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:07:28 INFO - warning: no files found matching '*.txt' 19:07:28 INFO - no previously-included directories found matching 'build' 19:07:28 INFO - no previously-included directories found matching 'dist' 19:07:28 INFO - no previously-included directories found matching '.git*' 19:07:28 INFO - Installing collected packages: jsonschema, functools32 19:07:28 INFO - Running setup.py install for functools32 19:07:28 INFO - warning: no files found matching '*.txt' 19:07:28 INFO - no previously-included directories found matching 'build' 19:07:28 INFO - no previously-included directories found matching 'dist' 19:07:28 INFO - no previously-included directories found matching '.git*' 19:07:28 INFO - Successfully installed jsonschema functools32 19:07:28 INFO - Cleaning up... 19:07:28 INFO - Return code: 0 19:07:28 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:28 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 0x7fedd3a06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afd660>, '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 0x2afe560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afea10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:07:28 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 19:07:28 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 19:07:28 INFO - Using env: {'DISPLAY': ':0', 19:07:28 INFO - 'HOME': '/home/cltbld', 19:07:28 INFO - 'LANG': 'en_US.UTF-8', 19:07:28 INFO - 'LANGUAGE': 'en_US:en', 19:07:28 INFO - 'LOGNAME': 'cltbld', 19:07:28 INFO - 'MAIL': '/var/mail/cltbld', 19:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:28 INFO - 'MOZ_NO_REMOTE': '1', 19:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:28 INFO - 'NO_EM_RESTART': '1', 19:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:28 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:28 INFO - 'SHELL': '/bin/bash', 19:07:28 INFO - 'SHLVL': '1', 19:07:28 INFO - 'TERM': 'linux', 19:07:28 INFO - 'TMOUT': '86400', 19:07:28 INFO - 'USER': 'cltbld', 19:07:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 19:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:28 INFO - '_': '/tools/buildbot/bin/python'} 19:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:28 INFO - Downloading/unpacking flake8 19:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:07:30 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 19:07:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:07:30 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 19:07:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:30 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 19:07:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:07:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:07:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:07:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:07:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:07:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:07:31 INFO - no previously-included directories found matching 'docs/_build' 19:07:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:07:31 INFO - Running setup.py install for pep8 19:07:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:07:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:07:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:07:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:07:31 INFO - no previously-included directories found matching 'docs/_build' 19:07:31 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:07:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:07:31 INFO - Cleaning up... 19:07:31 INFO - Return code: 0 19:07:31 INFO - Running post-action listener: _resource_record_post_action 19:07:31 INFO - Running post-action listener: _start_resource_monitoring 19:07:31 INFO - Starting resource monitoring. 19:07:31 INFO - ##### 19:07:31 INFO - ##### Running install step. 19:07:31 INFO - ##### 19:07:31 INFO - Running pre-action listener: _resource_record_pre_action 19:07:31 INFO - Running main action method: install 19:07:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:07:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:07:31 INFO - Reading from file tmpfile_stdout 19:07:31 INFO - Detecting whether we're running mozinstall >=1.0... 19:07:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:07:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:07:31 INFO - Reading from file tmpfile_stdout 19:07:31 INFO - Output received: 19:07:31 INFO - Usage: mozinstall [options] installer 19:07:31 INFO - Options: 19:07:31 INFO - -h, --help show this help message and exit 19:07:31 INFO - -d DEST, --destination=DEST 19:07:31 INFO - Directory to install application into. [default: 19:07:31 INFO - "/builds/slave/test-pgo"] 19:07:31 INFO - --app=APP Application being installed. [default: firefox] 19:07:31 INFO - mkdir: /builds/slave/test-pgo/build/application 19:07:31 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'] 19:07:31 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 19:07:47 INFO - Reading from file tmpfile_stdout 19:07:47 INFO - Output received: 19:07:47 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:07:47 INFO - Running post-action listener: _resource_record_post_action 19:07:47 INFO - ##### 19:07:47 INFO - ##### Running run-tests step. 19:07:47 INFO - ##### 19:07:47 INFO - Running pre-action listener: _resource_record_pre_action 19:07:47 INFO - Running main action method: run_tests 19:07:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:07:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:07:47 INFO - Python 2.7.3 19:07:47 INFO - Return code: 0 19:07:47 INFO - grabbing minidump binary from tooltool 19:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:47 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 0x2afd660>, '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 0x2afe560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afea10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:07:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:07:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:07:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:07:48 INFO - Return code: 0 19:07:48 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:07:48 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:07:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:07:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:07:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:07:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:07:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:07:48 INFO - Return code: 0 19:07:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 19:07:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 19:07:48 INFO - Using env: {'DISPLAY': ':0', 19:07:48 INFO - 'HOME': '/home/cltbld', 19:07:48 INFO - 'LANG': 'en_US.UTF-8', 19:07:48 INFO - 'LANGUAGE': 'en_US:en', 19:07:48 INFO - 'LOGNAME': 'cltbld', 19:07:48 INFO - 'MAIL': '/var/mail/cltbld', 19:07:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:07:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:48 INFO - 'MOZ_NO_REMOTE': '1', 19:07:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:48 INFO - 'NO_EM_RESTART': '1', 19:07:48 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:48 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:07:48 INFO - 'SHELL': '/bin/bash', 19:07:48 INFO - 'SHLVL': '1', 19:07:48 INFO - 'TERM': 'linux', 19:07:48 INFO - 'TMOUT': '86400', 19:07:48 INFO - 'USER': 'cltbld', 19:07:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133', 19:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:48 INFO - '_': '/tools/buildbot/bin/python'} 19:07:48 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:07:49 INFO - mozversion application_buildid: 20160107163004 19:07:49 INFO - mozversion application_changeset: b4d9c2dd5f7aa41a59138482956400da38b8b9f1 19:07:49 INFO - mozversion application_display_name: Nightly 19:07:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:07:49 INFO - mozversion application_name: Firefox 19:07:49 INFO - mozversion application_remotingname: firefox 19:07:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:07:49 INFO - mozversion application_vendor: Mozilla 19:07:49 INFO - mozversion application_version: 46.0a1 19:07:49 INFO - mozversion platform_buildid: 20160107163004 19:07:49 INFO - mozversion platform_changeset: b4d9c2dd5f7aa41a59138482956400da38b8b9f1 19:07:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:07:49 INFO - mozversion platform_version: 46.0a1 19:07:49 INFO - using testdate: 1452222469 19:07:49 INFO - actual date: 1452222469 19:07:49 INFO - starting webserver on 'localhost:57958' 19:07:49 INFO - SUITE-START | Running 3 tests 19:07:49 INFO - TEST-START | dromaeo_css 19:07:49 INFO - operating with platform_type : linux_ 19:07:49 INFO - Initialising browser for dromaeo_css test... 19:07:49 INFO - TEST-INFO | started process 14153 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpteZrYn/profile http://localhost:57958/getInfo.html) 19:07:53 INFO - PROCESS | 14153 | __metrics Screen width/height:1600/1200 19:07:53 INFO - PROCESS | 14153 | colorDepth:24 19:07:53 INFO - PROCESS | 14153 | Browser inner width/height: 1024/697 19:07:53 INFO - PROCESS | 14153 | __metrics 19:07:53 INFO - PROCESS | 14153 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:07:53 INFO - PROCESS | 14153 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:07:54 INFO - TEST-INFO | 14153: exit 0 19:07:54 INFO - Browser initialized. 19:07:54 INFO - Running cycle 1/1 for dromaeo_css test... 19:07:54 INFO - TEST-INFO | started process 14246 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpteZrYn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:06 INFO - PROCESS | 14246 | RSS: Main: 149901312 19:08:06 INFO - PROCESS | 14246 | 19:08:57 INFO - PROCESS | 14246 | 1452222537233 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:11:06 INFO - PROCESS | 14246 | Cycle 1(1): loaded http://localhost:57958/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57958/tests/dromaeo/cssquery-ext.html) 19:11:08 INFO - PROCESS | 14246 | RSS: Main: 317919232 19:11:08 INFO - PROCESS | 14246 | 19:14:10 INFO - PROCESS | 14246 | Cycle 1(1): loaded http://localhost:57958/tests/dromaeo/cssquery-ext.html (next: http://localhost:57958/tests/dromaeo/cssquery-jquery.html) 19:14:11 INFO - PROCESS | 14246 | RSS: Main: 232235008 19:14:11 INFO - PROCESS | 14246 | 19:17:13 INFO - PROCESS | 14246 | Cycle 1(1): loaded http://localhost:57958/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57958/tests/dromaeo/cssquery-mootools.html) 19:17:13 INFO - PROCESS | 14246 | RSS: Main: 223346688 19:17:13 INFO - PROCESS | 14246 | 19:20:15 INFO - PROCESS | 14246 | Cycle 1(1): loaded http://localhost:57958/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57958/tests/dromaeo/cssquery-prototype.html) 19:20:16 INFO - PROCESS | 14246 | RSS: Main: 212774912 19:20:16 INFO - PROCESS | 14246 | 19:23:18 INFO - PROCESS | 14246 | Cycle 1(1): loaded http://localhost:57958/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57958/tests/dromaeo/cssquery-yui.html) 19:23:19 INFO - PROCESS | 14246 | RSS: Main: 214212608 19:23:19 INFO - PROCESS | 14246 | 19:26:21 INFO - PROCESS | 14246 | Cycle 1(1): loaded http://localhost:57958/tests/dromaeo/cssquery-yui.html (next: http://localhost:57958/tests/dromaeo/cssquery-dojo.html) 19:26:22 INFO - PROCESS | 14246 | RSS: Main: 259559424 19:26:22 INFO - PROCESS | 14246 | 19:26:22 INFO - PROCESS | 14246 | __start_tp_report 19:26:22 INFO - PROCESS | 14246 | _x_x_mozilla_page_load 19:26:22 INFO - PROCESS | 14246 | _x_x_mozilla_page_load_details 19:26:22 INFO - PROCESS | 14246 | |i|pagename|runs| 19:26:22 INFO - PROCESS | 14246 | |0;dojo.html;3139.733122684572;3172.175234439045;3208.149840292323;3212.534182543531;3229.580154579904;4991.351124353838;5056.595472362212;5219.851632640818;5251.317328747262;5308.442613525582;5070.847874563759;5080.491950804918;5161.225816127583;5237.214417837326;5255.474452554743;4705.458872229686;4770.809167633291;4781.37842080529;4783.856484305476;4896.314515967767;4736.573708366246;4826.444958829727;4834.782434790425;4874.366332376786;4876.853694389174;4670.696404733681;4778.976105119452;4784.880377990543;4834.371531700874;4854.8300809471675;4693.202155633517;4768.523147685239;4809.663323567352;4811.831585894477;4825.975870120662;4726.550977657117;4730.432348118248;4732.597729193023;4740.691855029447;4765.046990601859;4856.4172299323955;4970.975145124251;5008.499150084962;5013.899722005576;5062.1141300272675;5462.918056229159;5468.781248750045;5469.863253418656;5480.671159730429;5578.581606379537;5564.33228012637;5572.637778544382;5573.303337082864;5574.275344205268;5577.414371491016;5068.366454193226;5195.454477279907;5196.168613021936;5201.063808514466;5233.842984710464;5583.246261754611;5602.85992850182;5682.176084467729;5771.538276937835;5802.47777700009;5483.040467918178;5483.561315094783;5494.203340515603;5499.587530935196;5510.669359838423;5422.620416570802;5569.470900264469;5581.441855814467;5597.720113994284;5599.664020158803;5430.782768689208;5444.700541470257;5462.672239665553;5508.44915508454;5539.556835453154;5534.667919924736;5537;5539.695316757537;5541.224228607998;5554.972225138848;4246.299360605465;4338.327559228324;4345.760983145894;4348.478182618106;4373.300271956536;3884.0872394987155;3898.142408670145;3931.272714547818;3932.7247092703237;3968.1071758854605;5176.068307704574;5180.559652429586;5186.455422180617;5187.844364669066;5188.169892817131;5316.494932981361;5393.7303134843105;5523.944760552424;5527.949689558971;5584.357798853102;5163.638545301868;5167.638265321467;5216.60875434344;5221.765020574083;5278.524932755993;4743.264793956942;4752.334673145762;4755.476897541268;4763.04739052191;4791.401074865642;5641.971790141105;5709.514691251207;5709.74306156224;5728.856778580569;5781;5362.973185134049;5544.916826247529;5610.663360198401;5613.691246981455;5671.007573674673;5751.884962300815;5759.769609215585;5763.7406316715005;5770.740316685676;5773.336066352424;5387.003404370204;5490.6431081979545;5494.697791621499;5498.120300752021;5510.118381059172;5477.890442191214;5521.475459831309;5526.281583394133;5545.029619816597;5546.140348246028;5411.648242864201;5441.319835020622;5442.700651464207;5466.863328416822;5473.890522189454;5409;5414.404415514369;5417.160340147283;5422.783088676409;5423.674579525241;5321.228421878728;5329.094054010905;5336.973315133399;5351.090314646597;5383.973080134574;5333.43998880112;5405.78376864921;5428.4842939920645;5434.701091439851;5451.48210919962;5279.656822306538;5328.70692111922;5340.732963351895;5344.091504444332;5348.438413966477 19:26:22 INFO - PROCESS | 14246 | |1;ext.html;520.9088409528334;548.6433818018285;577.6505214345323;592.2241863159262;599.7481057955658;27821.304467388327;35511;35989.280214395694;36076;36109.99999999996;38793;39167.60832391675;39229.21541569174;39232;39284;5788.131780232957;5807.361190269067;8386.329093672523;8557.144285571456;8564.357673174505;9984.95007524965;10148.340357876714;10156.898431015707;10160;10164.237682173829;9859.901400986006;9952.054554817281;9954.601815927354;9960.302778805486;9966.202703783716;7572.356349710254;7680.11678656956;9965.202783777353;9977;10232.181425485944;9740.269479789044;9830.754231144207;9873.40759554429;9881.110700037032;9887.159591434665;34551.82724086389;34722.479162812575;34747.65252347495;34872;34885.651143488496;3004.7145521175453;3019.728224459809;3155.4004739099496;3351.1789611545328;3552.520409744677;29063.229048274094;29345.706542934724;29458.263543411373;29543.26141846471;29908.10275691711;3607.350676878161;3666.899930020983;3731.81340932955;3738.3084129436143;3791.545014598266;192265;193708.03145984322;193946;194016;194064.38581492158;49737.50262497401;50602;55376;55541;55921.52627789767;51780.22329665058;51835.48164518382;51945.74027129916;52052.73973630183;52069.47930520646;13896.235707036009;13981.091229070078;13986;14037.71924561503;14044.438222470986;10698.197635177392;10730;10775.946120269506;10786.975237352439;10810.783784324269;17545.824541754675;18444.723329150074;18505.53736156607;18579.90710046441;18591;7228.855422891513;7460.291272329228;7463.888041679379;7509.9249007509225;7524;867.3711559119714;941.6327632223438;1097.7914196302677;1114.4483480677118;1124.707576030238;27570.724292757215;27719.168424947286;28245.293867653472;28324.291892702848;28422.43155136927;1002.908934870788;1028.3624153025173;1044.1646682653848;1095.594629986894;1113.3765091548757;14458.204798736171;14695.559133226021;14759.188244646433;14958.850411495963;15025.398984040734;310725;313523;315898;316195;317497;49334.506654933706;49498.25752613714;49620.25569616459;49673;49685.25472117849;1281.9679508012375;1301.2972994583008;1310.377570653951;1311.5147395463548;1319.4854006937303;22308.77691223067;28318.85840570784;29300.706992929798;30530.84734576313;31067;42617.36073958955;43035.35446968235;43180.78409608058;43213;43234.78382608067;232111;234591;234986;235186;235332;28634.57048144321;29631.555526666685;30011;30271;30277.243068923453;38496.422553661156;38719;38811.22377552489;39071.80464097661;39554.60445395509;33769.83115084507;34103.82948085244;34205;34213.82893085618;35136.29727405489;27680.723192767815;31631.20921976969;33617.83191084029;34358.31283374369;36483.45274820827;34113;34209;34855;35390.46914296236;35428;29024.41951161007;30783;31093.689063109985;31256.21859453532;31460.52809207818;23887.402814929766;24241.878790605933;24259.272221833373;24297.878510607334;24512.50974980526 19:26:22 INFO - PROCESS | 14246 | |2;jquery.html;350.81231541125504;356.3123172277503;359.6547314578006;361.33694670280033;363.04700162074556;14246.857531424683;14422.423103075864;16383.754243686339;16687.582810429747;17357.305707771706;16046.83953160468;17181.226844792014;17331.22009509572;17502.562435939108;17581.472555823344;5399.028174928511;5500.532454741332;5534.501894829465;5537.252470916415;5537.473939975695;3675;3755.586885442599;5487.725613719318;5523.171524271352;5894.823155305347;5959.195508606348;5998.490128339096;6011.218541589587;6012.3085845127935;6017.157597936292;5838.153467747175;5967.6121052131475;5975.193348897887;6022.126791615191;6024.9698751506185;5362.249285100089;5363.919541206885;5392.137258038695;5407.675539467606;5408.59435542332;20608.896955515276;20999.685004724943;21100.155993760232;21223.5755284895;21240.468988275417;1934.3809980806147;1984.2261518007988;2019.545602239499;2055.9486012849798;2127.7340332458443;9011.414258073204;9396.765080872965;12409.813852792215;12447.502099915993;13456.394462249222;1688.7213609754376;1769.0977601423238;1809.9185536650882;1812.8459080978132;1815.27389044382;54937;57199;57283.42716572822;57335.71332143354;58720.70639646817;9766.95116524427;9821.214302855755;9936.354136981074;9973;10038.899611003797;12670.746585068431;12676.112672113048;12683.175593586571;12684.23894566329;12690.111692181643;7396.038514993124;7450.292222238879;7459.813504662427;7514.6618402172035;7523.8119047023165;7041.049458323061;7098.1482222132645;7286.963565182246;7368.447366447538;7393.334599886036;4417.558244175621;4451.243288640874;4461.263891457873;4462.330650402466;4478.39541661878;1743.8517725993433;1758.841704246624;1775.1922875091802;1791.4715159028117;1796.1827368547279;872.389327470773;911.1344222988188;1001.104011909337;1001.3140998416109;1031.63377001165;16156.27296771648;17141.742873856903;17160.200475230205;17556.824431755773;17569.824301757075;776.9611519424119;839.9160083991552;870.8214815962713;903.1826197291462;995.4077323992213;9276.768080798034;9672.806543869083;9692;9704.835419749534;9714.854277185848;510913;515993;529117;529946;532712;80476.59761701155;80958.19041809624;80998;81803;82942.58528707318;1072.7693545887516;1083.3662307550014;1084.5553323137476;1086.576235268246;1102.2669924500278;15365.923170384076;15624.531264062096;15625.76561351558;15743;16012;35710.64289357177;35816;35839.46240806338;36781.26437471289;36917.815410922776;45871.541284586725;46447.65851926937;46656.53343466658;47678;48357.75821120872;8799.824003520022;8916.420432671855;8960.462372257685;9143.268538517035;9400.200982916529;10494.580216791548;10538;10630.893691062991;11247.831282530933;17404.912975435043;14719.116852988855;14857.628559286104;14959.626009349418;15112.110986126734;15443.61390965235;13585.796213056614;13871.653208669864;14320.57038288853;15011;15174.165420901956;12075.939620301842;14010.719785604435;14051.156930584199;14364.856351436352;14530.273486325852;7873.25204105609;8903.688370906988;9408.576614052521;9697.854532182164;9706.272029597949;14002;14326.785098223327;14332.426702931765;14734.484293049692;14785.92607037001 19:26:22 INFO - PROCESS | 14246 | |3;mootools.html;1259.6724851538597;1448.8768454681351;1450.2241300904016;1599.1764241415674;1782.313809183464;6779.728810847566;7415.851682966338;7510.8122296942465;7524.473286869915;7550.924490755091;7404.259574042607;7473.177950425449;7581.620918954058;7581.734639287626;7585.544867307965;1800.8019117897086;1827.5887925216853;1829.6706592813289;2220.455988282873;2271.0575111328862;1899.5061284066105;2227.7438094619165;2269.500709843832;2272.9545409091807;2276.5333106713083;2132.722746043012;2134.647783115784;2149.720536330275;2243.921462748804;2252.0653928619604;2201.0755482697305;2211.9115235390564;2218.7781221877685;2223.3107736601705;2223.5108276179217;2239.6304609739373;2257.7516473187934;2259.9548009039727;2262.7963483286417;2265.1166045242203;7392.6303684816085;7442.925570744277;7446.069241344832;7467.215942326032;7506.474546781727;4572.222722137211;4619.076184763027;4623.375844261015;4628.560286772751;4658.068386322749;2832.886684532616;2878.6977367376335;2965.5551667250083;2970.019893435161;2985.8656360463833;867.2628265973872;875.65411662393;885.490842765406;897.9775505612347;907;10435.060844524029;10442.477876106164;10447.477626118663;10448;10472.16222702182;4230.090530535949;4251.80866860992;4291.506476755213;4293.3989241506215;4296.548862369469;8989.955050224838;9016.774580635536;9020.8646870297;9024.593893274818;9062.275017998545;4730.787114579852;4735.857924262209;4737.763111844463;4738;4742.786574604151;4225.091605304874;4291.9785401072795;4293.914121717548;4296.419983302277;4296.806643701041;3318.1206980149796;3370.224848284859;3683.318586061587;3688.0779805048737;3738.43923411485;1173.8767429419959;1188.6671731915078;1201.501376928565;1211.6546784166471;1213.9028877689764;916.486767410239;927.5779520318239;928.2527565309855;993.6621548673486;1010.2271762101998;6932.792016239521;6992.545484543489;6998.895016574756;6999.405050570758;7002.649867506706;1059.9400599400599;1080.4651697409834;1083.2471432354596;1101.6639924823005;1123.5786580032488;5603.551715862721;5641.8589535261945;5725.942740572541;5751.1373294006235;5766.279215098113;8889.822203556021;9169;9191.448513089235;9312.72061838146;9317.627294908129;8911.37620366581;9107.681231156877;9147.634094636272;9149.268058555299;9163.404378715362;7177;7186.892196617159;7237.819054523679;7259.382952449101;7259.9274007259255;6794.8641027180165;6863.588184708933;6886.827829304308;6924.4114250289285;6944.791656250321;8003.07964584057;8175.059868115005;8262.710805122033;8274.213949674771;8327.708530201415;8398.748037558884;8514.829703406022;8514.91485085166;8523.48859068458;8544.74365769028;6678.432333251728;6712.83217919556;6741.797746067626;6743.763968261087;6744.460443164437;6404.775832845828;6423.164988551645;7111.573305601681;7450.552966822008;7504.249575042452;6572.244191917799;6673.165854268216;6744.494162937701;6759.155105611799;6988.37104660583;6618.437432818265;6670.199576050905;6731.394174524316;6744.258131605421;6915.170179578483;6870.690818913261;6914.204866440223;6956.339147780953;6957.582545047313;6984.895226571707;6356.078368636614;6359.395857393725;6392.840178995562;6434.453071488976;6441.420272175526;6255.53083518747;6279.96860015697;6291.496680265659;6294.181756371642;6301.873962520815 19:26:22 INFO - PROCESS | 14246 | |4;prototype.html;330.1004762023486;335.356116256787;338.81703879904853;343.6546270997647;349.7656570098034;5866.706664666771;5871.266091738533;5897;5906.084556893683;5908.67502287374;5551.1118221084635;5633.887322253563;5734.4265573442635;5766;5821.476067153955;4516.1193567254395;4525.864224073283;4539.273716205408;4543.522930092342;4553.180427523044;4328.826846926119;4554.70394424363;4555.362249285103;4556.088782243548;4558.133954548642;4364.410804541394;4371.278739008076;4462.509123996358;4478.664100192483;4482.058767658796;4452.131834292314;4462.3752674625575;4463.977680111611;4465.888352791174;4470.061287129674;3944.8422063117728;3945.1517923646265;3960.4653371794725;3965.405189221611;3965.7620542767527;5389.164679474648;5520.475554822286;5560.443955604448;5562.443755624405;5566.304211973504;5228.9738551307;5236.476352364771;5236.743181636418;5243.292155559027;5245.344331958505;6161.876762464725;6168;6179.258488981351;6180.721867515927;6183.443490085869;4395.12097580482;4396.120775844844;4400.031992961543;4404.22925987954;4404.889877753049;6334.144890439778;6476.125723027425;6478.319776423455;6478.643674597895;6483.935160648428;4525.366448697185;4528.071745292207;4528.320751887178;4529.116822219636;4542.727436353829;4586.839460618862;4588.472325682589;4593.28804035375;4593.770311484413;4597.4712908015335;5230.581553475713;5241.0828105081455;5241.606879484054;5245.554127899171;5246.31797866275;6043.516518678495;6240.7503699852405;6244.65654389013;6247.406496382836;6253.468455181361;1612.6774645071032;1628.080134723877;1629.983700163007;1631.6573519561025;1633.4854520825902;1101.9889801102047;1109.866815982071;1119.2109562758235;1119.972000699989;1127.0983213429224;5952.880942381128;5956.195913551615;5964.582479226413;5966.6121702090095;5970.58205925581;6386.786510562978;6407.13503677007;6411.0383442484;6413.262474815456;6432.678366081677;5782.248307720053;5845.09401042839;5963.135345374896;5998.280206375263;6029.427204415573;3477.8870761356125;3494.4583589543663;3500.1599616091953;3500.7724497907557;3501.9319107672404;6762.391384775394;6770.898436523456;6771.966140169267;6772.0857684212;6774.932250677529;6515.187801859993;6592.30780768022;6618.7021584028835;6637.203535575762;6648.66756662165;6760.087388202628;6762.188537375448;6765.898511522331;6768.526203165829;6781.898271525931;6421.229452465734;6433.5496515243485;6439.195100612424;6443.871122577616;6452.806415807533;6275.34108918557;6368.96815515938;6387.744490220525;6407.295197528175;6417.0695249187675;6742.5280230383405;6747.966260168668;6750.898736518858;6758.3917447428;6767.966160169168;4493.91012179748;4505.684602077954;4506.166359223423;4512.729236245836;4513;6294.968525157345;6461.224653041665;6471.158749362553;6509.381608747351;6518.543701940818;6279.1209230708655;6291.213598300213;6315.621062736251;6324.841878953063;6344.968275158594;6248.4688801452385;6269.49844012487;6274.121622972879;6274.933261345491;6276.874462510633;6093.512518998381;6186.1030150627;6206.534509911865;6216.627002379872;6216.689165541795;6336.239651241881;6337.04944258365;6346.428821405911;6347.746090156342;6348.746050157942;6207.6275423474735;6208.0998255253635;6208.534359922934;6213.378662133931;6215.627062376272 19:26:22 INFO - PROCESS | 14246 | |5;yui.html;768.746313716474;779.6335722210559;814.3688641302989;821.6015232612182;836.1346006882876;12670;12761.872381276184;12926.806097908539;12930.741385172314;12964.092513524058;11800.350980696057;11830.290182589051;11846.940765296184;12098.75802483952;12287.508499660025;688.0711040095856;818.7953011747063;831.9833603327929;833.9666413343459;834.1241696218976;680.5916450129932;823.7652269103306;829.9087100418949;831.3183189784379;833.8707500337457;846.289117141601;875.3916028360292;875.4003507597284;875.6016012714232;875.6409871952501;715.4705517916756;717.6985666020284;852.416094974938;861.8836457078277;867.7179916527123;633.3191818794814;634.4892361648871;636.096742625473;637.0444333499751;637.158950185755;12230.082743794252;12269.754604907852;12374.75250494985;12378.133530652858;12412;11298;11945.104117191158;12028.819567706492;12091.879081209163;12337.383130843422;9479.289053321028;9820.607175712963;10032.94983525085;10290.485475726184;10426.374417534897;3372.207531230159;3459.290845376717;3495.73781966351;3501.684848363634;3511.3504001759757;44511.33233001507;44631.10737785226;44691;44845;44856;9252.629894804133;9540.95229523848;9573.760655983517;9832.754181145385;10552.41961692099;17204.65590688179;17254.913725431292;17300.567485812702;17311.134443277784;17313.39403120885;7386.409087273005;7463.328300452985;7731.729389471454;7778.377729781604;7808;3887.7278590498395;3971.4042893566198;3984.780837053932;4017.216642754635;4164.583541645872;2840.0485837244755;2866.1258316213757;2873.5689646552764;2873.956890646642;2881;527.5594878276605;530.6285600079959;545.8580769000009;548.4077196627633;552.9225908372831;538.8437353167616;624.1844172211411;640.8301800022998;664.2062735031687;679.6873438218474;7497.475176737576;7819.882701759479;7952.403569732293;8064.314533264621;8170.714025009096;517.3429744224813;527.9260903473516;532.379777559147;603.7192705392014;676.202081543783;3655;3664.780113193217;3905.33609286422;4101.323281658493;4305.375720520569;48361;49285.26072108921;50070.74964625226;56658;56707.149392759144;50874;51389.486105139214;51727.74136129295;52003.47996520062;52056.21915671268;45714.54285457169;46918.765406173436;46941;46946;47284.7635761819;8460.153984601491;8467.66129354819;8491.74524764258;8551.230389264996;8652.524111173945;33918;34388.312233755685;34804.47793283052;34968;35013.29973400569;43366.566334336254;46207.76896115498;46365.304520432896;46901.29648055213;47613.52386476091;10881.891181088087;10883.836742448711;11166.44167791591;11271.211015228855;11304.943475282571;11921.701957451132;12022.75954480923;12255.693607659523;12270.509179632714;12293.93853030729;10683.145348371956;10906.236563440483;11177.72055698614;11285.589301337333;11451.885481145082;10921.945390273315;11204.551817927191;11217.66347009591;11624;11656.06751459898;7126.608036558039;9064.864027039732;10993.725156871142;11185.32888026721;11238.775224495628;9403.952980235055;9455.24358051368;9486.478243696663;9953.402795832273;10228.232882533988;9359.625614975324;9453.716388508356;9597.088276613711;9621.120455711178;9734.464604446823 19:26:22 INFO - PROCESS | 14246 | __end_tp_report 19:26:22 INFO - PROCESS | 14246 | __start_cc_report 19:26:22 INFO - PROCESS | 14246 | _x_x_mozilla_cycle_collect,1439 19:26:22 INFO - PROCESS | 14246 | __end_cc_report 19:26:22 INFO - PROCESS | 14246 | __startTimestamp1452223582206__endTimestamp 19:26:22 INFO - PROCESS | 14246 | 19:26:22 INFO - PROCESS | 14246 | ------- Summary: start ------- 19:26:22 INFO - PROCESS | 14246 | Number of tests: 6 19:26:22 INFO - PROCESS | 14246 | 19:26:22 INFO - PROCESS | 14246 | [#0] dojo.html Cycles:165 Average:5160.22 Median:5340.73 stddev:540.78 (10.1%) stddev-sans-first:518.69 19:26:22 INFO - PROCESS | 14246 | Values: 3139.7 3172.2 3208.1 3212.5 3229.6 4991.4 5056.6 5219.9 5251.3 5308.4 5070.8 5080.5 5161.2 5237.2 5255.5 4705.5 4770.8 4781.4 4783.9 4896.3 4736.6 4826.4 4834.8 4874.4 4876.9 4670.7 4779.0 4784.9 4834.4 4854.8 4693.2 4768.5 4809.7 4811.8 4826.0 4726.6 4730.4 4732.6 4740.7 4765.0 4856.4 4971.0 5008.5 5013.9 5062.1 5462.9 5468.8 5469.9 5480.7 5578.6 5564.3 5572.6 5573.3 5574.3 5577.4 5068.4 5195.5 5196.2 5201.1 5233.8 5583.2 5602.9 5682.2 5771.5 5802.5 5483.0 5483.6 5494.2 5499.6 5510.7 5422.6 5569.5 5581.4 5597.7 5599.7 5430.8 5444.7 5462.7 5508.4 5539.6 5534.7 5537.0 5539.7 5541.2 5555.0 4246.3 4338.3 4345.8 4348.5 4373.3 3884.1 3898.1 3931.3 3932.7 3968.1 5176.1 5180.6 5186.5 5187.8 5188.2 5316.5 5393.7 5523.9 5527.9 5584.4 5163.6 5167.6 5216.6 5221.8 5278.5 4743.3 4752.3 4755.5 4763.0 4791.4 5642.0 5709.5 5709.7 5728.9 5781.0 5363.0 5544.9 5610.7 5613.7 5671.0 5751.9 5759.8 5763.7 5770.7 5773.3 5387.0 5490.6 5494.7 5498.1 5510.1 5477.9 5521.5 5526.3 5545.0 5546.1 5411.6 5441.3 5442.7 5466.9 5473.9 5409.0 5414.4 5417.2 5422.8 5423.7 5321.2 5329.1 5337.0 5351.1 5384.0 5333.4 5405.8 5428.5 5434.7 5451.5 5279.7 5328.7 5340.7 5344.1 5348.4 19:26:22 INFO - PROCESS | 14246 | 19:26:22 INFO - PROCESS | 14246 | [#1] ext.html Cycles:180 Average:41192.06 Median:33693.83 stddev:65906.14 (195.6%) stddev-sans-first:66020.27 19:26:22 INFO - PROCESS | 14246 | Values: 520.9 548.6 577.7 592.2 599.7 27821.3 35511.0 35989.3 36076.0 36110.0 38793.0 39167.6 39229.2 39232.0 39284.0 5788.1 5807.4 8386.3 8557.1 8564.4 9985.0 10148.3 10156.9 10160.0 10164.2 9859.9 9952.1 9954.6 9960.3 9966.2 7572.4 7680.1 9965.2 9977.0 10232.2 9740.3 9830.8 9873.4 9881.1 9887.2 34551.8 34722.5 34747.7 34872.0 34885.7 3004.7 3019.7 3155.4 3351.2 3552.5 29063.2 29345.7 29458.3 29543.3 29908.1 3607.4 3666.9 3731.8 3738.3 3791.5 192265.0 193708.0 193946.0 194016.0 194064.4 49737.5 50602.0 55376.0 55541.0 55921.5 51780.2 51835.5 51945.7 52052.7 52069.5 13896.2 13981.1 13986.0 14037.7 14044.4 10698.2 10730.0 10775.9 10787.0 10810.8 17545.8 18444.7 18505.5 18579.9 18591.0 7228.9 7460.3 7463.9 7509.9 7524.0 867.4 941.6 1097.8 1114.4 1124.7 27570.7 27719.2 28245.3 28324.3 28422.4 1002.9 1028.4 1044.2 1095.6 1113.4 14458.2 14695.6 14759.2 14958.9 15025.4 310725.0 313523.0 315898.0 316195.0 317497.0 49334.5 49498.3 49620.3 49673.0 49685.3 1282.0 1301.3 1310.4 1311.5 1319.5 22308.8 28318.9 29300.7 30530.8 31067.0 42617.4 43035.4 43180.8 43213.0 43234.8 232111.0 234591.0 234986.0 235186.0 235332.0 28634.6 29631.6 30011.0 30271.0 30277.2 38496.4 38719.0 38811.2 39071.8 39554.6 33769.8 34103.8 34205.0 34213.8 35136.3 27680.7 31631.2 33617.8 34358.3 36483.5 34113.0 34209.0 34855.0 35390.5 35428.0 29024.4 30783.0 31093.7 31256.2 31460.5 23887.4 24241.9 24259.3 24297.9 24512.5 19:26:22 INFO - PROCESS | 14246 | 19:26:22 INFO - PROCESS | 14246 | [#2] jquery.html Cycles:180 Average:28317.33 Median:20228.13 stddev:85610.00 (423.2%) stddev-sans-first:85824.40 19:26:22 INFO - PROCESS | 14246 | Values: 350.8 356.3 359.7 361.3 363.0 14246.9 14422.4 16383.8 16687.6 17357.3 16046.8 17181.2 17331.2 17502.6 17581.5 5399.0 5500.5 5534.5 5537.3 5537.5 3675.0 3755.6 5487.7 5523.2 5894.8 5959.2 5998.5 6011.2 6012.3 6017.2 5838.2 5967.6 5975.2 6022.1 6025.0 5362.2 5363.9 5392.1 5407.7 5408.6 20608.9 20999.7 21100.2 21223.6 21240.5 1934.4 1984.2 2019.5 2055.9 2127.7 9011.4 9396.8 12409.8 12447.5 13456.4 1688.7 1769.1 1809.9 1812.8 1815.3 54937.0 57199.0 57283.4 57335.7 58720.7 9767.0 9821.2 9936.4 9973.0 10038.9 12670.7 12676.1 12683.2 12684.2 12690.1 7396.0 7450.3 7459.8 7514.7 7523.8 7041.0 7098.1 7287.0 7368.4 7393.3 4417.6 4451.2 4461.3 4462.3 4478.4 1743.9 1758.8 1775.2 1791.5 1796.2 872.4 911.1 1001.1 1001.3 1031.6 16156.3 17141.7 17160.2 17556.8 17569.8 777.0 839.9 870.8 903.2 995.4 9276.8 9672.8 9692.0 9704.8 9714.9 510913.0 515993.0 529117.0 529946.0 532712.0 80476.6 80958.2 80998.0 81803.0 82942.6 1072.8 1083.4 1084.6 1086.6 1102.3 15365.9 15624.5 15625.8 15743.0 16012.0 35710.6 35816.0 35839.5 36781.3 36917.8 45871.5 46447.7 46656.5 47678.0 48357.8 8799.8 8916.4 8960.5 9143.3 9400.2 10494.6 10538.0 10630.9 11247.8 17404.9 14719.1 14857.6 14959.6 15112.1 15443.6 13585.8 13871.7 14320.6 15011.0 15174.2 12075.9 14010.7 14051.2 14364.9 14530.3 7873.3 8903.7 9408.6 9697.9 9706.3 14002.0 14326.8 14332.4 14734.5 14785.9 19:26:22 INFO - PROCESS | 14246 | 19:26:22 INFO - PROCESS | 14246 | [#3] mootools.html Cycles:180 Average:5312.46 Median:6428.81 stddev:2765.82 (43.0%) stddev-sans-first:2756.80 19:26:22 INFO - PROCESS | 14246 | Values: 1259.7 1448.9 1450.2 1599.2 1782.3 6779.7 7415.9 7510.8 7524.5 7550.9 7404.3 7473.2 7581.6 7581.7 7585.5 1800.8 1827.6 1829.7 2220.5 2271.1 1899.5 2227.7 2269.5 2273.0 2276.5 2132.7 2134.6 2149.7 2243.9 2252.1 2201.1 2211.9 2218.8 2223.3 2223.5 2239.6 2257.8 2260.0 2262.8 2265.1 7392.6 7442.9 7446.1 7467.2 7506.5 4572.2 4619.1 4623.4 4628.6 4658.1 2832.9 2878.7 2965.6 2970.0 2985.9 867.3 875.7 885.5 898.0 907.0 10435.1 10442.5 10447.5 10448.0 10472.2 4230.1 4251.8 4291.5 4293.4 4296.5 8990.0 9016.8 9020.9 9024.6 9062.3 4730.8 4735.9 4737.8 4738.0 4742.8 4225.1 4292.0 4293.9 4296.4 4296.8 3318.1 3370.2 3683.3 3688.1 3738.4 1173.9 1188.7 1201.5 1211.7 1213.9 916.5 927.6 928.3 993.7 1010.2 6932.8 6992.5 6998.9 6999.4 7002.6 1059.9 1080.5 1083.2 1101.7 1123.6 5603.6 5641.9 5725.9 5751.1 5766.3 8889.8 9169.0 9191.4 9312.7 9317.6 8911.4 9107.7 9147.6 9149.3 9163.4 7177.0 7186.9 7237.8 7259.4 7259.9 6794.9 6863.6 6886.8 6924.4 6944.8 8003.1 8175.1 8262.7 8274.2 8327.7 8398.7 8514.8 8514.9 8523.5 8544.7 6678.4 6712.8 6741.8 6743.8 6744.5 6404.8 6423.2 7111.6 7450.6 7504.2 6572.2 6673.2 6744.5 6759.2 6988.4 6618.4 6670.2 6731.4 6744.3 6915.2 6870.7 6914.2 6956.3 6957.6 6984.9 6356.1 6359.4 6392.8 6434.5 6441.4 6255.5 6280.0 6291.5 6294.2 6301.9 19:26:22 INFO - PROCESS | 14246 | 19:26:22 INFO - PROCESS | 14246 | [#4] prototype.html Cycles:180 Average:5241.48 Median:5907.38 stddev:1566.82 (26.5%) stddev-sans-first:1527.23 19:26:22 INFO - PROCESS | 14246 | Values: 330.1 335.4 338.8 343.7 349.8 5866.7 5871.3 5897.0 5906.1 5908.7 5551.1 5633.9 5734.4 5766.0 5821.5 4516.1 4525.9 4539.3 4543.5 4553.2 4328.8 4554.7 4555.4 4556.1 4558.1 4364.4 4371.3 4462.5 4478.7 4482.1 4452.1 4462.4 4464.0 4465.9 4470.1 3944.8 3945.2 3960.5 3965.4 3965.8 5389.2 5520.5 5560.4 5562.4 5566.3 5229.0 5236.5 5236.7 5243.3 5245.3 6161.9 6168.0 6179.3 6180.7 6183.4 4395.1 4396.1 4400.0 4404.2 4404.9 6334.1 6476.1 6478.3 6478.6 6483.9 4525.4 4528.1 4528.3 4529.1 4542.7 4586.8 4588.5 4593.3 4593.8 4597.5 5230.6 5241.1 5241.6 5245.6 5246.3 6043.5 6240.8 6244.7 6247.4 6253.5 1612.7 1628.1 1630.0 1631.7 1633.5 1102.0 1109.9 1119.2 1120.0 1127.1 5952.9 5956.2 5964.6 5966.6 5970.6 6386.8 6407.1 6411.0 6413.3 6432.7 5782.2 5845.1 5963.1 5998.3 6029.4 3477.9 3494.5 3500.2 3500.8 3501.9 6762.4 6770.9 6772.0 6772.1 6774.9 6515.2 6592.3 6618.7 6637.2 6648.7 6760.1 6762.2 6765.9 6768.5 6781.9 6421.2 6433.5 6439.2 6443.9 6452.8 6275.3 6369.0 6387.7 6407.3 6417.1 6742.5 6748.0 6750.9 6758.4 6768.0 4493.9 4505.7 4506.2 4512.7 4513.0 6295.0 6461.2 6471.2 6509.4 6518.5 6279.1 6291.2 6315.6 6324.8 6345.0 6248.5 6269.5 6274.1 6274.9 6276.9 6093.5 6186.1 6206.5 6216.6 6216.7 6336.2 6337.0 6346.4 6347.7 6348.7 6207.6 6208.1 6208.5 6213.4 6215.6 19:26:22 INFO - PROCESS | 14246 | 19:26:22 INFO - PROCESS | 14246 | [#5] yui.html Cycles:180 Average:13382.79 Median:47115.38 stddev:15520.53 (32.9%) stddev-sans-first:15535.16 19:26:22 INFO - PROCESS | 14246 | Values: 768.7 779.6 814.4 821.6 836.1 12670.0 12761.9 12926.8 12930.7 12964.1 11800.4 11830.3 11846.9 12098.8 12287.5 688.1 818.8 832.0 834.0 834.1 680.6 823.8 829.9 831.3 833.9 846.3 875.4 875.4 875.6 875.6 715.5 717.7 852.4 861.9 867.7 633.3 634.5 636.1 637.0 637.2 12230.1 12269.8 12374.8 12378.1 12412.0 11298.0 11945.1 12028.8 12091.9 12337.4 9479.3 9820.6 10032.9 10290.5 10426.4 3372.2 3459.3 3495.7 3501.7 3511.4 44511.3 44631.1 44691.0 44845.0 44856.0 9252.6 9541.0 9573.8 9832.8 10552.4 17204.7 17254.9 17300.6 17311.1 17313.4 7386.4 7463.3 7731.7 7778.4 7808.0 3887.7 3971.4 3984.8 4017.2 4164.6 2840.0 2866.1 2873.6 2874.0 2881.0 527.6 530.6 545.9 548.4 552.9 538.8 624.2 640.8 664.2 679.7 7497.5 7819.9 7952.4 8064.3 8170.7 517.3 527.9 532.4 603.7 676.2 3655.0 3664.8 3905.3 4101.3 4305.4 48361.0 49285.3 50070.7 56658.0 56707.1 50874.0 51389.5 51727.7 52003.5 52056.2 45714.5 46918.8 46941.0 46946.0 47284.8 8460.2 8467.7 8491.7 8551.2 8652.5 33918.0 34388.3 34804.5 34968.0 35013.3 43366.6 46207.8 46365.3 46901.3 47613.5 10881.9 10883.8 11166.4 11271.2 11304.9 11921.7 12022.8 12255.7 12270.5 12293.9 10683.1 10906.2 11177.7 11285.6 11451.9 10921.9 11204.6 11217.7 11624.0 11656.1 7126.6 9064.9 10993.7 11185.3 11238.8 9404.0 9455.2 9486.5 9953.4 10228.2 9359.6 9453.7 9597.1 9621.1 9734.5 19:26:22 INFO - PROCESS | 14246 | -------- Summary: end -------- 19:26:22 INFO - PROCESS | 14246 | 19:26:22 INFO - TEST-INFO | 14246: exit 0 19:26:22 INFO - TEST-OK | dromaeo_css | took 1113773ms 19:26:22 INFO - TEST-START | kraken 19:26:22 INFO - operating with platform_type : linux_ 19:26:22 INFO - Initialising browser for kraken test... 19:26:22 INFO - TEST-INFO | started process 14444 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaMnBNI/profile http://localhost:57958/getInfo.html) 19:26:27 INFO - PROCESS | 14444 | __metrics Screen width/height:1600/1200 19:26:27 INFO - PROCESS | 14444 | colorDepth:24 19:26:27 INFO - PROCESS | 14444 | Browser inner width/height: 1024/697 19:26:27 INFO - PROCESS | 14444 | __metrics 19:26:27 INFO - PROCESS | 14444 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:26:27 INFO - PROCESS | 14444 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:26:28 INFO - TEST-INFO | 14444: exit 0 19:26:28 INFO - Browser initialized. 19:26:28 INFO - Running cycle 1/1 for kraken test... 19:26:28 INFO - TEST-INFO | started process 14532 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaMnBNI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:26:40 INFO - PROCESS | 14532 | RSS: Main: 149917696 19:26:40 INFO - PROCESS | 14532 | 19:26:42 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57958/tests/kraken/driver.html?testName=audio-beat-detection) 19:26:43 INFO - PROCESS | 14532 | RSS: Main: 187363328 19:26:43 INFO - PROCESS | 14532 | 19:26:45 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57958/tests/kraken/driver.html?testName=audio-dft) 19:26:46 INFO - PROCESS | 14532 | RSS: Main: 177881088 19:26:46 INFO - PROCESS | 14532 | 19:26:49 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57958/tests/kraken/driver.html?testName=audio-fft) 19:26:49 INFO - PROCESS | 14532 | RSS: Main: 160395264 19:26:49 INFO - PROCESS | 14532 | 19:26:51 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57958/tests/kraken/driver.html?testName=audio-oscillator) 19:26:52 INFO - PROCESS | 14532 | RSS: Main: 163966976 19:26:52 INFO - PROCESS | 14532 | 19:26:54 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57958/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:26:55 INFO - PROCESS | 14532 | RSS: Main: 165613568 19:26:55 INFO - PROCESS | 14532 | 19:26:58 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57958/tests/kraken/driver.html?testName=imaging-darkroom) 19:26:58 INFO - PROCESS | 14532 | RSS: Main: 166031360 19:26:58 INFO - PROCESS | 14532 | 19:27:02 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57958/tests/kraken/driver.html?testName=imaging-desaturate) 19:27:02 INFO - PROCESS | 14532 | RSS: Main: 167075840 19:27:02 INFO - PROCESS | 14532 | 19:27:05 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57958/tests/kraken/driver.html?testName=json-parse-financial) 19:27:05 INFO - PROCESS | 14532 | RSS: Main: 165691392 19:27:05 INFO - PROCESS | 14532 | 19:27:07 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57958/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:27:08 INFO - PROCESS | 14532 | RSS: Main: 179052544 19:27:08 INFO - PROCESS | 14532 | 19:27:09 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57958/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:27:10 INFO - PROCESS | 14532 | RSS: Main: 174366720 19:27:10 INFO - PROCESS | 14532 | 19:27:12 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57958/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:27:13 INFO - PROCESS | 14532 | RSS: Main: 181678080 19:27:13 INFO - PROCESS | 14532 | 19:27:15 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:27:16 INFO - PROCESS | 14532 | RSS: Main: 190398464 19:27:16 INFO - PROCESS | 14532 | 19:27:18 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:27:19 INFO - PROCESS | 14532 | RSS: Main: 188145664 19:27:19 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | Cycle 1(1): loaded http://localhost:57958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57958/tests/kraken/driver.html?testName=ai-astar) 19:27:21 INFO - PROCESS | 14532 | RSS: Main: 246444032 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | __start_tp_report 19:27:21 INFO - PROCESS | 14532 | _x_x_mozilla_page_load 19:27:21 INFO - PROCESS | 14532 | _x_x_mozilla_page_load_details 19:27:21 INFO - PROCESS | 14532 | |i|pagename|runs| 19:27:21 INFO - PROCESS | 14532 | |0;ai-astar;110;113;105;111;111;112;99;111;110;111 19:27:21 INFO - PROCESS | 14532 | |1;audio-beat-detection;159;137;149;174;130;157;161;127;175;126 19:27:21 INFO - PROCESS | 14532 | |2;audio-dft;161;161;160;160;160;160;160;162;161;162 19:27:21 INFO - PROCESS | 14532 | |3;audio-fft;71;71;86;96;71;71;71;100;93;71 19:27:21 INFO - PROCESS | 14532 | |4;audio-oscillator;105;97;148;96;96;96;142;96;97;141 19:27:21 INFO - PROCESS | 14532 | |5;imaging-gaussian-blur;110;109;109;109;109;110;109;109;109;109 19:27:21 INFO - PROCESS | 14532 | |6;imaging-darkroom;145;145;145;146;146;146;145;146;145;148 19:27:21 INFO - PROCESS | 14532 | |7;imaging-desaturate;96;96;96;96;96;96;96;97;97;95 19:27:21 INFO - PROCESS | 14532 | |8;json-parse-financial;56;59;60;59;60;57;57;57;57;54 19:27:21 INFO - PROCESS | 14532 | |9;json-stringify-tinderbox;66;67;66;67;68;71;67;67;68;68 19:27:21 INFO - PROCESS | 14532 | |10;stanford-crypto-aes;85;86;86;85;85;85;86;88;85;86 19:27:21 INFO - PROCESS | 14532 | |11;stanford-crypto-ccm;117;115;118;115;121;118;119;120;121;124 19:27:21 INFO - PROCESS | 14532 | |12;stanford-crypto-pbkdf2;143;142;156;152;159;141;151;152;151;140 19:27:21 INFO - PROCESS | 14532 | |13;stanford-crypto-sha256-iterative;67;69;71;70;68;68;69;82;68;67 19:27:21 INFO - PROCESS | 14532 | __end_tp_report 19:27:21 INFO - PROCESS | 14532 | __start_cc_report 19:27:21 INFO - PROCESS | 14532 | _x_x_mozilla_cycle_collect,953 19:27:21 INFO - PROCESS | 14532 | __end_cc_report 19:27:21 INFO - PROCESS | 14532 | __startTimestamp1452223641266__endTimestamp 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | ------- Summary: start ------- 19:27:21 INFO - PROCESS | 14532 | Number of tests: 14 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:4.19 (3.8%) stddev-sans-first:4.44 19:27:21 INFO - PROCESS | 14532 | Values: 110.0 113.0 105.0 111.0 111.0 112.0 99.0 111.0 110.0 111.0 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:158.00 stddev:18.63 (11.8%) stddev-sans-first:19.44 19:27:21 INFO - PROCESS | 14532 | Values: 159.0 137.0 149.0 174.0 130.0 157.0 161.0 127.0 175.0 126.0 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 19:27:21 INFO - PROCESS | 14532 | Values: 161.0 161.0 160.0 160.0 160.0 160.0 160.0 162.0 161.0 162.0 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#3] audio-fft Cycles:10 Average:80.10 Median:71.00 stddev:12.23 (17.2%) stddev-sans-first:12.52 19:27:21 INFO - PROCESS | 14532 | Values: 71.0 71.0 86.0 96.0 71.0 71.0 71.0 100.0 93.0 71.0 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#4] audio-oscillator Cycles:10 Average:111.40 Median:96.00 stddev:22.50 (23.4%) stddev-sans-first:23.75 19:27:21 INFO - PROCESS | 14532 | Values: 105.0 97.0 148.0 96.0 96.0 96.0 142.0 96.0 97.0 141.0 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 19:27:21 INFO - PROCESS | 14532 | Values: 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 19:27:21 INFO - PROCESS | 14532 | Values: 145.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 148.0 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 19:27:21 INFO - PROCESS | 14532 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 95.0 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.90 (3.3%) stddev-sans-first:1.92 19:27:21 INFO - PROCESS | 14532 | Values: 56.0 59.0 60.0 59.0 60.0 57.0 57.0 57.0 57.0 54.0 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:1.43 (2.1%) stddev-sans-first:1.41 19:27:21 INFO - PROCESS | 14532 | Values: 66.0 67.0 66.0 67.0 68.0 71.0 67.0 67.0 68.0 68.0 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:0.95 (1.1%) stddev-sans-first:0.97 19:27:21 INFO - PROCESS | 14532 | Values: 85.0 86.0 86.0 85.0 85.0 85.0 86.0 88.0 85.0 86.0 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:119.50 stddev:2.82 (2.4%) stddev-sans-first:2.92 19:27:21 INFO - PROCESS | 14532 | Values: 117.0 115.0 118.0 115.0 121.0 118.0 119.0 120.0 121.0 124.0 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:151.50 stddev:6.70 (4.4%) stddev-sans-first:6.78 19:27:21 INFO - PROCESS | 14532 | Values: 143.0 142.0 156.0 152.0 159.0 141.0 151.0 152.0 151.0 140.0 19:27:21 INFO - PROCESS | 14532 | 19:27:21 INFO - PROCESS | 14532 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.00 stddev:4.43 (6.4%) stddev-sans-first:4.58 19:27:21 INFO - PROCESS | 14532 | Values: 67.0 69.0 71.0 70.0 68.0 68.0 69.0 82.0 68.0 67.0 19:27:21 INFO - PROCESS | 14532 | -------- Summary: end -------- 19:27:21 INFO - PROCESS | 14532 | 19:27:22 INFO - TEST-INFO | 14532: exit 0 19:27:22 INFO - TEST-OK | kraken | took 59229ms 19:27:22 INFO - TEST-START | v8_7 19:27:22 INFO - operating with platform_type : linux_ 19:27:22 INFO - Initialising browser for v8_7 test... 19:27:22 INFO - TEST-INFO | started process 14780 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzSwAG9/profile http://localhost:57958/getInfo.html) 19:27:26 INFO - PROCESS | 14780 | __metrics Screen width/height:1600/1200 19:27:26 INFO - PROCESS | 14780 | colorDepth:24 19:27:26 INFO - PROCESS | 14780 | Browser inner width/height: 1024/697 19:27:26 INFO - PROCESS | 14780 | __metrics 19:27:26 INFO - PROCESS | 14780 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:27:26 INFO - PROCESS | 14780 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:27:27 INFO - TEST-INFO | 14780: exit 0 19:27:27 INFO - Browser initialized. 19:27:27 INFO - Running cycle 1/1 for v8_7 test... 19:27:27 INFO - TEST-INFO | started process 14862 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzSwAG9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:39 INFO - PROCESS | 14862 | RSS: Main: 150556672 19:27:39 INFO - PROCESS | 14862 | 19:28:00 INFO - PROCESS | 14862 | Cycle 1(1): loaded http://localhost:57958/tests/v8_7/run.html (next: http://localhost:57958/tests/v8_7/run.html) 19:28:01 INFO - PROCESS | 14862 | RSS: Main: 599887872 19:28:01 INFO - PROCESS | 14862 | 19:28:01 INFO - PROCESS | 14862 | __start_tp_report 19:28:01 INFO - PROCESS | 14862 | _x_x_mozilla_page_load 19:28:01 INFO - PROCESS | 14862 | _x_x_mozilla_page_load_details 19:28:01 INFO - PROCESS | 14862 | |i|pagename|runs| 19:28:01 INFO - PROCESS | 14862 | |0;Richards;166.75004168751042 19:28:01 INFO - PROCESS | 14862 | |1;DeltaBlue;190.07793195210036 19:28:01 INFO - PROCESS | 14862 | |2;Encrypt;281.928390188892 19:28:01 INFO - PROCESS | 14862 | |3;Decrypt;5186.5284974093265 19:28:01 INFO - PROCESS | 14862 | |4;RayTrace;1104.9723756906078 19:28:01 INFO - PROCESS | 14862 | |5;Earley;785.5459544383347 19:28:01 INFO - PROCESS | 14862 | |6;Boyer;12168.674698795181 19:28:01 INFO - PROCESS | 14862 | |7;RegExp;26230.76923076923 19:28:01 INFO - PROCESS | 14862 | |8;Splay;649.772579597141 19:28:01 INFO - PROCESS | 14862 | |9;NavierStokes;4826.923076923077 19:28:01 INFO - PROCESS | 14862 | __end_tp_report 19:28:01 INFO - PROCESS | 14862 | __startTimestamp1452223681135__endTimestamp 19:28:01 INFO - PROCESS | 14862 | 19:28:01 INFO - PROCESS | 14862 | ------- Summary: start ------- 19:28:01 INFO - PROCESS | 14862 | Number of tests: 10 19:28:01 INFO - PROCESS | 14862 | 19:28:01 INFO - PROCESS | 14862 | [#0] Richards Cycles:1 Average:166.75 Median:166.75 stddev:0.00 (0.0%) 19:28:01 INFO - PROCESS | 14862 | Values: 166.8 19:28:01 INFO - PROCESS | 14862 | 19:28:01 INFO - PROCESS | 14862 | [#1] DeltaBlue Cycles:1 Average:190.08 Median:190.08 stddev:0.00 (0.0%) 19:28:01 INFO - PROCESS | 14862 | Values: 190.1 19:28:01 INFO - PROCESS | 14862 | 19:28:01 INFO - PROCESS | 14862 | [#2] Encrypt Cycles:1 Average:281.93 Median:281.93 stddev:0.00 (0.0%) 19:28:01 INFO - PROCESS | 14862 | Values: 281.9 19:28:01 INFO - PROCESS | 14862 | 19:28:01 INFO - PROCESS | 14862 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 19:28:01 INFO - PROCESS | 14862 | Values: 5186.5 19:28:01 INFO - PROCESS | 14862 | 19:28:01 INFO - PROCESS | 14862 | [#4] RayTrace Cycles:1 Average:1104.97 Median:1104.97 stddev:0.00 (0.0%) 19:28:01 INFO - PROCESS | 14862 | Values: 1105.0 19:28:01 INFO - PROCESS | 14862 | 19:28:01 INFO - PROCESS | 14862 | [#5] Earley Cycles:1 Average:785.55 Median:785.55 stddev:0.00 (0.0%) 19:28:01 INFO - PROCESS | 14862 | Values: 785.5 19:28:01 INFO - PROCESS | 14862 | 19:28:01 INFO - PROCESS | 14862 | [#6] Boyer Cycles:1 Average:12168.67 Median:12168.67 stddev:0.00 (0.0%) 19:28:01 INFO - PROCESS | 14862 | Values: 12168.7 19:28:01 INFO - PROCESS | 14862 | 19:28:01 INFO - PROCESS | 14862 | [#7] RegExp Cycles:1 Average:26230.77 Median:26230.77 stddev:0.00 (0.0%) 19:28:01 INFO - PROCESS | 14862 | Values: 26230.8 19:28:01 INFO - PROCESS | 14862 | 19:28:01 INFO - PROCESS | 14862 | [#8] Splay Cycles:1 Average:649.77 Median:649.77 stddev:0.00 (0.0%) 19:28:01 INFO - PROCESS | 14862 | Values: 649.8 19:28:01 INFO - PROCESS | 14862 | 19:28:01 INFO - PROCESS | 14862 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 19:28:01 INFO - PROCESS | 14862 | Values: 4826.9 19:28:01 INFO - PROCESS | 14862 | -------- Summary: end -------- 19:28:01 INFO - PROCESS | 14862 | 19:28:01 INFO - TEST-INFO | 14862: exit 0 19:28:01 INFO - TEST-OK | v8_7 | took 39732ms 19:28:01 INFO - SUITE-END | took 1212s 19:28:02 INFO - Completed test suite (00:20:12) 19:28:02 INFO - Working with test: dromaeo_css 19:28:02 INFO - Generating results file: dromaeo_css 19:28:02 INFO - Working with test: kraken 19:28:02 INFO - Generating results file: kraken 19:28:02 INFO - javascript benchmark 19:28:02 INFO - Working with test: v8_7 19:28:02 INFO - Generating results file: v8_7 19:28:02 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:28:02 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 19:28:02 INFO - process_Request line: dromaeo_css 6805.10 graph.html#tests=[[72,1,35]] 19:28:02 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:28:02 INFO - process_Request line: kraken 1510.20 graph.html#tests=[[232,1,35]] 19:28:02 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:28:02 INFO - process_Request line: v8_7 20844.13 graph.html#tests=[[230,1,35]] 19:28:02 INFO - RETURN: dromaeo_css: 6805.10 19:28:02 INFO - RETURN: kraken: 1510.20 19:28:02 INFO - RETURN: v8_7: 20844.13 19:28:02 INFO - javascript benchmark 19:28:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3139.733122684572, 3172.175234439045, 3208.149840292323, 3212.534182543531, 3229.580154579904, 4991.351124353838, 5056.595472362212, 5219.851632640818, 5251.317328747262, 5308.442613525582, 5070.847874563759, 5080.491950804918, 5161.225816127583, 5237.214417837326, 5255.474452554743, 4705.458872229686, 4770.809167633291, 4781.37842080529, 4783.856484305476, 4896.314515967767, 4736.573708366246, 4826.444958829727, 4834.782434790425, 4874.366332376786, 4876.853694389174, 4670.696404733681, 4778.976105119452, 4784.880377990543, 4834.371531700874, 4854.8300809471675, 4693.202155633517, 4768.523147685239, 4809.663323567352, 4811.831585894477, 4825.975870120662, 4726.550977657117, 4730.432348118248, 4732.597729193023, 4740.691855029447, 4765.046990601859, 4856.4172299323955, 4970.975145124251, 5008.499150084962, 5013.899722005576, 5062.1141300272675, 5462.918056229159, 5468.781248750045, 5469.863253418656, 5480.671159730429, 5578.581606379537, 5564.33228012637, 5572.637778544382, 5573.303337082864, 5574.275344205268, 5577.414371491016, 5068.366454193226, 5195.454477279907, 5196.168613021936, 5201.063808514466, 5233.842984710464, 5583.246261754611, 5602.85992850182, 5682.176084467729, 5771.538276937835, 5802.47777700009, 5483.040467918178, 5483.561315094783, 5494.203340515603, 5499.587530935196, 5510.669359838423, 5422.620416570802, 5569.470900264469, 5581.441855814467, 5597.720113994284, 5599.664020158803, 5430.782768689208, 5444.700541470257, 5462.672239665553, 5508.44915508454, 5539.556835453154, 5534.667919924736, 5537.0, 5539.695316757537, 5541.224228607998, 5554.972225138848, 4246.299360605465, 4338.327559228324, 4345.760983145894, 4348.478182618106, 4373.300271956536, 3884.0872394987155, 3898.142408670145, 3931.272714547818, 3932.7247092703237, 3968.1071758854605, 5176.068307704574, 5180.559652429586, 5186.455422180617, 5187.844364669066, 5188.169892817131, 5316.494932981361, 5393.7303134843105, 5523.944760552424, 5527.949689558971, 5584.357798853102, 5163.638545301868, 5167.638265321467, 5216.60875434344, 5221.765020574083, 5278.524932755993, 4743.264793956942, 4752.334673145762, 4755.476897541268, 4763.04739052191, 4791.401074865642, 5641.971790141105, 5709.514691251207, 5709.74306156224, 5728.856778580569, 5781.0, 5362.973185134049, 5544.916826247529, 5610.663360198401, 5613.691246981455, 5671.007573674673, 5751.884962300815, 5759.769609215585, 5763.7406316715005, 5770.740316685676, 5773.336066352424, 5387.003404370204, 5490.6431081979545, 5494.697791621499, 5498.120300752021, 5510.118381059172, 5477.890442191214, 5521.475459831309, 5526.281583394133, 5545.029619816597, 5546.140348246028, 5411.648242864201, 5441.319835020622, 5442.700651464207, 5466.863328416822, 5473.890522189454, 5409.0, 5414.404415514369, 5417.160340147283, 5422.783088676409, 5423.674579525241, 5321.228421878728, 5329.094054010905, 5336.973315133399, 5351.090314646597, 5383.973080134574, 5333.43998880112, 5405.78376864921, 5428.4842939920645, 5434.701091439851, 5451.48210919962, 5279.656822306538, 5328.70692111922, 5340.732963351895, 5344.091504444332, 5348.438413966477], "unit": "score", "name": "dojo.html", "value": 5127.466819173714}, {"lowerIsBetter": false, "replicates": [520.9088409528334, 548.6433818018285, 577.6505214345323, 592.2241863159262, 599.7481057955658, 27821.304467388327, 35511.0, 35989.280214395694, 36076.0, 36109.99999999996, 38793.0, 39167.60832391675, 39229.21541569174, 39232.0, 39284.0, 5788.131780232957, 5807.361190269067, 8386.329093672523, 8557.144285571456, 8564.357673174505, 9984.95007524965, 10148.340357876714, 10156.898431015707, 10160.0, 10164.237682173829, 9859.901400986006, 9952.054554817281, 9954.601815927354, 9960.302778805486, 9966.202703783716, 7572.356349710254, 7680.11678656956, 9965.202783777353, 9977.0, 10232.181425485944, 9740.269479789044, 9830.754231144207, 9873.40759554429, 9881.110700037032, 9887.159591434665, 34551.82724086389, 34722.479162812575, 34747.65252347495, 34872.0, 34885.651143488496, 3004.7145521175453, 3019.728224459809, 3155.4004739099496, 3351.1789611545328, 3552.520409744677, 29063.229048274094, 29345.706542934724, 29458.263543411373, 29543.26141846471, 29908.10275691711, 3607.350676878161, 3666.899930020983, 3731.81340932955, 3738.3084129436143, 3791.545014598266, 192265.0, 193708.03145984322, 193946.0, 194016.0, 194064.38581492158, 49737.50262497401, 50602.0, 55376.0, 55541.0, 55921.52627789767, 51780.22329665058, 51835.48164518382, 51945.74027129916, 52052.73973630183, 52069.47930520646, 13896.235707036009, 13981.091229070078, 13986.0, 14037.71924561503, 14044.438222470986, 10698.197635177392, 10730.0, 10775.946120269506, 10786.975237352439, 10810.783784324269, 17545.824541754675, 18444.723329150074, 18505.53736156607, 18579.90710046441, 18591.0, 7228.855422891513, 7460.291272329228, 7463.888041679379, 7509.9249007509225, 7524.0, 867.3711559119714, 941.6327632223438, 1097.7914196302677, 1114.4483480677118, 1124.707576030238, 27570.724292757215, 27719.168424947286, 28245.293867653472, 28324.291892702848, 28422.43155136927, 1002.908934870788, 1028.3624153025173, 1044.1646682653848, 1095.594629986894, 1113.3765091548757, 14458.204798736171, 14695.559133226021, 14759.188244646433, 14958.850411495963, 15025.398984040734, 310725.0, 313523.0, 315898.0, 316195.0, 317497.0, 49334.506654933706, 49498.25752613714, 49620.25569616459, 49673.0, 49685.25472117849, 1281.9679508012375, 1301.2972994583008, 1310.377570653951, 1311.5147395463548, 1319.4854006937303, 22308.77691223067, 28318.85840570784, 29300.706992929798, 30530.84734576313, 31067.0, 42617.36073958955, 43035.35446968235, 43180.78409608058, 43213.0, 43234.78382608067, 232111.0, 234591.0, 234986.0, 235186.0, 235332.0, 28634.57048144321, 29631.555526666685, 30011.0, 30271.0, 30277.243068923453, 38496.422553661156, 38719.0, 38811.22377552489, 39071.80464097661, 39554.60445395509, 33769.83115084507, 34103.82948085244, 34205.0, 34213.82893085618, 35136.29727405489, 27680.723192767815, 31631.20921976969, 33617.83191084029, 34358.31283374369, 36483.45274820827, 34113.0, 34209.0, 34855.0, 35390.46914296236, 35428.0, 29024.41951161007, 30783.0, 31093.689063109985, 31256.21859453532, 31460.52809207818, 23887.402814929766, 24241.878790605933, 24259.272221833373, 24297.878510607334, 24512.50974980526], "unit": "score", "name": "ext.html", "value": 17539.601006511846}, {"lowerIsBetter": false, "replicates": [350.81231541125504, 356.3123172277503, 359.6547314578006, 361.33694670280033, 363.04700162074556, 14246.857531424683, 14422.423103075864, 16383.754243686339, 16687.582810429747, 17357.305707771706, 16046.83953160468, 17181.226844792014, 17331.22009509572, 17502.562435939108, 17581.472555823344, 5399.028174928511, 5500.532454741332, 5534.501894829465, 5537.252470916415, 5537.473939975695, 3675.0, 3755.586885442599, 5487.725613719318, 5523.171524271352, 5894.823155305347, 5959.195508606348, 5998.490128339096, 6011.218541589587, 6012.3085845127935, 6017.157597936292, 5838.153467747175, 5967.6121052131475, 5975.193348897887, 6022.126791615191, 6024.9698751506185, 5362.249285100089, 5363.919541206885, 5392.137258038695, 5407.675539467606, 5408.59435542332, 20608.896955515276, 20999.685004724943, 21100.155993760232, 21223.5755284895, 21240.468988275417, 1934.3809980806147, 1984.2261518007988, 2019.545602239499, 2055.9486012849798, 2127.7340332458443, 9011.414258073204, 9396.765080872965, 12409.813852792215, 12447.502099915993, 13456.394462249222, 1688.7213609754376, 1769.0977601423238, 1809.9185536650882, 1812.8459080978132, 1815.27389044382, 54937.0, 57199.0, 57283.42716572822, 57335.71332143354, 58720.70639646817, 9766.95116524427, 9821.214302855755, 9936.354136981074, 9973.0, 10038.899611003797, 12670.746585068431, 12676.112672113048, 12683.175593586571, 12684.23894566329, 12690.111692181643, 7396.038514993124, 7450.292222238879, 7459.813504662427, 7514.6618402172035, 7523.8119047023165, 7041.049458323061, 7098.1482222132645, 7286.963565182246, 7368.447366447538, 7393.334599886036, 4417.558244175621, 4451.243288640874, 4461.263891457873, 4462.330650402466, 4478.39541661878, 1743.8517725993433, 1758.841704246624, 1775.1922875091802, 1791.4715159028117, 1796.1827368547279, 872.389327470773, 911.1344222988188, 1001.104011909337, 1001.3140998416109, 1031.63377001165, 16156.27296771648, 17141.742873856903, 17160.200475230205, 17556.824431755773, 17569.824301757075, 776.9611519424119, 839.9160083991552, 870.8214815962713, 903.1826197291462, 995.4077323992213, 9276.768080798034, 9672.806543869083, 9692.0, 9704.835419749534, 9714.854277185848, 510913.0, 515993.0, 529117.0, 529946.0, 532712.0, 80476.59761701155, 80958.19041809624, 80998.0, 81803.0, 82942.58528707318, 1072.7693545887516, 1083.3662307550014, 1084.5553323137476, 1086.576235268246, 1102.2669924500278, 15365.923170384076, 15624.531264062096, 15625.76561351558, 15743.0, 16012.0, 35710.64289357177, 35816.0, 35839.46240806338, 36781.26437471289, 36917.815410922776, 45871.541284586725, 46447.65851926937, 46656.53343466658, 47678.0, 48357.75821120872, 8799.824003520022, 8916.420432671855, 8960.462372257685, 9143.268538517035, 9400.200982916529, 10494.580216791548, 10538.0, 10630.893691062991, 11247.831282530933, 17404.912975435043, 14719.116852988855, 14857.628559286104, 14959.626009349418, 15112.110986126734, 15443.61390965235, 13585.796213056614, 13871.653208669864, 14320.57038288853, 15011.0, 15174.165420901956, 12075.939620301842, 14010.719785604435, 14051.156930584199, 14364.856351436352, 14530.273486325852, 7873.25204105609, 8903.688370906988, 9408.576614052521, 9697.854532182164, 9706.272029597949, 14002.0, 14326.785098223327, 14332.426702931765, 14734.484293049692, 14785.92607037001], "unit": "score", "name": "jquery.html", "value": 8793.652341072455}, {"lowerIsBetter": false, "replicates": [1259.6724851538597, 1448.8768454681351, 1450.2241300904016, 1599.1764241415674, 1782.313809183464, 6779.728810847566, 7415.851682966338, 7510.8122296942465, 7524.473286869915, 7550.924490755091, 7404.259574042607, 7473.177950425449, 7581.620918954058, 7581.734639287626, 7585.544867307965, 1800.8019117897086, 1827.5887925216853, 1829.6706592813289, 2220.455988282873, 2271.0575111328862, 1899.5061284066105, 2227.7438094619165, 2269.500709843832, 2272.9545409091807, 2276.5333106713083, 2132.722746043012, 2134.647783115784, 2149.720536330275, 2243.921462748804, 2252.0653928619604, 2201.0755482697305, 2211.9115235390564, 2218.7781221877685, 2223.3107736601705, 2223.5108276179217, 2239.6304609739373, 2257.7516473187934, 2259.9548009039727, 2262.7963483286417, 2265.1166045242203, 7392.6303684816085, 7442.925570744277, 7446.069241344832, 7467.215942326032, 7506.474546781727, 4572.222722137211, 4619.076184763027, 4623.375844261015, 4628.560286772751, 4658.068386322749, 2832.886684532616, 2878.6977367376335, 2965.5551667250083, 2970.019893435161, 2985.8656360463833, 867.2628265973872, 875.65411662393, 885.490842765406, 897.9775505612347, 907.0, 10435.060844524029, 10442.477876106164, 10447.477626118663, 10448.0, 10472.16222702182, 4230.090530535949, 4251.80866860992, 4291.506476755213, 4293.3989241506215, 4296.548862369469, 8989.955050224838, 9016.774580635536, 9020.8646870297, 9024.593893274818, 9062.275017998545, 4730.787114579852, 4735.857924262209, 4737.763111844463, 4738.0, 4742.786574604151, 4225.091605304874, 4291.9785401072795, 4293.914121717548, 4296.419983302277, 4296.806643701041, 3318.1206980149796, 3370.224848284859, 3683.318586061587, 3688.0779805048737, 3738.43923411485, 1173.8767429419959, 1188.6671731915078, 1201.501376928565, 1211.6546784166471, 1213.9028877689764, 916.486767410239, 927.5779520318239, 928.2527565309855, 993.6621548673486, 1010.2271762101998, 6932.792016239521, 6992.545484543489, 6998.895016574756, 6999.405050570758, 7002.649867506706, 1059.9400599400599, 1080.4651697409834, 1083.2471432354596, 1101.6639924823005, 1123.5786580032488, 5603.551715862721, 5641.8589535261945, 5725.942740572541, 5751.1373294006235, 5766.279215098113, 8889.822203556021, 9169.0, 9191.448513089235, 9312.72061838146, 9317.627294908129, 8911.37620366581, 9107.681231156877, 9147.634094636272, 9149.268058555299, 9163.404378715362, 7177.0, 7186.892196617159, 7237.819054523679, 7259.382952449101, 7259.9274007259255, 6794.8641027180165, 6863.588184708933, 6886.827829304308, 6924.4114250289285, 6944.791656250321, 8003.07964584057, 8175.059868115005, 8262.710805122033, 8274.213949674771, 8327.708530201415, 8398.748037558884, 8514.829703406022, 8514.91485085166, 8523.48859068458, 8544.74365769028, 6678.432333251728, 6712.83217919556, 6741.797746067626, 6743.763968261087, 6744.460443164437, 6404.775832845828, 6423.164988551645, 7111.573305601681, 7450.552966822008, 7504.249575042452, 6572.244191917799, 6673.165854268216, 6744.494162937701, 6759.155105611799, 6988.37104660583, 6618.437432818265, 6670.199576050905, 6731.394174524316, 6744.258131605421, 6915.170179578483, 6870.690818913261, 6914.204866440223, 6956.339147780953, 6957.582545047313, 6984.895226571707, 6356.078368636614, 6359.395857393725, 6392.840178995562, 6434.453071488976, 6441.420272175526, 6255.53083518747, 6279.96860015697, 6291.496680265659, 6294.181756371642, 6301.873962520815], "unit": "score", "name": "mootools.html", "value": 4339.109638690443}, {"lowerIsBetter": false, "replicates": [330.1004762023486, 335.356116256787, 338.81703879904853, 343.6546270997647, 349.7656570098034, 5866.706664666771, 5871.266091738533, 5897.0, 5906.084556893683, 5908.67502287374, 5551.1118221084635, 5633.887322253563, 5734.4265573442635, 5766.0, 5821.476067153955, 4516.1193567254395, 4525.864224073283, 4539.273716205408, 4543.522930092342, 4553.180427523044, 4328.826846926119, 4554.70394424363, 4555.362249285103, 4556.088782243548, 4558.133954548642, 4364.410804541394, 4371.278739008076, 4462.509123996358, 4478.664100192483, 4482.058767658796, 4452.131834292314, 4462.3752674625575, 4463.977680111611, 4465.888352791174, 4470.061287129674, 3944.8422063117728, 3945.1517923646265, 3960.4653371794725, 3965.405189221611, 3965.7620542767527, 5389.164679474648, 5520.475554822286, 5560.443955604448, 5562.443755624405, 5566.304211973504, 5228.9738551307, 5236.476352364771, 5236.743181636418, 5243.292155559027, 5245.344331958505, 6161.876762464725, 6168.0, 6179.258488981351, 6180.721867515927, 6183.443490085869, 4395.12097580482, 4396.120775844844, 4400.031992961543, 4404.22925987954, 4404.889877753049, 6334.144890439778, 6476.125723027425, 6478.319776423455, 6478.643674597895, 6483.935160648428, 4525.366448697185, 4528.071745292207, 4528.320751887178, 4529.116822219636, 4542.727436353829, 4586.839460618862, 4588.472325682589, 4593.28804035375, 4593.770311484413, 4597.4712908015335, 5230.581553475713, 5241.0828105081455, 5241.606879484054, 5245.554127899171, 5246.31797866275, 6043.516518678495, 6240.7503699852405, 6244.65654389013, 6247.406496382836, 6253.468455181361, 1612.6774645071032, 1628.080134723877, 1629.983700163007, 1631.6573519561025, 1633.4854520825902, 1101.9889801102047, 1109.866815982071, 1119.2109562758235, 1119.972000699989, 1127.0983213429224, 5952.880942381128, 5956.195913551615, 5964.582479226413, 5966.6121702090095, 5970.58205925581, 6386.786510562978, 6407.13503677007, 6411.0383442484, 6413.262474815456, 6432.678366081677, 5782.248307720053, 5845.09401042839, 5963.135345374896, 5998.280206375263, 6029.427204415573, 3477.8870761356125, 3494.4583589543663, 3500.1599616091953, 3500.7724497907557, 3501.9319107672404, 6762.391384775394, 6770.898436523456, 6771.966140169267, 6772.0857684212, 6774.932250677529, 6515.187801859993, 6592.30780768022, 6618.7021584028835, 6637.203535575762, 6648.66756662165, 6760.087388202628, 6762.188537375448, 6765.898511522331, 6768.526203165829, 6781.898271525931, 6421.229452465734, 6433.5496515243485, 6439.195100612424, 6443.871122577616, 6452.806415807533, 6275.34108918557, 6368.96815515938, 6387.744490220525, 6407.295197528175, 6417.0695249187675, 6742.5280230383405, 6747.966260168668, 6750.898736518858, 6758.3917447428, 6767.966160169168, 4493.91012179748, 4505.684602077954, 4506.166359223423, 4512.729236245836, 4513.0, 6294.968525157345, 6461.224653041665, 6471.158749362553, 6509.381608747351, 6518.543701940818, 6279.1209230708655, 6291.213598300213, 6315.621062736251, 6324.841878953063, 6344.968275158594, 6248.4688801452385, 6269.49844012487, 6274.121622972879, 6274.933261345491, 6276.874462510633, 6093.512518998381, 6186.1030150627, 6206.534509911865, 6216.627002379872, 6216.689165541795, 6336.239651241881, 6337.04944258365, 6346.428821405911, 6347.746090156342, 6348.746050157942, 6207.6275423474735, 6208.0998255253635, 6208.534359922934, 6213.378662133931, 6215.627062376272], "unit": "score", "name": "prototype.html", "value": 4739.311037451722}, {"lowerIsBetter": false, "replicates": [768.746313716474, 779.6335722210559, 814.3688641302989, 821.6015232612182, 836.1346006882876, 12670.0, 12761.872381276184, 12926.806097908539, 12930.741385172314, 12964.092513524058, 11800.350980696057, 11830.290182589051, 11846.940765296184, 12098.75802483952, 12287.508499660025, 688.0711040095856, 818.7953011747063, 831.9833603327929, 833.9666413343459, 834.1241696218976, 680.5916450129932, 823.7652269103306, 829.9087100418949, 831.3183189784379, 833.8707500337457, 846.289117141601, 875.3916028360292, 875.4003507597284, 875.6016012714232, 875.6409871952501, 715.4705517916756, 717.6985666020284, 852.416094974938, 861.8836457078277, 867.7179916527123, 633.3191818794814, 634.4892361648871, 636.096742625473, 637.0444333499751, 637.158950185755, 12230.082743794252, 12269.754604907852, 12374.75250494985, 12378.133530652858, 12412.0, 11298.0, 11945.104117191158, 12028.819567706492, 12091.879081209163, 12337.383130843422, 9479.289053321028, 9820.607175712963, 10032.94983525085, 10290.485475726184, 10426.374417534897, 3372.207531230159, 3459.290845376717, 3495.73781966351, 3501.684848363634, 3511.3504001759757, 44511.33233001507, 44631.10737785226, 44691.0, 44845.0, 44856.0, 9252.629894804133, 9540.95229523848, 9573.760655983517, 9832.754181145385, 10552.41961692099, 17204.65590688179, 17254.913725431292, 17300.567485812702, 17311.134443277784, 17313.39403120885, 7386.409087273005, 7463.328300452985, 7731.729389471454, 7778.377729781604, 7808.0, 3887.7278590498395, 3971.4042893566198, 3984.780837053932, 4017.216642754635, 4164.583541645872, 2840.0485837244755, 2866.1258316213757, 2873.5689646552764, 2873.956890646642, 2881.0, 527.5594878276605, 530.6285600079959, 545.8580769000009, 548.4077196627633, 552.9225908372831, 538.8437353167616, 624.1844172211411, 640.8301800022998, 664.2062735031687, 679.6873438218474, 7497.475176737576, 7819.882701759479, 7952.403569732293, 8064.314533264621, 8170.714025009096, 517.3429744224813, 527.9260903473516, 532.379777559147, 603.7192705392014, 676.202081543783, 3655.0, 3664.780113193217, 3905.33609286422, 4101.323281658493, 4305.375720520569, 48361.0, 49285.26072108921, 50070.74964625226, 56658.0, 56707.149392759144, 50874.0, 51389.486105139214, 51727.74136129295, 52003.47996520062, 52056.21915671268, 45714.54285457169, 46918.765406173436, 46941.0, 46946.0, 47284.7635761819, 8460.153984601491, 8467.66129354819, 8491.74524764258, 8551.230389264996, 8652.524111173945, 33918.0, 34388.312233755685, 34804.47793283052, 34968.0, 35013.29973400569, 43366.566334336254, 46207.76896115498, 46365.304520432896, 46901.29648055213, 47613.52386476091, 10881.891181088087, 10883.836742448711, 11166.44167791591, 11271.211015228855, 11304.943475282571, 11921.701957451132, 12022.75954480923, 12255.693607659523, 12270.509179632714, 12293.93853030729, 10683.145348371956, 10906.236563440483, 11177.72055698614, 11285.589301337333, 11451.885481145082, 10921.945390273315, 11204.551817927191, 11217.66347009591, 11624.0, 11656.06751459898, 7126.608036558039, 9064.864027039732, 10993.725156871142, 11185.32888026721, 11238.775224495628, 9403.952980235055, 9455.24358051368, 9486.478243696663, 9953.402795832273, 10228.232882533988, 9359.625614975324, 9453.716388508356, 9597.088276613711, 9621.120455711178, 9734.464604446823], "unit": "score", "name": "yui.html", "value": 6106.03819440513}], "name": "dromaeo_css", "value": 6805.097171949802}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 105.0, 111.0, 111.0, 112.0, 99.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [159.0, 137.0, 149.0, 174.0, 130.0, 157.0, 161.0, 127.0, 175.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 149.5}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 86.0, 96.0, 71.0, 71.0, 71.0, 100.0, 93.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [105.0, 97.0, 148.0, 96.0, 96.0, 96.0, 142.0, 96.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 111.4}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 60.0, 59.0, 60.0, 57.0, 57.0, 57.0, 57.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 68.0, 71.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 85.0, 85.0, 85.0, 86.0, 88.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [117.0, 115.0, 118.0, 115.0, 121.0, 118.0, 119.0, 120.0, 121.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.8}, {"lowerIsBetter": true, "replicates": [143.0, 142.0, 156.0, 152.0, 159.0, 141.0, 151.0, 152.0, 151.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 71.0, 70.0, 68.0, 68.0, 69.0, 82.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1510.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.75004168751042], "unit": "score", "name": "Richards", "value": 211.70609399999992}, {"lowerIsBetter": false, "replicates": [190.07793195210036], "unit": "score", "name": "DeltaBlue", "value": 347.84679800000015}, {"lowerIsBetter": false, "replicates": [281.928390188892], "unit": "score", "name": "Encrypt", "value": 944.1440070000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1104.9723756906078], "unit": "score", "name": "RayTrace", "value": 669.6900450000003}, {"lowerIsBetter": false, "replicates": [785.5459544383347], "unit": "score", "name": "Earley", "value": 848.4073989999999}, {"lowerIsBetter": false, "replicates": [12168.674698795181], "unit": "score", "name": "Boyer", "value": 54.768741584158384}, {"lowerIsBetter": false, "replicates": [26230.76923076923], "unit": "score", "name": "RegExp", "value": 34.729633431085055}, {"lowerIsBetter": false, "replicates": [649.772579597141], "unit": "score", "name": "Splay", "value": 125.41464899999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20844.125490047485}]} 19:28:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20844.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1510.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6805.10"}}} 19:28:02 INFO - Return code: 0 19:28:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:28:02 INFO - # TBPL SUCCESS # 19:28:02 INFO - Running post-action listener: _resource_record_post_action 19:28:02 INFO - Running post-run listener: _resource_record_post_run 19:28:03 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 579330048; Read time: 0; Write time: 451976 19:28:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 238493696; Read time: 0; Write time: 205700 19:28:03 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 322625536; Read time: 0; Write time: 237420 19:28:03 INFO - Running post-run listener: _upload_blobber_files 19:28:03 INFO - Blob upload gear active. 19:28:03 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:28:03 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 19:28:03 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:28:03 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:28:03 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:28:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:28:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:05 INFO - (blobuploader) - INFO - Done attempting. 19:28:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:28:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:28:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:05 INFO - (blobuploader) - INFO - Done attempting. 19:28:05 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:05 INFO - Return code: 0 19:28:05 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:28:05 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf0f7d6899d3534a773fc86181b031cb4bc961d3566dfef3b7e4b973eea145375639cb0e5a0eaef75b4a17e15586f9b89bbd665c1f008cf3682a364293150eaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baace54e5df1867792503f2244e53ab086cdd64ede6cf1841177759ae440a928be25daabf2bddfef9be5786013f6d8fd5f3ea6aa1c5434097b1038fcabcb6917"} 19:28:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:28:05 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:28:05 INFO - Contents: 19:28:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf0f7d6899d3534a773fc86181b031cb4bc961d3566dfef3b7e4b973eea145375639cb0e5a0eaef75b4a17e15586f9b89bbd665c1f008cf3682a364293150eaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baace54e5df1867792503f2244e53ab086cdd64ede6cf1841177759ae440a928be25daabf2bddfef9be5786013f6d8fd5f3ea6aa1c5434097b1038fcabcb6917"} 19:28:05 INFO - Copying logs to upload dir... 19:28:05 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.148990 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-07 19:28:05.325184) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 19:28:05.328936) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf0f7d6899d3534a773fc86181b031cb4bc961d3566dfef3b7e4b973eea145375639cb0e5a0eaef75b4a17e15586f9b89bbd665c1f008cf3682a364293150eaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baace54e5df1867792503f2244e53ab086cdd64ede6cf1841177759ae440a928be25daabf2bddfef9be5786013f6d8fd5f3ea6aa1c5434097b1038fcabcb6917"} build_url:https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011183 build_url: 'https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf0f7d6899d3534a773fc86181b031cb4bc961d3566dfef3b7e4b973eea145375639cb0e5a0eaef75b4a17e15586f9b89bbd665c1f008cf3682a364293150eaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baace54e5df1867792503f2244e53ab086cdd64ede6cf1841177759ae440a928be25daabf2bddfef9be5786013f6d8fd5f3ea6aa1c5434097b1038fcabcb6917"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 19:28:05.353345) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:28:05.353673) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1452215070.164954-980094133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:28:05.435123) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 19:28:05.435431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 19:28:05.438767) ========= ========= Total master_lag: 0.22 =========