builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1452819827.94 results: success (0) buildid: 20160114143022 builduid: abbc0b3110f64323a5dc8c6e01683516 revision: b6ef37a7673e9829de96d0439244343948545955 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:47.936953) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:47.937545) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:47.937907) ========= 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=1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006475 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.016542) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.016877) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.031983) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.032333) ========= 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=1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.085267) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.086002) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.086711) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.087189) ========= 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=1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 17:03:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.5M=0s 2016-01-14 17:03:48 (35.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098226 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.199935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.200282) ========= 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=1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022923 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.253009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.253823) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b6ef37a7673e9829de96d0439244343948545955 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b6ef37a7673e9829de96d0439244343948545955 --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=1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 17:03:48,788 truncating revision to first 12 chars 2016-01-14 17:03:48,788 Setting DEBUG logging. 2016-01-14 17:03:48,788 attempt 1/10 2016-01-14 17:03:48,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b6ef37a7673e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 17:03:49,154 unpacking tar archive at: fx-team-b6ef37a7673e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670456 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.939526) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.939903) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.949601) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.949979) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 17:03:48.950601) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-14 17:03:48.951006) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:03:49 INFO - MultiFileLogger online at 20160114 17:03:49 in /builds/slave/test-pgo 17:03:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:03:49 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:03:49 INFO - {'append_to_log': False, 17:03:49 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:03:49 INFO - 'blob_upload_branch': 'Fx-Team', 17:03:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:03:49 INFO - 'branch': 'Fx-Team', 17:03:49 INFO - 'buildbot_json_path': 'buildprops.json', 17:03:49 INFO - 'config_files': ('talos/linux_config.py',), 17:03:49 INFO - 'default_actions': ('clobber', 17:03:49 INFO - 'read-buildbot-config', 17:03:49 INFO - 'download-and-extract', 17:03:49 INFO - 'populate-webroot', 17:03:49 INFO - 'create-virtualenv', 17:03:49 INFO - 'install', 17:03:49 INFO - 'run-tests'), 17:03:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:03:49 INFO - 'download_minidump_stackwalk': True, 17:03:49 INFO - 'download_symbols': 'ondemand', 17:03:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:03:49 INFO - 'tooltool.py': '/tools/tooltool.py', 17:03:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:03:49 INFO - '/tools/misc-python/virtualenv.py')}, 17:03:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:03:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:03:49 INFO - 'installer_path': 'installer.exe', 17:03:49 INFO - 'log_level': 'info', 17:03:49 INFO - 'log_name': 'talos', 17:03:49 INFO - 'log_to_console': True, 17:03:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:03:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:03:49 INFO - 'opt_config_files': (), 17:03:49 INFO - 'pip_index': False, 17:03:49 INFO - 'sps_profile': False, 17:03:49 INFO - 'sps_profile_interval': 0, 17:03:49 INFO - 'suite': 'dromaeojs-e10s', 17:03:49 INFO - 'system_bits': '32', 17:03:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:03:49 INFO - 'title': 'talos-linux64-ix-027', 17:03:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:03:49 INFO - 'use_talos_json': True, 17:03:49 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:03:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:03:49 INFO - 'work_dir': 'build'} 17:03:49 INFO - ##### 17:03:49 INFO - ##### Running clobber step. 17:03:49 INFO - ##### 17:03:49 INFO - Running pre-action listener: _resource_record_pre_action 17:03:49 INFO - Running main action method: clobber 17:03:49 INFO - rmtree: /builds/slave/test-pgo/build 17:03:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:03:50 INFO - Running post-action listener: _resource_record_post_action 17:03:50 INFO - ##### 17:03:50 INFO - ##### Running read-buildbot-config step. 17:03:50 INFO - ##### 17:03:50 INFO - Running pre-action listener: _resource_record_pre_action 17:03:50 INFO - Running main action method: read_buildbot_config 17:03:50 INFO - Using buildbot properties: 17:03:50 INFO - { 17:03:50 INFO - "project": "", 17:03:50 INFO - "product": "firefox", 17:03:50 INFO - "script_repo_revision": "production", 17:03:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:03:50 INFO - "repository": "", 17:03:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:03:50 INFO - "buildid": "20160114143022", 17:03:50 INFO - "pgo_build": "True", 17:03:50 INFO - "basedir": "/builds/slave/test-pgo", 17:03:50 INFO - "buildnumber": 126, 17:03:50 INFO - "slavename": "talos-linux64-ix-027", 17:03:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:03:50 INFO - "platform": "ubuntu64_hw", 17:03:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:03:50 INFO - "branch": "fx-team", 17:03:50 INFO - "repo_path": "integration/fx-team", 17:03:50 INFO - "revision": "b6ef37a7673e9829de96d0439244343948545955", 17:03:50 INFO - "stage_platform": "linux64-pgo", 17:03:50 INFO - "builduid": "abbc0b3110f64323a5dc8c6e01683516", 17:03:50 INFO - "slavebuilddir": "test" 17:03:50 INFO - } 17:03:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:03:50 INFO - Running post-action listener: _resource_record_post_action 17:03:50 INFO - ##### 17:03:50 INFO - ##### Running download-and-extract step. 17:03:50 INFO - ##### 17:03:50 INFO - Running pre-action listener: _resource_record_pre_action 17:03:50 INFO - Running main action method: download_and_extract 17:03:50 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:03:50 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')]} 17:03:50 INFO - https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:03:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/test_packages.json 17:03:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/test_packages.json 17:03:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:03:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:03:50 INFO - Downloaded 1448 bytes. 17:03:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:03:50 INFO - Using the following test package requirements: 17:03:50 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:50 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:03:50 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:03:50 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'jsshell-linux-x86_64.zip'], 17:03:50 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:03:50 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:50 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:03:50 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:03:50 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:03:50 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:50 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:03:50 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:03:50 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')]} 17:03:50 INFO - https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:03:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:03:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:04:00 INFO - Downloaded 22439306 bytes. 17:04:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:04:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:04:01 INFO - Return code: 0 17:04:01 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 17:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:01 INFO - https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:04:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:04:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:04:04 INFO - Downloaded 22439306 bytes. 17:04:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:04:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:04:05 INFO - Return code: 0 17:04: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')]} 17:04:05 INFO - https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:04:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:04:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:04:07 INFO - Downloaded 11132144 bytes. 17:04:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:04:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 17:04:07 INFO - Return code: 0 17:04: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')]} 17:04:07 INFO - https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:04:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:04:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:04:11 INFO - Downloaded 55952475 bytes. 17:04:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:11 INFO - mkdir: /builds/slave/test-pgo/properties 17:04:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:04:11 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:04:11 INFO - Contents: 17:04:11 INFO - build_url:https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:11 INFO - Running post-action listener: _resource_record_post_action 17:04:11 INFO - Running post-action listener: set_extra_try_arguments 17:04:11 INFO - ##### 17:04:11 INFO - ##### Running populate-webroot step. 17:04:11 INFO - ##### 17:04:11 INFO - Running pre-action listener: _resource_record_pre_action 17:04:11 INFO - Running main action method: populate_webroot 17:04:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:04:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:04:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:04:11 INFO - '--tppagecycles', 17:04:11 INFO - '7'], 17:04:11 INFO - 'tests': ['tsvgm']}}, 17:04:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:04:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:04:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:04:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:04:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:11 INFO - 'talos_options': ['--e10s'], 17:04:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:11 INFO - 'tests': ['damp', 'tps']}, 17:04:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:11 INFO - 'talos_options': ['--e10s'], 17:04:11 INFO - 'tests': ['damp', 'tps']}, 17:04:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:04:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:04:11 INFO - 'other': {'tests': ['a11yr', 17:04:11 INFO - 'ts_paint', 17:04:11 INFO - 'tpaint', 17:04:11 INFO - 'sessionrestore', 17:04:11 INFO - 'sessionrestore_no_auto_restore']}, 17:04:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:04:11 INFO - 'tests': ['a11yr', 17:04:11 INFO - 'ts_paint', 17:04:11 INFO - 'tpaint', 17:04:11 INFO - 'sessionrestore', 17:04:11 INFO - 'sessionrestore_no_auto_restore']}, 17:04:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:04:11 INFO - 'tests': ['a11yr', 17:04:11 INFO - 'ts_paint', 17:04:11 INFO - 'tpaint', 17:04:11 INFO - 'sessionrestore', 17:04:11 INFO - 'sessionrestore_no_auto_restore']}, 17:04:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:04:11 INFO - 'tests': ['a11yr', 17:04:11 INFO - 'ts_paint', 17:04:11 INFO - 'tpaint', 17:04:11 INFO - 'sessionrestore', 17:04:11 INFO - 'sessionrestore_no_auto_restore']}, 17:04:11 INFO - 'other_l64': {'tests': ['a11yr', 17:04:11 INFO - 'ts_paint', 17:04:11 INFO - 'tpaint', 17:04:11 INFO - 'sessionrestore', 17:04:11 INFO - 'sessionrestore_no_auto_restore']}, 17:04:11 INFO - 'other_nol64': {'tests': ['a11yr', 17:04:11 INFO - 'ts_paint', 17:04:11 INFO - 'tpaint', 17:04:11 INFO - 'sessionrestore', 17:04:11 INFO - 'sessionrestore_no_auto_restore']}, 17:04:11 INFO - 'svgr': {'tests': ['tsvgx', 17:04:11 INFO - 'tsvgr_opacity', 17:04:11 INFO - 'tart', 17:04:11 INFO - 'tscrollx', 17:04:11 INFO - 'cart']}, 17:04:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:04:11 INFO - 'tests': ['tsvgx', 17:04:11 INFO - 'tsvgr_opacity', 17:04:11 INFO - 'tart', 17:04:11 INFO - 'tscrollx', 17:04:11 INFO - 'cart']}, 17:04:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:11 INFO - 'tests': ['tp5o']}, 17:04:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:11 INFO - 'talos_options': ['--e10s'], 17:04:11 INFO - 'tests': ['tp5o']}, 17:04:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:11 INFO - 'talos_options': ['--xperf_path', 17:04:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:11 INFO - 'tests': ['tp5n']}, 17:04:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:11 INFO - 'talos_options': ['--e10s', 17:04:11 INFO - '--xperf_path', 17:04:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:11 INFO - 'tests': ['tp5n']}}, 17:04:11 INFO - 'talos.zip': {'path': '', 17:04:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:04:11 INFO - Running post-action listener: _resource_record_post_action 17:04:11 INFO - ##### 17:04:11 INFO - ##### Running create-virtualenv step. 17:04:11 INFO - ##### 17:04:11 INFO - Running pre-action listener: _resource_record_pre_action 17:04:11 INFO - Running main action method: create_virtualenv 17:04:11 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:04:11 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 17:04:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:04:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:04:11 INFO - Using real prefix '/usr' 17:04:11 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:04:11 INFO - Installing distribute.............................................................................................................................................................................................done. 17:04:13 INFO - Installing pip.................done. 17:04:13 INFO - Return code: 0 17:04:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:04: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')]} 17:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90dc44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c840>, '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 0x2ad96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad9b60>, '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': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', '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 17:04: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:04: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 pip>=1.5 17:04:13 INFO - Using env: {'DISPLAY': ':0', 17:04:13 INFO - 'HOME': '/home/cltbld', 17:04:13 INFO - 'LANG': 'en_US.UTF-8', 17:04:13 INFO - 'LANGUAGE': 'en_US:en', 17:04:13 INFO - 'LOGNAME': 'cltbld', 17:04:13 INFO - 'MAIL': '/var/mail/cltbld', 17:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:13 INFO - 'MOZ_NO_REMOTE': '1', 17:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:13 INFO - 'NO_EM_RESTART': '1', 17:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:13 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:13 INFO - 'SHELL': '/bin/bash', 17:04:13 INFO - 'SHLVL': '1', 17:04:13 INFO - 'TERM': 'linux', 17:04:13 INFO - 'TMOUT': '86400', 17:04:13 INFO - 'USER': 'cltbld', 17:04:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', 17:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:13 INFO - '_': '/tools/buildbot/bin/python'} 17:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:14 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 17:04:14 INFO - Cleaning up... 17:04:14 INFO - Return code: 0 17:04:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:14 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 0x7fe90dc44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c840>, '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 0x2ad96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad9b60>, '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': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', '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 17:04:14 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 17:04:14 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 17:04:14 INFO - Using env: {'DISPLAY': ':0', 17:04:14 INFO - 'HOME': '/home/cltbld', 17:04:14 INFO - 'LANG': 'en_US.UTF-8', 17:04:14 INFO - 'LANGUAGE': 'en_US:en', 17:04:14 INFO - 'LOGNAME': 'cltbld', 17:04:14 INFO - 'MAIL': '/var/mail/cltbld', 17:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:14 INFO - 'MOZ_NO_REMOTE': '1', 17:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:14 INFO - 'NO_EM_RESTART': '1', 17:04:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:14 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:14 INFO - 'SHELL': '/bin/bash', 17:04:14 INFO - 'SHLVL': '1', 17:04:14 INFO - 'TERM': 'linux', 17:04:14 INFO - 'TMOUT': '86400', 17:04:14 INFO - 'USER': 'cltbld', 17:04:14 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', 17:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:14 INFO - '_': '/tools/buildbot/bin/python'} 17:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:14 INFO - Downloading/unpacking psutil>=0.7.1 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:16 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:04:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:04:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:04:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:16 INFO - Installing collected packages: psutil 17:04:16 INFO - Running setup.py install for psutil 17:04:16 INFO - building 'psutil._psutil_linux' extension 17:04:16 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 17:04:16 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 17:04:16 INFO - building 'psutil._psutil_posix' extension 17:04:16 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 17:04:16 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 17:04:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:16 INFO - Successfully installed psutil 17:04:16 INFO - Cleaning up... 17:04:16 INFO - Return code: 0 17:04:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:04: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')]} 17:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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', '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 0x7fe90dc44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c840>, '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 0x2ad96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad9b60>, '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': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', '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 17:04: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:04: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 mozsystemmonitor==0.0.0 17:04:16 INFO - Using env: {'DISPLAY': ':0', 17:04:16 INFO - 'HOME': '/home/cltbld', 17:04:16 INFO - 'LANG': 'en_US.UTF-8', 17:04:16 INFO - 'LANGUAGE': 'en_US:en', 17:04:16 INFO - 'LOGNAME': 'cltbld', 17:04:16 INFO - 'MAIL': '/var/mail/cltbld', 17:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:16 INFO - 'MOZ_NO_REMOTE': '1', 17:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:16 INFO - 'NO_EM_RESTART': '1', 17:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:16 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:16 INFO - 'SHELL': '/bin/bash', 17:04:16 INFO - 'SHLVL': '1', 17:04:16 INFO - 'TERM': 'linux', 17:04:16 INFO - 'TMOUT': '86400', 17:04:16 INFO - 'USER': 'cltbld', 17:04:16 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', 17:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:16 INFO - '_': '/tools/buildbot/bin/python'} 17:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:04:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:04:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:04:18 INFO - Installing collected packages: mozsystemmonitor 17:04:18 INFO - Running setup.py install for mozsystemmonitor 17:04:18 INFO - Successfully installed mozsystemmonitor 17:04:18 INFO - Cleaning up... 17:04:18 INFO - Return code: 0 17:04:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe90dc44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c840>, '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 0x2ad96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad9b60>, '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': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', '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 17:04:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:04:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:04:18 INFO - Using env: {'DISPLAY': ':0', 17:04:18 INFO - 'HOME': '/home/cltbld', 17:04:18 INFO - 'LANG': 'en_US.UTF-8', 17:04:18 INFO - 'LANGUAGE': 'en_US:en', 17:04:18 INFO - 'LOGNAME': 'cltbld', 17:04:18 INFO - 'MAIL': '/var/mail/cltbld', 17:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:18 INFO - 'MOZ_NO_REMOTE': '1', 17:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:18 INFO - 'NO_EM_RESTART': '1', 17:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:18 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:18 INFO - 'SHELL': '/bin/bash', 17:04:18 INFO - 'SHLVL': '1', 17:04:18 INFO - 'TERM': 'linux', 17:04:18 INFO - 'TMOUT': '86400', 17:04:18 INFO - 'USER': 'cltbld', 17:04:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', 17:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:18 INFO - '_': '/tools/buildbot/bin/python'} 17:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:19 INFO - Downloading/unpacking blobuploader==1.2.4 17:04:19 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 17:04:19 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 17:04:19 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 17:04:19 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 17:04:19 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 17:04:19 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 17:04:20 INFO - Downloading blobuploader-1.2.4.tar.gz 17:04:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:04:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:04:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:04:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:04:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:04:21 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 17:04:21 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 17:04:21 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 17:04:21 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 17:04:21 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 17:04:21 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 17:04:21 INFO - Downloading docopt-0.6.1.tar.gz 17:04:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:04:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:04:21 INFO - Installing collected packages: blobuploader, requests, docopt 17:04:21 INFO - Running setup.py install for blobuploader 17:04:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:04:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:04:21 INFO - Running setup.py install for requests 17:04:21 INFO - Running setup.py install for docopt 17:04:22 INFO - Successfully installed blobuploader requests docopt 17:04:22 INFO - Cleaning up... 17:04:22 INFO - Return code: 0 17:04:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04: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')]} 17:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:22 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 0x7fe90dc44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c840>, '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 0x2ad96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad9b60>, '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': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', '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 17:04:22 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 17:04:22 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 17:04:22 INFO - Using env: {'DISPLAY': ':0', 17:04:22 INFO - 'HOME': '/home/cltbld', 17:04:22 INFO - 'LANG': 'en_US.UTF-8', 17:04:22 INFO - 'LANGUAGE': 'en_US:en', 17:04:22 INFO - 'LOGNAME': 'cltbld', 17:04:22 INFO - 'MAIL': '/var/mail/cltbld', 17:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:22 INFO - 'MOZ_NO_REMOTE': '1', 17:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:22 INFO - 'NO_EM_RESTART': '1', 17:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:22 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:22 INFO - 'SHELL': '/bin/bash', 17:04:22 INFO - 'SHLVL': '1', 17:04:22 INFO - 'TERM': 'linux', 17:04:22 INFO - 'TMOUT': '86400', 17:04:22 INFO - 'USER': 'cltbld', 17:04:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', 17:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:22 INFO - '_': '/tools/buildbot/bin/python'} 17:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:22 INFO - Running setup.py (path:/tmp/pip-qE63kj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:22 INFO - Running setup.py (path:/tmp/pip-HHepzC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:22 INFO - Running setup.py (path:/tmp/pip-YsrU5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:22 INFO - Running setup.py (path:/tmp/pip-SO2gkM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:22 INFO - Running setup.py (path:/tmp/pip-B_dUcO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:22 INFO - Running setup.py (path:/tmp/pip-2Dxkqc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:22 INFO - Running setup.py (path:/tmp/pip-5knso3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:22 INFO - Running setup.py (path:/tmp/pip-9l_LT6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:22 INFO - Running setup.py (path:/tmp/pip-XqMbfU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:22 INFO - Running setup.py (path:/tmp/pip-TqnLA_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:23 INFO - Running setup.py (path:/tmp/pip-UzeRie-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:23 INFO - Running setup.py (path:/tmp/pip-IoeZ1K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:23 INFO - Running setup.py (path:/tmp/pip-JQgPwZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:23 INFO - Running setup.py (path:/tmp/pip-pxGULx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:23 INFO - Running setup.py (path:/tmp/pip-5CiPHN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:23 INFO - Running setup.py (path:/tmp/pip-uMeZPA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:23 INFO - Running setup.py (path:/tmp/pip-wUGxia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:04:23 INFO - Running setup.py install for manifestparser 17:04:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:04:23 INFO - Running setup.py install for mozcrash 17:04:23 INFO - Running setup.py install for mozdebug 17:04:23 INFO - Running setup.py install for mozdevice 17:04:23 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:04:23 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:04:23 INFO - Running setup.py install for mozfile 17:04:24 INFO - Running setup.py install for mozhttpd 17:04:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:04:24 INFO - Running setup.py install for mozinfo 17:04:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:04:24 INFO - Running setup.py install for mozInstall 17:04:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:04:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:04:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:04:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:04:24 INFO - Running setup.py install for mozleak 17:04:24 INFO - Running setup.py install for mozlog 17:04:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:04:24 INFO - Running setup.py install for moznetwork 17:04:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:04:24 INFO - Running setup.py install for mozprocess 17:04:24 INFO - Running setup.py install for mozprofile 17:04:24 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:04:24 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:04:24 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:04:24 INFO - Running setup.py install for mozrunner 17:04:24 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:04:25 INFO - Running setup.py install for mozscreenshot 17:04:25 INFO - Running setup.py install for moztest 17:04:25 INFO - Running setup.py install for mozversion 17:04:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:04:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:04:25 INFO - Cleaning up... 17:04:25 INFO - Return code: 0 17:04:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:25 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')]} 17:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:25 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')]} 17:04:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:25 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 0x7fe90dc44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c840>, '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 0x2ad96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad9b60>, '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': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', '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 17:04:25 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 17:04:25 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 17:04:25 INFO - Using env: {'DISPLAY': ':0', 17:04:25 INFO - 'HOME': '/home/cltbld', 17:04:25 INFO - 'LANG': 'en_US.UTF-8', 17:04:25 INFO - 'LANGUAGE': 'en_US:en', 17:04:25 INFO - 'LOGNAME': 'cltbld', 17:04:25 INFO - 'MAIL': '/var/mail/cltbld', 17:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:25 INFO - 'MOZ_NO_REMOTE': '1', 17:04:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:25 INFO - 'NO_EM_RESTART': '1', 17:04:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:25 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:25 INFO - 'SHELL': '/bin/bash', 17:04:25 INFO - 'SHLVL': '1', 17:04:25 INFO - 'TERM': 'linux', 17:04:25 INFO - 'TMOUT': '86400', 17:04:25 INFO - 'USER': 'cltbld', 17:04:25 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', 17:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:25 INFO - '_': '/tools/buildbot/bin/python'} 17:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:25 INFO - Running setup.py (path:/tmp/pip-FHixDK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:25 INFO - Running setup.py (path:/tmp/pip-lgEQZq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:25 INFO - Running setup.py (path:/tmp/pip-HqeqTq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:25 INFO - Running setup.py (path:/tmp/pip-bMJDv5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:25 INFO - Running setup.py (path:/tmp/pip-LfNNqC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:25 INFO - Running setup.py (path:/tmp/pip-1JkdPn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:25 INFO - Running setup.py (path:/tmp/pip-J4645J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:26 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)) 17:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:26 INFO - Running setup.py (path:/tmp/pip-mUAhd2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:26 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)) 17:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:26 INFO - Running setup.py (path:/tmp/pip-Pi8cyB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:26 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)) 17:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:26 INFO - Running setup.py (path:/tmp/pip-QT3qGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:26 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)) 17:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:26 INFO - Running setup.py (path:/tmp/pip-xuaEmR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:26 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)) 17:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:26 INFO - Running setup.py (path:/tmp/pip-GywsWv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:26 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)) 17:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:26 INFO - Running setup.py (path:/tmp/pip-_IfQhA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:26 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)) 17:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:26 INFO - Running setup.py (path:/tmp/pip-uYOJ4u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:26 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)) 17:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:26 INFO - Running setup.py (path:/tmp/pip-q6eyv9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:26 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)) 17:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:26 INFO - Running setup.py (path:/tmp/pip-Tv7jUw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:26 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)) 17:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:26 INFO - Running setup.py (path:/tmp/pip-nf8xZI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:26 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)) 17:04:26 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)) 17:04:26 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)) 17:04:26 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)) 17:04: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 mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:28 INFO - Downloading blessings-1.5.1.tar.gz 17:04:28 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 17:04:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:04:28 INFO - Installing collected packages: blessings 17:04:28 INFO - Running setup.py install for blessings 17:04:28 INFO - Successfully installed blessings 17:04:28 INFO - Cleaning up... 17:04:28 INFO - Return code: 0 17:04:28 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:04:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:04:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:04:28 INFO - Reading from file tmpfile_stdout 17:04:28 INFO - Current package versions: 17:04:28 INFO - argparse == 1.2.1 17:04:28 INFO - blessings == 1.5.1 17:04:28 INFO - blobuploader == 1.2.4 17:04:28 INFO - docopt == 0.6.1 17:04:28 INFO - manifestparser == 1.1 17:04:28 INFO - mozInstall == 1.12 17:04:28 INFO - mozcrash == 0.16 17:04:28 INFO - mozdebug == 0.1 17:04:28 INFO - mozdevice == 0.48 17:04:28 INFO - mozfile == 1.2 17:04:28 INFO - mozhttpd == 0.7 17:04:28 INFO - mozinfo == 0.9 17:04:28 INFO - mozleak == 0.1 17:04:28 INFO - mozlog == 3.1 17:04:28 INFO - moznetwork == 0.27 17:04:28 INFO - mozprocess == 0.22 17:04:28 INFO - mozprofile == 0.28 17:04:28 INFO - mozrunner == 6.11 17:04:28 INFO - mozscreenshot == 0.1 17:04:28 INFO - mozsystemmonitor == 0.0 17:04:28 INFO - moztest == 0.7 17:04:28 INFO - mozversion == 1.4 17:04:28 INFO - psutil == 3.1.1 17:04:28 INFO - requests == 1.2.3 17:04:28 INFO - wsgiref == 0.1.2 17:04:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04: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')]} 17:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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', '-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 0x7fe90dc44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c840>, '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 0x2ad96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad9b60>, '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': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', '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 17:04:28 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 17:04:28 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 17:04:28 INFO - Using env: {'DISPLAY': ':0', 17:04:28 INFO - 'HOME': '/home/cltbld', 17:04:28 INFO - 'LANG': 'en_US.UTF-8', 17:04:28 INFO - 'LANGUAGE': 'en_US:en', 17:04:28 INFO - 'LOGNAME': 'cltbld', 17:04:28 INFO - 'MAIL': '/var/mail/cltbld', 17:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:28 INFO - 'MOZ_NO_REMOTE': '1', 17:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:28 INFO - 'NO_EM_RESTART': '1', 17:04:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:28 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:28 INFO - 'SHELL': '/bin/bash', 17:04:28 INFO - 'SHLVL': '1', 17:04:28 INFO - 'TERM': 'linux', 17:04:28 INFO - 'TMOUT': '86400', 17:04:28 INFO - 'USER': 'cltbld', 17:04:28 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', 17:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:28 INFO - '_': '/tools/buildbot/bin/python'} 17:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:29 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)) 17:04:29 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)) 17:04:29 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)) 17:04:29 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)) 17:04:29 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)) 17:04:29 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)) 17:04:29 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)) 17:04:29 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)) 17:04:29 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)) 17:04:29 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)) 17:04:29 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)) 17:04:29 INFO - Cleaning up... 17:04:29 INFO - Return code: 0 17:04:29 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:29 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 0x7fe90dc44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c840>, '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 0x2ad96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad9b60>, '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': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', '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 17:04:29 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 17:04:29 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 17:04:29 INFO - Using env: {'DISPLAY': ':0', 17:04:29 INFO - 'HOME': '/home/cltbld', 17:04:29 INFO - 'LANG': 'en_US.UTF-8', 17:04:29 INFO - 'LANGUAGE': 'en_US:en', 17:04:29 INFO - 'LOGNAME': 'cltbld', 17:04:29 INFO - 'MAIL': '/var/mail/cltbld', 17:04:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:29 INFO - 'MOZ_NO_REMOTE': '1', 17:04:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:29 INFO - 'NO_EM_RESTART': '1', 17:04:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:29 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:29 INFO - 'SHELL': '/bin/bash', 17:04:29 INFO - 'SHLVL': '1', 17:04:29 INFO - 'TERM': 'linux', 17:04:29 INFO - 'TMOUT': '86400', 17:04:29 INFO - 'USER': 'cltbld', 17:04:29 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', 17:04:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:29 INFO - '_': '/tools/buildbot/bin/python'} 17:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:29 INFO - Downloading/unpacking jsonschema 17:04:29 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 17:04:29 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 17:04:29 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 17:04:29 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 17:04:29 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 17:04:29 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 17:04:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:04:31 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 17:04:31 INFO - Downloading/unpacking functools32 (from jsonschema) 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:31 INFO - Downloading functools32-3.2.3-2.tar.gz 17:04:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:04:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:04:31 INFO - warning: no files found matching '*.txt' 17:04:31 INFO - no previously-included directories found matching 'build' 17:04:31 INFO - no previously-included directories found matching 'dist' 17:04:31 INFO - no previously-included directories found matching '.git*' 17:04:31 INFO - Installing collected packages: jsonschema, functools32 17:04:31 INFO - Running setup.py install for functools32 17:04:31 INFO - warning: no files found matching '*.txt' 17:04:31 INFO - no previously-included directories found matching 'build' 17:04:31 INFO - no previously-included directories found matching 'dist' 17:04:31 INFO - no previously-included directories found matching '.git*' 17:04:31 INFO - Successfully installed jsonschema functools32 17:04:31 INFO - Cleaning up... 17:04:31 INFO - Return code: 0 17:04:31 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:04:31 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')]} 17:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:31 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')]} 17:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:31 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 0x7fe90dc44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c840>, '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 0x2ad96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad9b60>, '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': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', '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 17:04:31 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 17:04:31 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 17:04:31 INFO - Using env: {'DISPLAY': ':0', 17:04:31 INFO - 'HOME': '/home/cltbld', 17:04:31 INFO - 'LANG': 'en_US.UTF-8', 17:04:31 INFO - 'LANGUAGE': 'en_US:en', 17:04:31 INFO - 'LOGNAME': 'cltbld', 17:04:31 INFO - 'MAIL': '/var/mail/cltbld', 17:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:31 INFO - 'MOZ_NO_REMOTE': '1', 17:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:31 INFO - 'NO_EM_RESTART': '1', 17:04:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:31 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:31 INFO - 'SHELL': '/bin/bash', 17:04:31 INFO - 'SHLVL': '1', 17:04:31 INFO - 'TERM': 'linux', 17:04:31 INFO - 'TMOUT': '86400', 17:04:31 INFO - 'USER': 'cltbld', 17:04:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', 17:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:31 INFO - '_': '/tools/buildbot/bin/python'} 17:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:31 INFO - Downloading/unpacking flake8 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:04:33 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 17:04:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:04:33 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 17:04:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:33 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 17:04:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:04:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:04:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:34 INFO - no previously-included directories found matching 'docs/_build' 17:04:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:04:34 INFO - Running setup.py install for pep8 17:04:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:34 INFO - no previously-included directories found matching 'docs/_build' 17:04:34 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:04:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:04:34 INFO - Cleaning up... 17:04:34 INFO - Return code: 0 17:04:34 INFO - Running post-action listener: _resource_record_post_action 17:04:34 INFO - Running post-action listener: _start_resource_monitoring 17:04:34 INFO - Starting resource monitoring. 17:04:34 INFO - ##### 17:04:34 INFO - ##### Running install step. 17:04:34 INFO - ##### 17:04:34 INFO - Running pre-action listener: _resource_record_pre_action 17:04:34 INFO - Running main action method: install 17:04:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:04:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:04:34 INFO - Reading from file tmpfile_stdout 17:04:34 INFO - Detecting whether we're running mozinstall >=1.0... 17:04:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:04:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:04:34 INFO - Reading from file tmpfile_stdout 17:04:34 INFO - Output received: 17:04:34 INFO - Usage: mozinstall [options] installer 17:04:34 INFO - Options: 17:04:34 INFO - -h, --help show this help message and exit 17:04:34 INFO - -d DEST, --destination=DEST 17:04:34 INFO - Directory to install application into. [default: 17:04:34 INFO - "/builds/slave/test-pgo"] 17:04:34 INFO - --app=APP Application being installed. [default: firefox] 17:04:34 INFO - mkdir: /builds/slave/test-pgo/build/application 17:04:34 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'] 17:04:34 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 17:04:50 INFO - Reading from file tmpfile_stdout 17:04:50 INFO - Output received: 17:04:50 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:04:50 INFO - Running post-action listener: _resource_record_post_action 17:04:50 INFO - ##### 17:04:50 INFO - ##### Running run-tests step. 17:04:50 INFO - ##### 17:04:50 INFO - Running pre-action listener: _resource_record_pre_action 17:04:50 INFO - Running main action method: run_tests 17:04:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:04:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:04:50 INFO - Python 2.7.3 17:04:50 INFO - Return code: 0 17:04:50 INFO - grabbing minidump binary from tooltool 17:04:50 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')]} 17:04:50 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 0x2b6c840>, '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 0x2ad96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad9b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:04:50 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 17:04:50 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 17:04:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:04:50 INFO - Return code: 0 17:04:50 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:04:50 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:04:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:04:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:04:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:04:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:04:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:04:51 INFO - Return code: 0 17:04:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 17:04:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:04:51 INFO - Using env: {'DISPLAY': ':0', 17:04:51 INFO - 'HOME': '/home/cltbld', 17:04:51 INFO - 'LANG': 'en_US.UTF-8', 17:04:51 INFO - 'LANGUAGE': 'en_US:en', 17:04:51 INFO - 'LOGNAME': 'cltbld', 17:04:51 INFO - 'MAIL': '/var/mail/cltbld', 17:04:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:04:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:51 INFO - 'MOZ_NO_REMOTE': '1', 17:04:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:51 INFO - 'NO_EM_RESTART': '1', 17:04:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:51 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:04:51 INFO - 'SHELL': '/bin/bash', 17:04:51 INFO - 'SHLVL': '1', 17:04:51 INFO - 'TERM': 'linux', 17:04:51 INFO - 'TMOUT': '86400', 17:04:51 INFO - 'USER': 'cltbld', 17:04:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130', 17:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:51 INFO - '_': '/tools/buildbot/bin/python'} 17:04:51 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:04:51 INFO - mozversion application_buildid: 20160114143022 17:04:51 INFO - mozversion application_changeset: b6ef37a7673e9829de96d0439244343948545955 17:04:51 INFO - mozversion application_display_name: Nightly 17:04:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:04:51 INFO - mozversion application_name: Firefox 17:04:51 INFO - mozversion application_remotingname: firefox 17:04:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:04:51 INFO - mozversion application_vendor: Mozilla 17:04:51 INFO - mozversion application_version: 46.0a1 17:04:51 INFO - mozversion platform_buildid: 20160114143022 17:04:51 INFO - mozversion platform_changeset: b6ef37a7673e9829de96d0439244343948545955 17:04:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:04:51 INFO - mozversion platform_version: 46.0a1 17:04:51 INFO - using testdate: 1452819891 17:04:51 INFO - actual date: 1452819891 17:04:51 INFO - starting webserver on 'localhost:52477' 17:04:51 INFO - SUITE-START | Running 3 tests 17:04:51 INFO - TEST-START | dromaeo_css 17:04:51 INFO - operating with platform_type : linux_ 17:04:51 INFO - Initialising browser for dromaeo_css test... 17:04:51 INFO - TEST-INFO | started process 31507 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxET77E/profile http://localhost:52477/getInfo.html) 17:04:55 INFO - PROCESS | 31507 | 17:04:55 INFO - PROCESS | 31507 | (process:31593): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:04:56 INFO - PROCESS | 31507 | __metrics Screen width/height:1600/1200 17:04:56 INFO - PROCESS | 31507 | colorDepth:24 17:04:56 INFO - PROCESS | 31507 | Browser inner width/height: 1024/697 17:04:56 INFO - PROCESS | 31507 | __metrics 17:04:56 INFO - PROCESS | 31507 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:04:57 INFO - TEST-INFO | 31507: exit 0 17:04:57 INFO - Browser initialized. 17:04:57 INFO - Running cycle 1/1 for dromaeo_css test... 17:04:57 INFO - TEST-INFO | started process 31642 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxET77E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:58 INFO - PROCESS | 31642 | 17:04:58 INFO - PROCESS | 31642 | (process:31699): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:05:09 INFO - PROCESS | 31642 | RSS: Main: 150810624 17:05:09 INFO - PROCESS | 31642 | 17:05:58 INFO - PROCESS | 31642 | 1452819958664 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] 17:08:07 INFO - PROCESS | 31642 | Cycle 1(1): loaded http://localhost:52477/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52477/tests/dromaeo/cssquery-ext.html) 17:08:08 INFO - PROCESS | 31642 | RSS: Main: 155279360 17:08:08 INFO - PROCESS | 31642 | 17:11:10 INFO - PROCESS | 31642 | Cycle 1(1): loaded http://localhost:52477/tests/dromaeo/cssquery-ext.html (next: http://localhost:52477/tests/dromaeo/cssquery-jquery.html) 17:11:11 INFO - PROCESS | 31642 | RSS: Main: 153374720 17:11:11 INFO - PROCESS | 31642 | 17:14:13 INFO - PROCESS | 31642 | Cycle 1(1): loaded http://localhost:52477/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52477/tests/dromaeo/cssquery-mootools.html) 17:14:13 INFO - PROCESS | 31642 | RSS: Main: 152870912 17:14:13 INFO - PROCESS | 31642 | 17:17:15 INFO - PROCESS | 31642 | Cycle 1(1): loaded http://localhost:52477/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52477/tests/dromaeo/cssquery-prototype.html) 17:17:16 INFO - PROCESS | 31642 | RSS: Main: 150528000 17:17:16 INFO - PROCESS | 31642 | 17:20:18 INFO - PROCESS | 31642 | Cycle 1(1): loaded http://localhost:52477/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52477/tests/dromaeo/cssquery-yui.html) 17:20:19 INFO - PROCESS | 31642 | RSS: Main: 151597056 17:20:19 INFO - PROCESS | 31642 | 17:23:21 INFO - PROCESS | 31642 | Cycle 1(1): loaded http://localhost:52477/tests/dromaeo/cssquery-yui.html (next: http://localhost:52477/tests/dromaeo/cssquery-dojo.html) 17:23:21 INFO - PROCESS | 31642 | RSS: Main: 153591808 17:23:21 INFO - PROCESS | 31642 | 17:23:21 INFO - PROCESS | 31642 | __start_tp_report 17:23:21 INFO - PROCESS | 31642 | _x_x_mozilla_page_load 17:23:21 INFO - PROCESS | 31642 | _x_x_mozilla_page_load_details 17:23:21 INFO - PROCESS | 31642 | |i|pagename|runs| 17:23:21 INFO - PROCESS | 31642 | |0;dojo.html;3184.745220382369;3191.2500562367827;3215.0515597898616;3232.127325622082;3237.676232376762;5213.322268105141;5296.973515132424;5300.946990530103;5318.388385335687;5337.306150200473;5295.338082739658;5336.8132115375965;5340.439253878345;5380.354357477098;5467.6719396836115;4883.755812209384;4922.778474968635;4960.206366981283;4971.552560269575;5012.423571289294;4968.205087186051;4982.451930287665;5023.296738456619;5028.120078986181;5037.992401519692;4828.082664293791;4830.058138662962;4846.055019271261;4900;4924.852254432372;4862.222044472867;4877.902441951177;4878.292647566119;4894.290327902434;4933.80264789408;4775.355327030841;4847.636427267969;4849.224124140156;4858.684185527929;4862.805487780484;5104.69371837691;5173.76718047685;5212.843614691566;5249.842504724865;5292.153255479144;5796.043652797283;5800.303963524404;5802.477777000048;5804.88390232193;5819.0689489681445;5688.886222275572;5842.328132264802;5856.560757943172;5864.618799778001;5875.529957603381;5382.4886635769935;5395.190721391783;5434.456554344573;5449.155380915964;5485.451454854483;5960.433758792908;5960.910586341209;5970.194023806817;5992.101184822312;5992.700364981733;5535.833924982257;5604.963081829875;5752.338481074647;5760.193572899798;5761.222234998306;5763.481286684135;5795.565332600072;5814.127880817827;5821.592488525847;5841.883162336814;5654.46282603152;5660.85847853807;5687.829365119053;5691.146328050825;5707.942920570741;5619.466150715675;5620.91568626471;5674.546036317085;5684.261046063985;5690.800821971294;4436;4440.023194897118;4445.933311000337;4476.7090139140855;4501.099780044005;3987.063040185554;3994.201159768;4001.6198461146146;4007.3788562772816;4041.4341992121126;5291.444398338196;5351.277577527062;5373.838784836383;5415.864603384947;5489.58828087895;5770.16332631766;5830.300363956352;5831.067029275296;5870.090136028923;5870.119482077723;5411.134218525017;5417.891642167214;5418.593605479605;5424.566034717213;5427.457254274541;4812.302216178635;4896.436909755353;4934.851954441372;4938.308636790852;4985.725785081783;5823.970880145572;5828.912566311508;5863.7947671832135;5877.94122058774;5943.613665111754;5721.199032135588;5755.740991655469;5777.162311464898;5788.797392091256;5793.79721709755;5637.689927053887;5744.4829965303325;5761.049426844524;5857.26784151981;5938.109283607493;5679.716014199191;5682.119271512922;5713.400092990342;5721.599488035964;5772;5677.31872175325;5708.828735137952;5725.8568535786935;5726.627769194989;5728.713564321684;5527.143292789624;5609.49514543693;5613;5620.213170156099;5621.213030175861;5611.971940140274;5614.494695477427;5630.85922851932;5645.125005624135;5698.544116470755;5538.224648549126;5541.168824676331;5544.223808666709;5547.944520554743;5559.054960656779;5578.525825304894;5589.720513974366;5599.720013999366;5632.2678051853;5698.743556540048;5471;5544.140658197985;5556.611037227355;5598.832035038955;5605.103183490785 17:23:21 INFO - PROCESS | 31642 | |1;ext.html;536.4099490560384;537.9731013449326;559.7956745787787;562.9240052592904;571.0121489822607;34531.82734086329;35274.2945141097;35473;35550.64449355505;35692.82153589232;39467.60532394675;39896.40155397671;39899.40150897739;39930.80034599823;40032.19935601286;8358.164183581654;8526.147385261454;8572.14278572144;8578.39951203416;8594.140585941419;8344.833103337929;8463.95768021159;8472.74581762548;8711.433756805787;8737.868931966026;8751.781205469882;8790.164934331227;8826;8848.823023539526;8851.645934162658;8746.956265218665;8795.120487951217;8796.736097917073;8807.955960220223;8814.16265454784;8475.618597163142;8622.913770862273;8632.266257368132;8649.351298652564;8671.176238257356;38458.23083538313;38726.806365968274;38834.53402858651;38963.41554876679;39071.21857562861;3246.2446085964907;3290.176685470038;3472.2708231271463;3527.3121741260466;3726.720495962814;29949.401011979855;30091.548626770615;30241.848790756125;30311.24221894448;31234.687653123405;3761.755485893408;3997.480327557428;4096.549379568245;4103.363978583325;4105.2405305018665;249382;249548;249988.75005625037;250182;251008;42291.71353580803;42562.78718606387;42824.357634635504;54060.18909716357;54192.45807541953;41321.79339103285;41404;41470.79264603658;41488.79255603763;41585.37621935673;14585.635359115895;14672.413103475956;14802.259887005823;14811.851881481047;14835.332410041574;10690.78618427627;10749.62376316825;10800.729981750363;10823;10846.728831779112;14234.786478202835;14422;14422.783658245135;14471.131732096108;14539.491117811038;5646.85882852932;5655;5723.59934804568;5776.711164441761;5791.739371728282;944.8110377924443;984.1388784813288;993.8161440133598;1033.3231733214757;1072.4691277817374;27748.167554973385;27977.300567485974;28166.2958426041;28616.85691571529;28714.282142946176;1060.612876300145;1067.1302888146136;1074.1943542343242;1129.062877811431;1167.7197472606683;14677.48628797987;14717.705645887023;14862.182579958206;15087.170205638795;15114.773278400833;325883;326251;327518;328403;329705;49512.75243623831;49768.75115624399;49996.250056249184;50024.74987625039;50122.49877501178;1331.6870535424168;1355.5662188099911;1363.3183408295852;1370.465518447806;1371.3349025722516;26992.73007269902;27447.313817154733;27747;27958.3010424741;28226.15321540357;46580.30129548127;46735.53264467448;47073.05853882834;47179.292310614685;47200.29199562078;295125;295884;296544;299760;300044;32192.19519512031;40835.38746918739;42625.786871065444;42685;42854;40298;41485.377719334836;41520.1695966085;41777.373339399324;42311.7884410576;34490.65509344975;34876;34884.7718029821;35284.294314114086;35495;34568;34927.12682182966;35111.297774044884;36980.63019369772;38628;32573.674263258014;32788.83605581957;33366.49950250797;33451.33097337991;33487.49768753519;30089.247768805955;32029.67970320267;32391.67608323981;32396.676033239364;32683.673163268064;24517.877410613546;24838.37904052413;24906.875465622557;25059.74940250647;25339.493210135326 17:23:21 INFO - PROCESS | 31642 | |2;jquery.html;365.22936603766055;366.52717993787996;367.10975883482547;367.90802299425144;369.18226129123985;15163.241837908101;16232.431864884731;16720.163991800422;17051;17739.2017359219;11314.603988860392;11482.770344593104;16312.265948032338;16397.672046559062;16480.917595412036;4682.929756053653;5322.467753224666;5355.651882627617;5359.08895487766;5362.946370536303;4375.562443755631;5142.562882155022;5239.056969745444;5288.101022826128;5291.126964050927;4892.510748925115;4897.730624815634;5060.342155519796;5194.662346947455;5244.213367994793;5183.481651834824;5194.740262986855;5210.374755029383;5225.425203227642;5486.780528778844;5226.660267082628;5266.578673706094;5267.815626453055;5271.446498117681;5278.340207474066;11850.407479625985;12890.742185156245;12895.871041289562;12948.352582370844;12988.155769874928;2074.979250207494;2111.28216406421;2174.945626359338;2186.8906554672203;2264.8754318512474;9822.557984890696;9946.254030947708;10645.361278323326;10665.253432259746;13038.543650972266;1734.17626627351;1756.7452719355622;1767.7260024696193;1794.9551261218444;1881.6613009658256;53053;54448.45551544474;55221;55416;55562.44437555654;9833.016698330253;9928.453935033498;10162.593496260066;10228.795424091477;10310.32982856112;13231.73536529264;13343.132696374705;13355.198688078746;13355.46578136883;13372.398242079129;7524.811879702942;7543.660535275926;7603.315701586884;7608.543487390663;7671.34793542544;7323.340899319087;7325.120985481776;7327.047483827068;7343;7351;4382.320740285261;4409.096135292321;4427.358033085185;4463.732176069446;4487.528809475023;1749.2478234359094;1775.5383600264024;1826.9908650456928;1855.9814401855808;1872.7939926608062;860.0840105287848;886.1183122792862;889.1419779912416;915.5925613102106;934.3879758758025;15233.923830380778;15657.921710391603;16646.6670666586;16911.49265522036;17298.308067677153;898.4788822482944;935.2284365398438;971.8736564246744;1000.2248257600418;1033.5297439664935;8889.911100889038;8933.776655583533;8984.101589841095;9002.639894404281;9163.450192988443;373640;380963;385157;556269;558582;45783.771081145045;59582;61303;65871.67064164649;71514;1135.8353038809325;1166.5567084508002;1174.0724827386268;1174.2895548193562;1182.0307347974579;10257.692269231935;15051.021683590532;15074.698506030038;15171.16558589244;15302.693946120793;32535.51196732098;34150.82924585361;34557.65442345645;34678.47982280318;36176.457353139194;43276.78361608172;44414.3337849926;44416.7779161115;45858.08283834371;46774.06451870876;10279.691609251735;10335.586576536854;10456.68629941103;10563.68308950702;10690.465476726287;11628.767424651629;11870.940645296718;12043.458044387848;12053.51785928553;12324.445399956845;7666.080070391588;7748.380129589506;7752.612369381395;8006.599670016592;8023.1976802319305;7733.342665873463;7856.764297071097;7951.2843844051995;8052;8110.107888132418;7649.196834332315;7727.49771264866;7732.613369331399;7929.5242285463055;7973.0455006260445;10362.792744145225;10385.584576616851;10513.684589462327;10673.252872298865;10698;7665.540067595962;10813.134949204203;10890.153881522647;11032.779344413228;11059.612913547988 17:23:21 INFO - PROCESS | 31642 | |3;mootools.html;1460.4450308882626;1470.0591621362323;1622.3753854765919;1734.124267245041;1763.7266223735326;7492.400607951365;7614.505057171287;7639;7656.846863062736;7891.4081443891655;7849.80375490613;7905.367570594353;7915.248051435119;7965.9601701991405;7969.521828690283;2265;2299.1493147535434;2300.4478925058033;2304.147465437782;2308.0998410619873;2320.14154762738;2376.6910301660846;2420.2860156253946;2423.4183795889035;2434.853908765471;2357.9882100589475;2358.905643774247;2359.079958816063;2378.4410663494064;2399;2360.032386721436;2374.299581623425;2378.0250097459957;2380.9047638094544;2382.6664267002634;2358.516504116652;2388.092524840567;2391.4380120671626;2396.209250947183;2402.459446624513;7812.179721129256;7822.452428330019;7873.370130389555;7917.089534703525;7924.920750792476;4729.6452766042685;4811.422629284473;4813.807447702087;4819.927701084486;4851.514848515156;3110.0358888744563;3128.593282873235;3139.3250451152885;3153.30627262002;3224.790388624732;1058.4919238765358;1073.5491093740648;1076.61529711689;1110.655696734007;1122.231271578971;10440;10678.572857085785;10682.572697092108;10694.144468442506;10695;4440.644748420119;4449.888752781207;4579.22153233951;4603.49361570227;4630.6758526902795;8645.8703119452;8685.739427817176;8730.825383492422;8746.91253087461;8759.16787905148;4853.417589889236;4882.584980276716;4890.902181956341;4899.461059283476;4920.532549407801;4372.846950356722;4453.933191002137;4469.932951005738;4474.530174331713;4485.887852803706;3583.9820800895827;3585.049961760136;3591.353556359828;3644.562652481719;3676.7058635309113;1092.6121226964472;1095.2333366643381;1107.7950579142885;1120.0591503137405;1122.2088427658482;1233.7409144079843;1239.2192918461312;1254.6737848159544;1266.7783137951005;1269.225772278909;6929.064576282138;6940.444764418834;6992.650367481606;7178.461615378763;7180.640967951582;508.54231191926823;512.3723438787456;513.4788189987166;519.948005199477;522.4435975685882;5578.358488773762;5671.914921276184;5680.7727690892725;5693.373728889819;5697.829065128053;9003.504807235666;9496.43021418717;9524.285678574135;9537.952310238543;9658.082482164184;9327.673531426368;9350.485723285285;9361.063893610584;9397.295202859812;9451.480168590793;7246.804277294293;7427.517211381243;7438.5536867788105;7448.702051917971;7455.254474552501;7053.470989675692;7060.470464715064;7154.069970903957;7158.785236442915;7170.354668079689;7885.2114788520685;7910.723124690839;8048.476849004796;8080.515169089874;8167.714130005421;8121.066077400938;8159.46963447374;8170.7957301067945;8225.753227403187;8260.256576908107;6554.737810487527;6704.597724136567;6731.158605174353;6771.966140169267;6895.931040689529;7408.703651853865;7432.442566807619;7453.962730186531;7475.7009719610605;7491.438142139253;6946.235914049349;7020.508564400443;7145.17830449505;7200.747973820891;7239.746608868664;6864.416524595265;7022.648867556704;7056.259092795182;7064.858702826017;7084.185318688416;6857.108575885302;6956.617386043817;7046.682899269647;7078.398336141486;7169.677364518713;6546.705398257185;6571;6587.374199451045;6590.209174899042;6621.50338724588;6573.57271777333;6575.210974683068;6586.110875031809;6619.536632435876;6665.50008749336 17:23:21 INFO - PROCESS | 31642 | |4;prototype.html;343.8847985924715;348.22867348822354;350.2959052304868;353.58630402429156;356.0813102196334;6263.498920086394;6274.811755647333;6281.43467087962;6323.30443651198;6469.6441695706835;6277.968610156943;6297.055441683749;6326.304106548288;6334.429901308881;6348.841278968028;4805.471398146201;4813.157697402958;4813.8074477021055;4827.25177597473;4828.444728856191;4808.302796094564;4811.30236115763;4824.565789078983;4841.588464980481;4849.563539281464;4705.458872229686;4793.4487533933525;4803.039392121572;4806.975965120169;4812.10975969445;4789.832355867528;4798.47216806151;4801.663883528172;4802.06359759847;4808.447028591687;4150.335946248616;4166.041810383629;4167.270727622654;4171.144915292358;4173.227952828736;5962.926673198823;6019.097135429677;6025.6083354581815;6033.034714445712;6033.5474839387225;5396.757145928443;5542;5579.107342825128;5585.944140558624;5586.329640443132;6677;6702.128723265993;6705.463562915004;6721.495887808385;6726.0919775830125;4575.313702944552;4589.219832628428;4595.448546174447;4598.425196850394;4629.421322334708;6751.493637977172;6921.861562768717;6975.616341101238;7002.75490357835;7027.683754231072;4646.6747327686735;4686.718796872198;4694.741789201558;4696.624270058387;4707.552782485658;4745.691530050535;4752.596029337476;4754.310624959361;4779.545943135397;4790.353302304214;5521.723913804293;5542.667439953616;5551.25058117149;5563.860903477445;5568.470995255444;6502.414782669583;6689.297623749533;6690.632015239111;6703.061571380011;6704.865902681919;1627.7721119043345;1650.8514233719022;1659.8921070130402;1666.7083260429376;1666.7416550434702;1092.1754075672816;1128.1764312052085;1130.559081958037;1133.7335726104359;1139.6865861888048;6239.376062393724;6262.780802671885;6278.6860656966965;6288.937110628926;6310.463610593151;6790.558613690095;6796.150481189851;6799.354061364163;6811.773880701521;6818.318168183142;6153.353897840751;6277.7175027123885;6330.905036424458;6340.397662222082;6341.778037768749;3697.2975134724315;3704.9629503705155;3712.832922518493;3713.3687273163628;3726.9813650931574;6928.618925959121;6967.198772141167;6969.9303006969285;6976.372126508639;6992.3357281058215;6771.661416929134;6966;6970.581765094009;6996.160460744743;7017.824554386181;6948.062011628466;6969.16370035599;6970.512064155562;6977.616231107237;6989.4408447324095;6791.117154769849;6795.184577850492;6806.591604503746;6835.213950395768;6836.48726345536;6622.90065649006;6706.161729783777;6729;6734.124563806674;6738.966305168443;6869.690863911036;6928.1339832520935;6941.167059952838;6967.268436814062;6970.79087627372;4588.288815233511;4589.2886602576655;4615.676902616785;4640.582347588733;4648.535146485325;6649.60102393858;6692.0965669635925;6789.694463749044;6803.149606299213;6808.523403361717;6740.629265390255;6776.220734615582;6780.186377634715;6783.59298442095;6784.118064651564;6670.83322916931;6707.66461676924;6713.295104014203;6730.596164229966;6749.831254218684;6503.869922601616;6623.238327592196;6635.966820165868;6665.900011499734;6700.564463309869;6730.730770769114;6756;6786.728530858908;6797.5581587196675;6808.455323574003;6563.474922006323;6567;6616.603003819786;6621.768238111643;6638.502112341497 17:23:21 INFO - PROCESS | 31642 | |5;yui.html;845.0957475501215;850.9106543812895;853.4836423963502;861.7027125641652;895.6730793260461;13197.604071877848;13406.865931340684;13458.192508449476;13460.192388456675;13463;12685.238885666866;12733.108682392212;12763.298018608974;12780.872191278084;12795.552155674553;642.935706429358;651.6383407208997;800.2437696376926;821.6097353756977;825.7605294464598;809.0655293136437;814.4990830639144;816.2042009041168;818.1491249100958;819.7253919936828;851.1190917400492;854.4958474500044;859.0764927702744;861.0571424290392;861.5476874640801;851.3019324154166;851.4678326046252;852.5438890193778;856.4989481153533;856.6102423397401;627.3663599764226;635.9586626869238;636.8885445047098;637.1525870592102;637.5537124013209;13479;13483.393247303895;13515.729685406335;13516.93241533786;13573.185608863401;12794.168379055425;12988.155769874928;13045.804312935314;13139.934300328532;13323.000774941918;10537.73655658607;10576.153907687367;10682.092022178047;10939.890601093966;10991.06575941046;3538.168530395355;3637.6344891285144;3650.7444478886487;3736.532933383327;3750.3999360102252;45374.77312613449;45800;45976.3103553447;46121;46572;9467.43195408264;9511.809763804824;9513.429194248367;9863.457509837028;9924;17915;18203;18255.817441825413;18476.815231847777;18483.16825742845;7013.649317534103;7064.258252883476;7510.211427800003;7569.053868266466;7877.172896845863;4176.498820141542;4252.21334053195;4271.786410679453;4278.229918614679;4368.104538569585;2952.129121909042;2971.435427268812;2974.9702502975124;3006.413749318862;3023.1232942446445;546.469924173551;567.8381661226531;569.4931510955253;593.5963544789498;594.8334466349429;531.5773959702046;561.9874098933617;591.6036255708685;623.8676801605072;689.2934741889503;8600.698975535826;8693;8741.344399170088;8762.4742515448;8925.062868398854;560.8822147349102;577.3158806813939;598.7994022002591;661.0645936000506;694.0912490650711;4023.6177563131455;4117.402976568381;4123.60825721556;4219.51475580306;4282.293421585404;54517.454825452034;56557.7172114145;56792.43207567954;57256;57761.71119144378;49807.750961245685;50780.23829642558;51035.489645103815;51327.230091548656;51329.743351283;45375.54624453779;45823.541764582595;46167.07665846664;46554.53445465502;46621.76689116532;8261.104420954503;8317.41778075529;8341.165883411853;8611.48331100136;8726.345524085593;34024;34323.313533729684;35282.64717352896;35319.646803531636;35550.46674299939;39895.80052099721;40433.59566404416;42870;42879.3568096485;43183.35224971565;8651.134886511298;8705.260052895575;9454.621815127319;9899.752506187402;10101.191904647463;10620.309679871092;10758.300710454108;11161.162912781412;11788.764224715285;11914.76170476603;10807.278024735944;10981.560737570408;11118.110551156049;11149.442527873736;11308.426041604931;10883.183761218099;11131.10951123892;11281.92821681939;11318.26431281964;11517.94241028823;10323.432211228455;10608.204384671335;10624.203184761329;10700.785984280115;11197.60808371703;8701.34739894523;8745.737627871174;8781.467089375052;8862.379633425857;9185.035571264922;9062.32032597571;9324.440533568008;9345.906540934775;9356.298277629068;9476.857847132436 17:23:21 INFO - PROCESS | 31642 | __end_tp_report 17:23:21 INFO - PROCESS | 31642 | __start_cc_report 17:23:21 INFO - PROCESS | 31642 | _x_x_mozilla_cycle_collect,295 17:23:21 INFO - PROCESS | 31642 | __end_cc_report 17:23:21 INFO - PROCESS | 31642 | __startTimestamp1452821001782__endTimestamp 17:23:21 INFO - PROCESS | 31642 | 17:23:21 INFO - PROCESS | 31642 | ------- Summary: start ------- 17:23:21 INFO - PROCESS | 31642 | Number of tests: 6 17:23:21 INFO - PROCESS | 31642 | 17:23:21 INFO - PROCESS | 31642 | [#0] dojo.html Cycles:165 Average:5343.02 Median:5547.94 stddev:584.92 (10.5%) stddev-sans-first:561.68 17:23:21 INFO - PROCESS | 31642 | Values: 3184.7 3191.3 3215.1 3232.1 3237.7 5213.3 5297.0 5300.9 5318.4 5337.3 5295.3 5336.8 5340.4 5380.4 5467.7 4883.8 4922.8 4960.2 4971.6 5012.4 4968.2 4982.5 5023.3 5028.1 5038.0 4828.1 4830.1 4846.1 4900.0 4924.9 4862.2 4877.9 4878.3 4894.3 4933.8 4775.4 4847.6 4849.2 4858.7 4862.8 5104.7 5173.8 5212.8 5249.8 5292.2 5796.0 5800.3 5802.5 5804.9 5819.1 5688.9 5842.3 5856.6 5864.6 5875.5 5382.5 5395.2 5434.5 5449.2 5485.5 5960.4 5960.9 5970.2 5992.1 5992.7 5535.8 5605.0 5752.3 5760.2 5761.2 5763.5 5795.6 5814.1 5821.6 5841.9 5654.5 5660.9 5687.8 5691.1 5707.9 5619.5 5620.9 5674.5 5684.3 5690.8 4436.0 4440.0 4445.9 4476.7 4501.1 3987.1 3994.2 4001.6 4007.4 4041.4 5291.4 5351.3 5373.8 5415.9 5489.6 5770.2 5830.3 5831.1 5870.1 5870.1 5411.1 5417.9 5418.6 5424.6 5427.5 4812.3 4896.4 4934.9 4938.3 4985.7 5824.0 5828.9 5863.8 5877.9 5943.6 5721.2 5755.7 5777.2 5788.8 5793.8 5637.7 5744.5 5761.0 5857.3 5938.1 5679.7 5682.1 5713.4 5721.6 5772.0 5677.3 5708.8 5725.9 5726.6 5728.7 5527.1 5609.5 5613.0 5620.2 5621.2 5612.0 5614.5 5630.9 5645.1 5698.5 5538.2 5541.2 5544.2 5547.9 5559.1 5578.5 5589.7 5599.7 5632.3 5698.7 5471.0 5544.1 5556.6 5598.8 5605.1 17:23:21 INFO - PROCESS | 31642 | 17:23:21 INFO - PROCESS | 31642 | [#1] ext.html Cycles:180 Average:44967.87 Median:35378.65 stddev:76739.52 (216.9%) stddev-sans-first:76882.29 17:23:21 INFO - PROCESS | 31642 | Values: 536.4 538.0 559.8 562.9 571.0 34531.8 35274.3 35473.0 35550.6 35692.8 39467.6 39896.4 39899.4 39930.8 40032.2 8358.2 8526.1 8572.1 8578.4 8594.1 8344.8 8464.0 8472.7 8711.4 8737.9 8751.8 8790.2 8826.0 8848.8 8851.6 8747.0 8795.1 8796.7 8808.0 8814.2 8475.6 8622.9 8632.3 8649.4 8671.2 38458.2 38726.8 38834.5 38963.4 39071.2 3246.2 3290.2 3472.3 3527.3 3726.7 29949.4 30091.5 30241.8 30311.2 31234.7 3761.8 3997.5 4096.5 4103.4 4105.2 249382.0 249548.0 249988.8 250182.0 251008.0 42291.7 42562.8 42824.4 54060.2 54192.5 41321.8 41404.0 41470.8 41488.8 41585.4 14585.6 14672.4 14802.3 14811.9 14835.3 10690.8 10749.6 10800.7 10823.0 10846.7 14234.8 14422.0 14422.8 14471.1 14539.5 5646.9 5655.0 5723.6 5776.7 5791.7 944.8 984.1 993.8 1033.3 1072.5 27748.2 27977.3 28166.3 28616.9 28714.3 1060.6 1067.1 1074.2 1129.1 1167.7 14677.5 14717.7 14862.2 15087.2 15114.8 325883.0 326251.0 327518.0 328403.0 329705.0 49512.8 49768.8 49996.3 50024.7 50122.5 1331.7 1355.6 1363.3 1370.5 1371.3 26992.7 27447.3 27747.0 27958.3 28226.2 46580.3 46735.5 47073.1 47179.3 47200.3 295125.0 295884.0 296544.0 299760.0 300044.0 32192.2 40835.4 42625.8 42685.0 42854.0 40298.0 41485.4 41520.2 41777.4 42311.8 34490.7 34876.0 34884.8 35284.3 35495.0 34568.0 34927.1 35111.3 36980.6 38628.0 32573.7 32788.8 33366.5 33451.3 33487.5 30089.2 32029.7 32391.7 32396.7 32683.7 24517.9 24838.4 24906.9 25059.7 25339.5 17:23:21 INFO - PROCESS | 31642 | 17:23:21 INFO - PROCESS | 31642 | [#2] jquery.html Cycles:180 Average:24570.44 Median:23826.17 stddev:75058.52 (315.0%) stddev-sans-first:75247.08 17:23:21 INFO - PROCESS | 31642 | Values: 365.2 366.5 367.1 367.9 369.2 15163.2 16232.4 16720.2 17051.0 17739.2 11314.6 11482.8 16312.3 16397.7 16480.9 4682.9 5322.5 5355.7 5359.1 5362.9 4375.6 5142.6 5239.1 5288.1 5291.1 4892.5 4897.7 5060.3 5194.7 5244.2 5183.5 5194.7 5210.4 5225.4 5486.8 5226.7 5266.6 5267.8 5271.4 5278.3 11850.4 12890.7 12895.9 12948.4 12988.2 2075.0 2111.3 2174.9 2186.9 2264.9 9822.6 9946.3 10645.4 10665.3 13038.5 1734.2 1756.7 1767.7 1795.0 1881.7 53053.0 54448.5 55221.0 55416.0 55562.4 9833.0 9928.5 10162.6 10228.8 10310.3 13231.7 13343.1 13355.2 13355.5 13372.4 7524.8 7543.7 7603.3 7608.5 7671.3 7323.3 7325.1 7327.0 7343.0 7351.0 4382.3 4409.1 4427.4 4463.7 4487.5 1749.2 1775.5 1827.0 1856.0 1872.8 860.1 886.1 889.1 915.6 934.4 15233.9 15657.9 16646.7 16911.5 17298.3 898.5 935.2 971.9 1000.2 1033.5 8889.9 8933.8 8984.1 9002.6 9163.5 373640.0 380963.0 385157.0 556269.0 558582.0 45783.8 59582.0 61303.0 65871.7 71514.0 1135.8 1166.6 1174.1 1174.3 1182.0 10257.7 15051.0 15074.7 15171.2 15302.7 32535.5 34150.8 34557.7 34678.5 36176.5 43276.8 44414.3 44416.8 45858.1 46774.1 10279.7 10335.6 10456.7 10563.7 10690.5 11628.8 11870.9 12043.5 12053.5 12324.4 7666.1 7748.4 7752.6 8006.6 8023.2 7733.3 7856.8 7951.3 8052.0 8110.1 7649.2 7727.5 7732.6 7929.5 7973.0 10362.8 10385.6 10513.7 10673.3 10698.0 7665.5 10813.1 10890.2 11032.8 11059.6 17:23:21 INFO - PROCESS | 31642 | 17:23:21 INFO - PROCESS | 31642 | [#3] mootools.html Cycles:180 Average:5456.53 Median:6550.72 stddev:2789.74 (42.6%) stddev-sans-first:2781.40 17:23:21 INFO - PROCESS | 31642 | Values: 1460.4 1470.1 1622.4 1734.1 1763.7 7492.4 7614.5 7639.0 7656.8 7891.4 7849.8 7905.4 7915.2 7966.0 7969.5 2265.0 2299.1 2300.4 2304.1 2308.1 2320.1 2376.7 2420.3 2423.4 2434.9 2358.0 2358.9 2359.1 2378.4 2399.0 2360.0 2374.3 2378.0 2380.9 2382.7 2358.5 2388.1 2391.4 2396.2 2402.5 7812.2 7822.5 7873.4 7917.1 7924.9 4729.6 4811.4 4813.8 4819.9 4851.5 3110.0 3128.6 3139.3 3153.3 3224.8 1058.5 1073.5 1076.6 1110.7 1122.2 10440.0 10678.6 10682.6 10694.1 10695.0 4440.6 4449.9 4579.2 4603.5 4630.7 8645.9 8685.7 8730.8 8746.9 8759.2 4853.4 4882.6 4890.9 4899.5 4920.5 4372.8 4453.9 4469.9 4474.5 4485.9 3584.0 3585.0 3591.4 3644.6 3676.7 1092.6 1095.2 1107.8 1120.1 1122.2 1233.7 1239.2 1254.7 1266.8 1269.2 6929.1 6940.4 6992.7 7178.5 7180.6 508.5 512.4 513.5 519.9 522.4 5578.4 5671.9 5680.8 5693.4 5697.8 9003.5 9496.4 9524.3 9538.0 9658.1 9327.7 9350.5 9361.1 9397.3 9451.5 7246.8 7427.5 7438.6 7448.7 7455.3 7053.5 7060.5 7154.1 7158.8 7170.4 7885.2 7910.7 8048.5 8080.5 8167.7 8121.1 8159.5 8170.8 8225.8 8260.3 6554.7 6704.6 6731.2 6772.0 6895.9 7408.7 7432.4 7454.0 7475.7 7491.4 6946.2 7020.5 7145.2 7200.7 7239.7 6864.4 7022.6 7056.3 7064.9 7084.2 6857.1 6956.6 7046.7 7078.4 7169.7 6546.7 6571.0 6587.4 6590.2 6621.5 6573.6 6575.2 6586.1 6619.5 6665.5 17:23:21 INFO - PROCESS | 31642 | 17:23:21 INFO - PROCESS | 31642 | [#4] prototype.html Cycles:180 Average:5552.41 Median:6303.76 stddev:1670.56 (26.5%) stddev-sans-first:1628.86 17:23:21 INFO - PROCESS | 31642 | Values: 343.9 348.2 350.3 353.6 356.1 6263.5 6274.8 6281.4 6323.3 6469.6 6278.0 6297.1 6326.3 6334.4 6348.8 4805.5 4813.2 4813.8 4827.3 4828.4 4808.3 4811.3 4824.6 4841.6 4849.6 4705.5 4793.4 4803.0 4807.0 4812.1 4789.8 4798.5 4801.7 4802.1 4808.4 4150.3 4166.0 4167.3 4171.1 4173.2 5962.9 6019.1 6025.6 6033.0 6033.5 5396.8 5542.0 5579.1 5585.9 5586.3 6677.0 6702.1 6705.5 6721.5 6726.1 4575.3 4589.2 4595.4 4598.4 4629.4 6751.5 6921.9 6975.6 7002.8 7027.7 4646.7 4686.7 4694.7 4696.6 4707.6 4745.7 4752.6 4754.3 4779.5 4790.4 5521.7 5542.7 5551.3 5563.9 5568.5 6502.4 6689.3 6690.6 6703.1 6704.9 1627.8 1650.9 1659.9 1666.7 1666.7 1092.2 1128.2 1130.6 1133.7 1139.7 6239.4 6262.8 6278.7 6288.9 6310.5 6790.6 6796.2 6799.4 6811.8 6818.3 6153.4 6277.7 6330.9 6340.4 6341.8 3697.3 3705.0 3712.8 3713.4 3727.0 6928.6 6967.2 6969.9 6976.4 6992.3 6771.7 6966.0 6970.6 6996.2 7017.8 6948.1 6969.2 6970.5 6977.6 6989.4 6791.1 6795.2 6806.6 6835.2 6836.5 6622.9 6706.2 6729.0 6734.1 6739.0 6869.7 6928.1 6941.2 6967.3 6970.8 4588.3 4589.3 4615.7 4640.6 4648.5 6649.6 6692.1 6789.7 6803.1 6808.5 6740.6 6776.2 6780.2 6783.6 6784.1 6670.8 6707.7 6713.3 6730.6 6749.8 6503.9 6623.2 6636.0 6665.9 6700.6 6730.7 6756.0 6786.7 6797.6 6808.5 6563.5 6567.0 6616.6 6621.8 6638.5 17:23:21 INFO - PROCESS | 31642 | 17:23:21 INFO - PROCESS | 31642 | [#5] yui.html Cycles:180 Average:13490.54 Median:48214.76 stddev:15584.53 (32.3%) stddev-sans-first:15599.31 17:23:21 INFO - PROCESS | 31642 | Values: 845.1 850.9 853.5 861.7 895.7 13197.6 13406.9 13458.2 13460.2 13463.0 12685.2 12733.1 12763.3 12780.9 12795.6 642.9 651.6 800.2 821.6 825.8 809.1 814.5 816.2 818.1 819.7 851.1 854.5 859.1 861.1 861.5 851.3 851.5 852.5 856.5 856.6 627.4 636.0 636.9 637.2 637.6 13479.0 13483.4 13515.7 13516.9 13573.2 12794.2 12988.2 13045.8 13139.9 13323.0 10537.7 10576.2 10682.1 10939.9 10991.1 3538.2 3637.6 3650.7 3736.5 3750.4 45374.8 45800.0 45976.3 46121.0 46572.0 9467.4 9511.8 9513.4 9863.5 9924.0 17915.0 18203.0 18255.8 18476.8 18483.2 7013.6 7064.3 7510.2 7569.1 7877.2 4176.5 4252.2 4271.8 4278.2 4368.1 2952.1 2971.4 2975.0 3006.4 3023.1 546.5 567.8 569.5 593.6 594.8 531.6 562.0 591.6 623.9 689.3 8600.7 8693.0 8741.3 8762.5 8925.1 560.9 577.3 598.8 661.1 694.1 4023.6 4117.4 4123.6 4219.5 4282.3 54517.5 56557.7 56792.4 57256.0 57761.7 49807.8 50780.2 51035.5 51327.2 51329.7 45375.5 45823.5 46167.1 46554.5 46621.8 8261.1 8317.4 8341.2 8611.5 8726.3 34024.0 34323.3 35282.6 35319.6 35550.5 39895.8 40433.6 42870.0 42879.4 43183.4 8651.1 8705.3 9454.6 9899.8 10101.2 10620.3 10758.3 11161.2 11788.8 11914.8 10807.3 10981.6 11118.1 11149.4 11308.4 10883.2 11131.1 11281.9 11318.3 11517.9 10323.4 10608.2 10624.2 10700.8 11197.6 8701.3 8745.7 8781.5 8862.4 9185.0 9062.3 9324.4 9345.9 9356.3 9476.9 17:23:21 INFO - PROCESS | 31642 | -------- Summary: end -------- 17:23:21 INFO - PROCESS | 31642 | 17:23:22 INFO - TEST-INFO | 31642: exit 0 17:23:22 INFO - TEST-OK | dromaeo_css | took 1110495ms 17:23:22 INFO - TEST-START | kraken 17:23:22 INFO - operating with platform_type : linux_ 17:23:22 INFO - Initialising browser for kraken test... 17:23:22 INFO - TEST-INFO | started process 31880 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPJZqzj/profile http://localhost:52477/getInfo.html) 17:23:25 INFO - PROCESS | 31880 | 17:23:25 INFO - PROCESS | 31880 | (process:31954): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:23:26 INFO - PROCESS | 31880 | __metrics Screen width/height:1600/1200 17:23:26 INFO - PROCESS | 31880 | colorDepth:24 17:23:26 INFO - PROCESS | 31880 | Browser inner width/height: 1024/697 17:23:26 INFO - PROCESS | 31880 | __metrics 17:23:26 INFO - PROCESS | 31880 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:23:27 INFO - TEST-INFO | 31880: exit 0 17:23:27 INFO - Browser initialized. 17:23:27 INFO - Running cycle 1/1 for kraken test... 17:23:27 INFO - TEST-INFO | started process 32003 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPJZqzj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:28 INFO - PROCESS | 32003 | 17:23:28 INFO - PROCESS | 32003 | (process:32061): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:23:39 INFO - PROCESS | 32003 | RSS: Main: 150654976 17:23:39 INFO - PROCESS | 32003 | 17:23:41 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52477/tests/kraken/driver.html?testName=audio-beat-detection) 17:23:42 INFO - PROCESS | 32003 | RSS: Main: 152027136 17:23:42 INFO - PROCESS | 32003 | 17:23:45 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52477/tests/kraken/driver.html?testName=audio-dft) 17:23:45 INFO - PROCESS | 32003 | RSS: Main: 155283456 17:23:45 INFO - PROCESS | 32003 | 17:23:48 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52477/tests/kraken/driver.html?testName=audio-fft) 17:23:49 INFO - PROCESS | 32003 | RSS: Main: 149082112 17:23:49 INFO - PROCESS | 32003 | 17:23:51 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52477/tests/kraken/driver.html?testName=audio-oscillator) 17:23:52 INFO - PROCESS | 32003 | RSS: Main: 148746240 17:23:52 INFO - PROCESS | 32003 | 17:23:54 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52477/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:23:54 INFO - PROCESS | 32003 | RSS: Main: 149626880 17:23:54 INFO - PROCESS | 32003 | 17:23:57 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52477/tests/kraken/driver.html?testName=imaging-darkroom) 17:23:58 INFO - PROCESS | 32003 | RSS: Main: 149954560 17:23:58 INFO - PROCESS | 32003 | 17:24:01 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52477/tests/kraken/driver.html?testName=imaging-desaturate) 17:24:02 INFO - PROCESS | 32003 | RSS: Main: 150618112 17:24:02 INFO - PROCESS | 32003 | 17:24:05 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52477/tests/kraken/driver.html?testName=json-parse-financial) 17:24:05 INFO - PROCESS | 32003 | RSS: Main: 149884928 17:24:05 INFO - PROCESS | 32003 | 17:24:07 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52477/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:24:07 INFO - PROCESS | 32003 | RSS: Main: 150122496 17:24:07 INFO - PROCESS | 32003 | 17:24:09 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:24:10 INFO - PROCESS | 32003 | RSS: Main: 150310912 17:24:10 INFO - PROCESS | 32003 | 17:24:12 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:24:13 INFO - PROCESS | 32003 | RSS: Main: 151015424 17:24:13 INFO - PROCESS | 32003 | 17:24:15 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:24:16 INFO - PROCESS | 32003 | RSS: Main: 151027712 17:24:16 INFO - PROCESS | 32003 | 17:24:18 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:24:19 INFO - PROCESS | 32003 | RSS: Main: 150118400 17:24:19 INFO - PROCESS | 32003 | 17:24:20 INFO - PROCESS | 32003 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52477/tests/kraken/driver.html?testName=ai-astar) 17:24:21 INFO - PROCESS | 32003 | RSS: Main: 150994944 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | __start_tp_report 17:24:21 INFO - PROCESS | 32003 | _x_x_mozilla_page_load 17:24:21 INFO - PROCESS | 32003 | _x_x_mozilla_page_load_details 17:24:21 INFO - PROCESS | 32003 | |i|pagename|runs| 17:24:21 INFO - PROCESS | 32003 | |0;ai-astar;113;109;112;112;112;126;114;114;113;114 17:24:21 INFO - PROCESS | 32003 | |1;audio-beat-detection;148;135;151;161;128;159;150;125;177;126 17:24:21 INFO - PROCESS | 32003 | |2;audio-dft;163;168;162;164;162;164;165;169;166;164 17:24:21 INFO - PROCESS | 32003 | |3;audio-fft;73;73;73;77;71;133;71;72;73;75 17:24:21 INFO - PROCESS | 32003 | |4;audio-oscillator;96;97;139;100;99;96;141;95;98;136 17:24:21 INFO - PROCESS | 32003 | |5;imaging-gaussian-blur;110;110;109;110;111;110;109;111;110;109 17:24:21 INFO - PROCESS | 32003 | |6;imaging-darkroom;146;146;146;147;147;147;147;147;146;154 17:24:21 INFO - PROCESS | 32003 | |7;imaging-desaturate;96;96;96;98;96;96;96;96;96;97 17:24:21 INFO - PROCESS | 32003 | |8;json-parse-financial;59;59;59;59;59;58;59;60;55;56 17:24:21 INFO - PROCESS | 32003 | |9;json-stringify-tinderbox;67;68;67;67;77;67;67;67;67;67 17:24:21 INFO - PROCESS | 32003 | |10;stanford-crypto-aes;88;83;82;91;83;81;82;86;93;85 17:24:21 INFO - PROCESS | 32003 | |11;stanford-crypto-ccm;115;115;120;119;118;126;134;121;125;123 17:24:21 INFO - PROCESS | 32003 | |12;stanford-crypto-pbkdf2;146;144;150;148;147;131;143;143;145;143 17:24:21 INFO - PROCESS | 32003 | |13;stanford-crypto-sha256-iterative;68;66;67;67;67;69;69;68;70;67 17:24:21 INFO - PROCESS | 32003 | __end_tp_report 17:24:21 INFO - PROCESS | 32003 | __start_cc_report 17:24:21 INFO - PROCESS | 32003 | _x_x_mozilla_cycle_collect,730 17:24:21 INFO - PROCESS | 32003 | __end_cc_report 17:24:21 INFO - PROCESS | 32003 | __startTimestamp1452821061197__endTimestamp 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | ------- Summary: start ------- 17:24:21 INFO - PROCESS | 32003 | Number of tests: 14 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#0] ai-astar Cycles:10 Average:113.90 Median:113.50 stddev:4.51 (4.0%) stddev-sans-first:4.77 17:24:21 INFO - PROCESS | 32003 | Values: 113.0 109.0 112.0 112.0 112.0 126.0 114.0 114.0 113.0 114.0 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:150.50 stddev:17.28 (11.5%) stddev-sans-first:18.31 17:24:21 INFO - PROCESS | 32003 | Values: 148.0 135.0 151.0 161.0 128.0 159.0 150.0 125.0 177.0 126.0 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:2.36 (1.4%) stddev-sans-first:2.42 17:24:21 INFO - PROCESS | 32003 | Values: 163.0 168.0 162.0 164.0 162.0 164.0 165.0 169.0 166.0 164.0 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#3] audio-fft Cycles:10 Average:79.10 Median:73.00 stddev:19.02 (26.1%) stddev-sans-first:20.05 17:24:21 INFO - PROCESS | 32003 | Values: 73.0 73.0 73.0 77.0 71.0 133.0 71.0 72.0 73.0 75.0 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:96.00 stddev:20.08 (20.9%) stddev-sans-first:20.67 17:24:21 INFO - PROCESS | 32003 | Values: 96.0 97.0 139.0 100.0 99.0 96.0 141.0 95.0 98.0 136.0 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 17:24:21 INFO - PROCESS | 32003 | Values: 110.0 110.0 109.0 110.0 111.0 110.0 109.0 111.0 110.0 109.0 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:2.41 (1.6%) stddev-sans-first:2.51 17:24:21 INFO - PROCESS | 32003 | Values: 146.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 154.0 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 17:24:21 INFO - PROCESS | 32003 | Values: 96.0 96.0 96.0 98.0 96.0 96.0 96.0 96.0 96.0 97.0 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:59.00 stddev:1.57 (2.7%) stddev-sans-first:1.64 17:24:21 INFO - PROCESS | 32003 | Values: 59.0 59.0 59.0 59.0 59.0 58.0 59.0 60.0 55.0 56.0 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:67.00 stddev:3.14 (4.7%) stddev-sans-first:3.31 17:24:21 INFO - PROCESS | 32003 | Values: 67.0 68.0 67.0 67.0 77.0 67.0 67.0 67.0 67.0 67.0 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:4.09 (4.8%) stddev-sans-first:4.23 17:24:21 INFO - PROCESS | 32003 | Values: 88.0 83.0 82.0 91.0 83.0 81.0 82.0 86.0 93.0 85.0 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:122.00 stddev:5.74 (4.7%) stddev-sans-first:5.57 17:24:21 INFO - PROCESS | 32003 | Values: 115.0 115.0 120.0 119.0 118.0 126.0 134.0 121.0 125.0 123.0 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:145.50 stddev:5.14 (3.5%) stddev-sans-first:5.40 17:24:21 INFO - PROCESS | 32003 | Values: 146.0 144.0 150.0 148.0 147.0 131.0 143.0 143.0 145.0 143.0 17:24:21 INFO - PROCESS | 32003 | 17:24:21 INFO - PROCESS | 32003 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 17:24:21 INFO - PROCESS | 32003 | Values: 68.0 66.0 67.0 67.0 67.0 69.0 69.0 68.0 70.0 67.0 17:24:21 INFO - PROCESS | 32003 | -------- Summary: end -------- 17:24:21 INFO - PROCESS | 32003 | 17:24:22 INFO - TEST-INFO | 32003: exit 0 17:24:22 INFO - TEST-OK | kraken | took 59613ms 17:24:22 INFO - TEST-START | v8_7 17:24:22 INFO - operating with platform_type : linux_ 17:24:22 INFO - Initialising browser for v8_7 test... 17:24:22 INFO - TEST-INFO | started process 32289 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0MqzB6/profile http://localhost:52477/getInfo.html) 17:24:25 INFO - PROCESS | 32289 | 17:24:25 INFO - PROCESS | 32289 | (process:32362): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:24:26 INFO - PROCESS | 32289 | __metrics Screen width/height:1600/1200 17:24:26 INFO - PROCESS | 32289 | colorDepth:24 17:24:26 INFO - PROCESS | 32289 | Browser inner width/height: 1024/697 17:24:26 INFO - PROCESS | 32289 | __metrics 17:24:26 INFO - PROCESS | 32289 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:24:27 INFO - TEST-INFO | 32289: exit 0 17:24:27 INFO - Browser initialized. 17:24:27 INFO - Running cycle 1/1 for v8_7 test... 17:24:27 INFO - TEST-INFO | started process 32411 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0MqzB6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:24:28 INFO - PROCESS | 32411 | 17:24:28 INFO - PROCESS | 32411 | (process:32472): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:24:39 INFO - PROCESS | 32411 | RSS: Main: 150880256 17:24:39 INFO - PROCESS | 32411 | 17:25:01 INFO - PROCESS | 32411 | Cycle 1(1): loaded http://localhost:52477/tests/v8_7/run.html (next: http://localhost:52477/tests/v8_7/run.html) 17:25:01 INFO - PROCESS | 32411 | RSS: Main: 147042304 17:25:01 INFO - PROCESS | 32411 | 17:25:01 INFO - PROCESS | 32411 | __start_tp_report 17:25:01 INFO - PROCESS | 32411 | _x_x_mozilla_page_load 17:25:01 INFO - PROCESS | 32411 | _x_x_mozilla_page_load_details 17:25:01 INFO - PROCESS | 32411 | |i|pagename|runs| 17:25:01 INFO - PROCESS | 32411 | |0;Richards;165.61775422325275 17:25:01 INFO - PROCESS | 32411 | |1;DeltaBlue;187.86398647379298 17:25:01 INFO - PROCESS | 32411 | |2;Encrypt;279.2516056967328 17:25:01 INFO - PROCESS | 32411 | |3;Decrypt;5223.958333333333 17:25:01 INFO - PROCESS | 32411 | |4;RayTrace;1121.0762331838564 17:25:01 INFO - PROCESS | 32411 | |5;Earley;729.92700729927 17:25:01 INFO - PROCESS | 32411 | |6;Boyer;12207.317073170732 17:25:01 INFO - PROCESS | 32411 | |7;RegExp;40725.490196078434 17:25:01 INFO - PROCESS | 32411 | |8;Splay;628.5355122564425 17:25:01 INFO - PROCESS | 32411 | |9;NavierStokes;4845.410628019324 17:25:01 INFO - PROCESS | 32411 | __end_tp_report 17:25:01 INFO - PROCESS | 32411 | __startTimestamp1452821101678__endTimestamp 17:25:01 INFO - PROCESS | 32411 | 17:25:01 INFO - PROCESS | 32411 | ------- Summary: start ------- 17:25:01 INFO - PROCESS | 32411 | Number of tests: 10 17:25:01 INFO - PROCESS | 32411 | 17:25:01 INFO - PROCESS | 32411 | [#0] Richards Cycles:1 Average:165.62 Median:165.62 stddev:0.00 (0.0%) 17:25:01 INFO - PROCESS | 32411 | Values: 165.6 17:25:01 INFO - PROCESS | 32411 | 17:25:01 INFO - PROCESS | 32411 | [#1] DeltaBlue Cycles:1 Average:187.86 Median:187.86 stddev:0.00 (0.0%) 17:25:01 INFO - PROCESS | 32411 | Values: 187.9 17:25:01 INFO - PROCESS | 32411 | 17:25:01 INFO - PROCESS | 32411 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 17:25:01 INFO - PROCESS | 32411 | Values: 279.3 17:25:01 INFO - PROCESS | 32411 | 17:25:01 INFO - PROCESS | 32411 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 17:25:01 INFO - PROCESS | 32411 | Values: 5224.0 17:25:01 INFO - PROCESS | 32411 | 17:25:01 INFO - PROCESS | 32411 | [#4] RayTrace Cycles:1 Average:1121.08 Median:1121.08 stddev:0.00 (0.0%) 17:25:01 INFO - PROCESS | 32411 | Values: 1121.1 17:25:01 INFO - PROCESS | 32411 | 17:25:01 INFO - PROCESS | 32411 | [#5] Earley Cycles:1 Average:729.93 Median:729.93 stddev:0.00 (0.0%) 17:25:01 INFO - PROCESS | 32411 | Values: 729.9 17:25:01 INFO - PROCESS | 32411 | 17:25:01 INFO - PROCESS | 32411 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 17:25:01 INFO - PROCESS | 32411 | Values: 12207.3 17:25:01 INFO - PROCESS | 32411 | 17:25:01 INFO - PROCESS | 32411 | [#7] RegExp Cycles:1 Average:40725.49 Median:40725.49 stddev:0.00 (0.0%) 17:25:01 INFO - PROCESS | 32411 | Values: 40725.5 17:25:01 INFO - PROCESS | 32411 | 17:25:01 INFO - PROCESS | 32411 | [#8] Splay Cycles:1 Average:628.54 Median:628.54 stddev:0.00 (0.0%) 17:25:01 INFO - PROCESS | 32411 | Values: 628.5 17:25:01 INFO - PROCESS | 32411 | 17:25:01 INFO - PROCESS | 32411 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 17:25:01 INFO - PROCESS | 32411 | Values: 4845.4 17:25:01 INFO - PROCESS | 32411 | -------- Summary: end -------- 17:25:01 INFO - PROCESS | 32411 | 17:25:02 INFO - TEST-INFO | 32411: exit 0 17:25:02 INFO - TEST-OK | v8_7 | took 40479ms 17:25:02 INFO - SUITE-END | took 1210s 17:25:02 INFO - Completed test suite (00:20:10) 17:25:02 INFO - Working with test: dromaeo_css 17:25:02 INFO - Generating results file: dromaeo_css 17:25:02 INFO - Working with test: kraken 17:25:02 INFO - Generating results file: kraken 17:25:02 INFO - javascript benchmark 17:25:02 INFO - Working with test: v8_7 17:25:02 INFO - Generating results file: v8_7 17:25:02 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:25:07 INFO - process_Request line: dromaeo_css 6855.48 graph.html#tests=[[72,64,43]] 17:25:07 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:07 INFO - process_Request line: kraken 1512.10 graph.html#tests=[[232,64,43]] 17:25:07 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:08 INFO - process_Request line: v8_7 20187.20 graph.html#tests=[[230,64,43]] 17:25:08 INFO - RETURN: dromaeo_css: 6855.48 17:25:08 INFO - RETURN: kraken: 1512.10 17:25:08 INFO - RETURN: v8_7: 20187.20 17:25:08 INFO - javascript benchmark 17:25:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3184.745220382369, 3191.2500562367827, 3215.0515597898616, 3232.127325622082, 3237.676232376762, 5213.322268105141, 5296.973515132424, 5300.946990530103, 5318.388385335687, 5337.306150200473, 5295.338082739658, 5336.8132115375965, 5340.439253878345, 5380.354357477098, 5467.6719396836115, 4883.755812209384, 4922.778474968635, 4960.206366981283, 4971.552560269575, 5012.423571289294, 4968.205087186051, 4982.451930287665, 5023.296738456619, 5028.120078986181, 5037.992401519692, 4828.082664293791, 4830.058138662962, 4846.055019271261, 4900.0, 4924.852254432372, 4862.222044472867, 4877.902441951177, 4878.292647566119, 4894.290327902434, 4933.80264789408, 4775.355327030841, 4847.636427267969, 4849.224124140156, 4858.684185527929, 4862.805487780484, 5104.69371837691, 5173.76718047685, 5212.843614691566, 5249.842504724865, 5292.153255479144, 5796.043652797283, 5800.303963524404, 5802.477777000048, 5804.88390232193, 5819.0689489681445, 5688.886222275572, 5842.328132264802, 5856.560757943172, 5864.618799778001, 5875.529957603381, 5382.4886635769935, 5395.190721391783, 5434.456554344573, 5449.155380915964, 5485.451454854483, 5960.433758792908, 5960.910586341209, 5970.194023806817, 5992.101184822312, 5992.700364981733, 5535.833924982257, 5604.963081829875, 5752.338481074647, 5760.193572899798, 5761.222234998306, 5763.481286684135, 5795.565332600072, 5814.127880817827, 5821.592488525847, 5841.883162336814, 5654.46282603152, 5660.85847853807, 5687.829365119053, 5691.146328050825, 5707.942920570741, 5619.466150715675, 5620.91568626471, 5674.546036317085, 5684.261046063985, 5690.800821971294, 4436.0, 4440.023194897118, 4445.933311000337, 4476.7090139140855, 4501.099780044005, 3987.063040185554, 3994.201159768, 4001.6198461146146, 4007.3788562772816, 4041.4341992121126, 5291.444398338196, 5351.277577527062, 5373.838784836383, 5415.864603384947, 5489.58828087895, 5770.16332631766, 5830.300363956352, 5831.067029275296, 5870.090136028923, 5870.119482077723, 5411.134218525017, 5417.891642167214, 5418.593605479605, 5424.566034717213, 5427.457254274541, 4812.302216178635, 4896.436909755353, 4934.851954441372, 4938.308636790852, 4985.725785081783, 5823.970880145572, 5828.912566311508, 5863.7947671832135, 5877.94122058774, 5943.613665111754, 5721.199032135588, 5755.740991655469, 5777.162311464898, 5788.797392091256, 5793.79721709755, 5637.689927053887, 5744.4829965303325, 5761.049426844524, 5857.26784151981, 5938.109283607493, 5679.716014199191, 5682.119271512922, 5713.400092990342, 5721.599488035964, 5772.0, 5677.31872175325, 5708.828735137952, 5725.8568535786935, 5726.627769194989, 5728.713564321684, 5527.143292789624, 5609.49514543693, 5613.0, 5620.213170156099, 5621.213030175861, 5611.971940140274, 5614.494695477427, 5630.85922851932, 5645.125005624135, 5698.544116470755, 5538.224648549126, 5541.168824676331, 5544.223808666709, 5547.944520554743, 5559.054960656779, 5578.525825304894, 5589.720513974366, 5599.720013999366, 5632.2678051853, 5698.743556540048, 5471.0, 5544.140658197985, 5556.611037227355, 5598.832035038955, 5605.103183490785], "unit": "score", "name": "dojo.html", "value": 5305.493130287401}, {"lowerIsBetter": false, "replicates": [536.4099490560384, 537.9731013449326, 559.7956745787787, 562.9240052592904, 571.0121489822607, 34531.82734086329, 35274.2945141097, 35473.0, 35550.64449355505, 35692.82153589232, 39467.60532394675, 39896.40155397671, 39899.40150897739, 39930.80034599823, 40032.19935601286, 8358.164183581654, 8526.147385261454, 8572.14278572144, 8578.39951203416, 8594.140585941419, 8344.833103337929, 8463.95768021159, 8472.74581762548, 8711.433756805787, 8737.868931966026, 8751.781205469882, 8790.164934331227, 8826.0, 8848.823023539526, 8851.645934162658, 8746.956265218665, 8795.120487951217, 8796.736097917073, 8807.955960220223, 8814.16265454784, 8475.618597163142, 8622.913770862273, 8632.266257368132, 8649.351298652564, 8671.176238257356, 38458.23083538313, 38726.806365968274, 38834.53402858651, 38963.41554876679, 39071.21857562861, 3246.2446085964907, 3290.176685470038, 3472.2708231271463, 3527.3121741260466, 3726.720495962814, 29949.401011979855, 30091.548626770615, 30241.848790756125, 30311.24221894448, 31234.687653123405, 3761.755485893408, 3997.480327557428, 4096.549379568245, 4103.363978583325, 4105.2405305018665, 249382.0, 249548.0, 249988.75005625037, 250182.0, 251008.0, 42291.71353580803, 42562.78718606387, 42824.357634635504, 54060.18909716357, 54192.45807541953, 41321.79339103285, 41404.0, 41470.79264603658, 41488.79255603763, 41585.37621935673, 14585.635359115895, 14672.413103475956, 14802.259887005823, 14811.851881481047, 14835.332410041574, 10690.78618427627, 10749.62376316825, 10800.729981750363, 10823.0, 10846.728831779112, 14234.786478202835, 14422.0, 14422.783658245135, 14471.131732096108, 14539.491117811038, 5646.85882852932, 5655.0, 5723.59934804568, 5776.711164441761, 5791.739371728282, 944.8110377924443, 984.1388784813288, 993.8161440133598, 1033.3231733214757, 1072.4691277817374, 27748.167554973385, 27977.300567485974, 28166.2958426041, 28616.85691571529, 28714.282142946176, 1060.612876300145, 1067.1302888146136, 1074.1943542343242, 1129.062877811431, 1167.7197472606683, 14677.48628797987, 14717.705645887023, 14862.182579958206, 15087.170205638795, 15114.773278400833, 325883.0, 326251.0, 327518.0, 328403.0, 329705.0, 49512.75243623831, 49768.75115624399, 49996.250056249184, 50024.74987625039, 50122.49877501178, 1331.6870535424168, 1355.5662188099911, 1363.3183408295852, 1370.465518447806, 1371.3349025722516, 26992.73007269902, 27447.313817154733, 27747.0, 27958.3010424741, 28226.15321540357, 46580.30129548127, 46735.53264467448, 47073.05853882834, 47179.292310614685, 47200.29199562078, 295125.0, 295884.0, 296544.0, 299760.0, 300044.0, 32192.19519512031, 40835.38746918739, 42625.786871065444, 42685.0, 42854.0, 40298.0, 41485.377719334836, 41520.1695966085, 41777.373339399324, 42311.7884410576, 34490.65509344975, 34876.0, 34884.7718029821, 35284.294314114086, 35495.0, 34568.0, 34927.12682182966, 35111.297774044884, 36980.63019369772, 38628.0, 32573.674263258014, 32788.83605581957, 33366.49950250797, 33451.33097337991, 33487.49768753519, 30089.247768805955, 32029.67970320267, 32391.67608323981, 32396.676033239364, 32683.673163268064, 24517.877410613546, 24838.37904052413, 24906.875465622557, 25059.74940250647, 25339.493210135326], "unit": "score", "name": "ext.html", "value": 17720.96372611165}, {"lowerIsBetter": false, "replicates": [365.22936603766055, 366.52717993787996, 367.10975883482547, 367.90802299425144, 369.18226129123985, 15163.241837908101, 16232.431864884731, 16720.163991800422, 17051.0, 17739.2017359219, 11314.603988860392, 11482.770344593104, 16312.265948032338, 16397.672046559062, 16480.917595412036, 4682.929756053653, 5322.467753224666, 5355.651882627617, 5359.08895487766, 5362.946370536303, 4375.562443755631, 5142.562882155022, 5239.056969745444, 5288.101022826128, 5291.126964050927, 4892.510748925115, 4897.730624815634, 5060.342155519796, 5194.662346947455, 5244.213367994793, 5183.481651834824, 5194.740262986855, 5210.374755029383, 5225.425203227642, 5486.780528778844, 5226.660267082628, 5266.578673706094, 5267.815626453055, 5271.446498117681, 5278.340207474066, 11850.407479625985, 12890.742185156245, 12895.871041289562, 12948.352582370844, 12988.155769874928, 2074.979250207494, 2111.28216406421, 2174.945626359338, 2186.8906554672203, 2264.8754318512474, 9822.557984890696, 9946.254030947708, 10645.361278323326, 10665.253432259746, 13038.543650972266, 1734.17626627351, 1756.7452719355622, 1767.7260024696193, 1794.9551261218444, 1881.6613009658256, 53053.0, 54448.45551544474, 55221.0, 55416.0, 55562.44437555654, 9833.016698330253, 9928.453935033498, 10162.593496260066, 10228.795424091477, 10310.32982856112, 13231.73536529264, 13343.132696374705, 13355.198688078746, 13355.46578136883, 13372.398242079129, 7524.811879702942, 7543.660535275926, 7603.315701586884, 7608.543487390663, 7671.34793542544, 7323.340899319087, 7325.120985481776, 7327.047483827068, 7343.0, 7351.0, 4382.320740285261, 4409.096135292321, 4427.358033085185, 4463.732176069446, 4487.528809475023, 1749.2478234359094, 1775.5383600264024, 1826.9908650456928, 1855.9814401855808, 1872.7939926608062, 860.0840105287848, 886.1183122792862, 889.1419779912416, 915.5925613102106, 934.3879758758025, 15233.923830380778, 15657.921710391603, 16646.6670666586, 16911.49265522036, 17298.308067677153, 898.4788822482944, 935.2284365398438, 971.8736564246744, 1000.2248257600418, 1033.5297439664935, 8889.911100889038, 8933.776655583533, 8984.101589841095, 9002.639894404281, 9163.450192988443, 373640.0, 380963.0, 385157.0, 556269.0, 558582.0, 45783.771081145045, 59582.0, 61303.0, 65871.67064164649, 71514.0, 1135.8353038809325, 1166.5567084508002, 1174.0724827386268, 1174.2895548193562, 1182.0307347974579, 10257.692269231935, 15051.021683590532, 15074.698506030038, 15171.16558589244, 15302.693946120793, 32535.51196732098, 34150.82924585361, 34557.65442345645, 34678.47982280318, 36176.457353139194, 43276.78361608172, 44414.3337849926, 44416.7779161115, 45858.08283834371, 46774.06451870876, 10279.691609251735, 10335.586576536854, 10456.68629941103, 10563.68308950702, 10690.465476726287, 11628.767424651629, 11870.940645296718, 12043.458044387848, 12053.51785928553, 12324.445399956845, 7666.080070391588, 7748.380129589506, 7752.612369381395, 8006.599670016592, 8023.1976802319305, 7733.342665873463, 7856.764297071097, 7951.2843844051995, 8052.0, 8110.107888132418, 7649.196834332315, 7727.49771264866, 7732.613369331399, 7929.5242285463055, 7973.0455006260445, 10362.792744145225, 10385.584576616851, 10513.684589462327, 10673.252872298865, 10698.0, 7665.540067595962, 10813.134949204203, 10890.153881522647, 11032.779344413228, 11059.612913547988], "unit": "score", "name": "jquery.html", "value": 8009.466838001213}, {"lowerIsBetter": false, "replicates": [1460.4450308882626, 1470.0591621362323, 1622.3753854765919, 1734.124267245041, 1763.7266223735326, 7492.400607951365, 7614.505057171287, 7639.0, 7656.846863062736, 7891.4081443891655, 7849.80375490613, 7905.367570594353, 7915.248051435119, 7965.9601701991405, 7969.521828690283, 2265.0, 2299.1493147535434, 2300.4478925058033, 2304.147465437782, 2308.0998410619873, 2320.14154762738, 2376.6910301660846, 2420.2860156253946, 2423.4183795889035, 2434.853908765471, 2357.9882100589475, 2358.905643774247, 2359.079958816063, 2378.4410663494064, 2399.0, 2360.032386721436, 2374.299581623425, 2378.0250097459957, 2380.9047638094544, 2382.6664267002634, 2358.516504116652, 2388.092524840567, 2391.4380120671626, 2396.209250947183, 2402.459446624513, 7812.179721129256, 7822.452428330019, 7873.370130389555, 7917.089534703525, 7924.920750792476, 4729.6452766042685, 4811.422629284473, 4813.807447702087, 4819.927701084486, 4851.514848515156, 3110.0358888744563, 3128.593282873235, 3139.3250451152885, 3153.30627262002, 3224.790388624732, 1058.4919238765358, 1073.5491093740648, 1076.61529711689, 1110.655696734007, 1122.231271578971, 10440.0, 10678.572857085785, 10682.572697092108, 10694.144468442506, 10695.0, 4440.644748420119, 4449.888752781207, 4579.22153233951, 4603.49361570227, 4630.6758526902795, 8645.8703119452, 8685.739427817176, 8730.825383492422, 8746.91253087461, 8759.16787905148, 4853.417589889236, 4882.584980276716, 4890.902181956341, 4899.461059283476, 4920.532549407801, 4372.846950356722, 4453.933191002137, 4469.932951005738, 4474.530174331713, 4485.887852803706, 3583.9820800895827, 3585.049961760136, 3591.353556359828, 3644.562652481719, 3676.7058635309113, 1092.6121226964472, 1095.2333366643381, 1107.7950579142885, 1120.0591503137405, 1122.2088427658482, 1233.7409144079843, 1239.2192918461312, 1254.6737848159544, 1266.7783137951005, 1269.225772278909, 6929.064576282138, 6940.444764418834, 6992.650367481606, 7178.461615378763, 7180.640967951582, 508.54231191926823, 512.3723438787456, 513.4788189987166, 519.948005199477, 522.4435975685882, 5578.358488773762, 5671.914921276184, 5680.7727690892725, 5693.373728889819, 5697.829065128053, 9003.504807235666, 9496.43021418717, 9524.285678574135, 9537.952310238543, 9658.082482164184, 9327.673531426368, 9350.485723285285, 9361.063893610584, 9397.295202859812, 9451.480168590793, 7246.804277294293, 7427.517211381243, 7438.5536867788105, 7448.702051917971, 7455.254474552501, 7053.470989675692, 7060.470464715064, 7154.069970903957, 7158.785236442915, 7170.354668079689, 7885.2114788520685, 7910.723124690839, 8048.476849004796, 8080.515169089874, 8167.714130005421, 8121.066077400938, 8159.46963447374, 8170.7957301067945, 8225.753227403187, 8260.256576908107, 6554.737810487527, 6704.597724136567, 6731.158605174353, 6771.966140169267, 6895.931040689529, 7408.703651853865, 7432.442566807619, 7453.962730186531, 7475.7009719610605, 7491.438142139253, 6946.235914049349, 7020.508564400443, 7145.17830449505, 7200.747973820891, 7239.746608868664, 6864.416524595265, 7022.648867556704, 7056.259092795182, 7064.858702826017, 7084.185318688416, 6857.108575885302, 6956.617386043817, 7046.682899269647, 7078.398336141486, 7169.677364518713, 6546.705398257185, 6571.0, 6587.374199451045, 6590.209174899042, 6621.50338724588, 6573.57271777333, 6575.210974683068, 6586.110875031809, 6619.536632435876, 6665.50008749336], "unit": "score", "name": "mootools.html", "value": 4443.472490689924}, {"lowerIsBetter": false, "replicates": [343.8847985924715, 348.22867348822354, 350.2959052304868, 353.58630402429156, 356.0813102196334, 6263.498920086394, 6274.811755647333, 6281.43467087962, 6323.30443651198, 6469.6441695706835, 6277.968610156943, 6297.055441683749, 6326.304106548288, 6334.429901308881, 6348.841278968028, 4805.471398146201, 4813.157697402958, 4813.8074477021055, 4827.25177597473, 4828.444728856191, 4808.302796094564, 4811.30236115763, 4824.565789078983, 4841.588464980481, 4849.563539281464, 4705.458872229686, 4793.4487533933525, 4803.039392121572, 4806.975965120169, 4812.10975969445, 4789.832355867528, 4798.47216806151, 4801.663883528172, 4802.06359759847, 4808.447028591687, 4150.335946248616, 4166.041810383629, 4167.270727622654, 4171.144915292358, 4173.227952828736, 5962.926673198823, 6019.097135429677, 6025.6083354581815, 6033.034714445712, 6033.5474839387225, 5396.757145928443, 5542.0, 5579.107342825128, 5585.944140558624, 5586.329640443132, 6677.0, 6702.128723265993, 6705.463562915004, 6721.495887808385, 6726.0919775830125, 4575.313702944552, 4589.219832628428, 4595.448546174447, 4598.425196850394, 4629.421322334708, 6751.493637977172, 6921.861562768717, 6975.616341101238, 7002.75490357835, 7027.683754231072, 4646.6747327686735, 4686.718796872198, 4694.741789201558, 4696.624270058387, 4707.552782485658, 4745.691530050535, 4752.596029337476, 4754.310624959361, 4779.545943135397, 4790.353302304214, 5521.723913804293, 5542.667439953616, 5551.25058117149, 5563.860903477445, 5568.470995255444, 6502.414782669583, 6689.297623749533, 6690.632015239111, 6703.061571380011, 6704.865902681919, 1627.7721119043345, 1650.8514233719022, 1659.8921070130402, 1666.7083260429376, 1666.7416550434702, 1092.1754075672816, 1128.1764312052085, 1130.559081958037, 1133.7335726104359, 1139.6865861888048, 6239.376062393724, 6262.780802671885, 6278.6860656966965, 6288.937110628926, 6310.463610593151, 6790.558613690095, 6796.150481189851, 6799.354061364163, 6811.773880701521, 6818.318168183142, 6153.353897840751, 6277.7175027123885, 6330.905036424458, 6340.397662222082, 6341.778037768749, 3697.2975134724315, 3704.9629503705155, 3712.832922518493, 3713.3687273163628, 3726.9813650931574, 6928.618925959121, 6967.198772141167, 6969.9303006969285, 6976.372126508639, 6992.3357281058215, 6771.661416929134, 6966.0, 6970.581765094009, 6996.160460744743, 7017.824554386181, 6948.062011628466, 6969.16370035599, 6970.512064155562, 6977.616231107237, 6989.4408447324095, 6791.117154769849, 6795.184577850492, 6806.591604503746, 6835.213950395768, 6836.48726345536, 6622.90065649006, 6706.161729783777, 6729.0, 6734.124563806674, 6738.966305168443, 6869.690863911036, 6928.1339832520935, 6941.167059952838, 6967.268436814062, 6970.79087627372, 4588.288815233511, 4589.2886602576655, 4615.676902616785, 4640.582347588733, 4648.535146485325, 6649.60102393858, 6692.0965669635925, 6789.694463749044, 6803.149606299213, 6808.523403361717, 6740.629265390255, 6776.220734615582, 6780.186377634715, 6783.59298442095, 6784.118064651564, 6670.83322916931, 6707.66461676924, 6713.295104014203, 6730.596164229966, 6749.831254218684, 6503.869922601616, 6623.238327592196, 6635.966820165868, 6665.900011499734, 6700.564463309869, 6730.730770769114, 6756.0, 6786.728530858908, 6797.5581587196675, 6808.455323574003, 6563.474922006323, 6567.0, 6616.603003819786, 6621.768238111643, 6638.502112341497], "unit": "score", "name": "prototype.html", "value": 5006.708513779696}, {"lowerIsBetter": false, "replicates": [845.0957475501215, 850.9106543812895, 853.4836423963502, 861.7027125641652, 895.6730793260461, 13197.604071877848, 13406.865931340684, 13458.192508449476, 13460.192388456675, 13463.0, 12685.238885666866, 12733.108682392212, 12763.298018608974, 12780.872191278084, 12795.552155674553, 642.935706429358, 651.6383407208997, 800.2437696376926, 821.6097353756977, 825.7605294464598, 809.0655293136437, 814.4990830639144, 816.2042009041168, 818.1491249100958, 819.7253919936828, 851.1190917400492, 854.4958474500044, 859.0764927702744, 861.0571424290392, 861.5476874640801, 851.3019324154166, 851.4678326046252, 852.5438890193778, 856.4989481153533, 856.6102423397401, 627.3663599764226, 635.9586626869238, 636.8885445047098, 637.1525870592102, 637.5537124013209, 13479.0, 13483.393247303895, 13515.729685406335, 13516.93241533786, 13573.185608863401, 12794.168379055425, 12988.155769874928, 13045.804312935314, 13139.934300328532, 13323.000774941918, 10537.73655658607, 10576.153907687367, 10682.092022178047, 10939.890601093966, 10991.06575941046, 3538.168530395355, 3637.6344891285144, 3650.7444478886487, 3736.532933383327, 3750.3999360102252, 45374.77312613449, 45800.0, 45976.3103553447, 46121.0, 46572.0, 9467.43195408264, 9511.809763804824, 9513.429194248367, 9863.457509837028, 9924.0, 17915.0, 18203.0, 18255.817441825413, 18476.815231847777, 18483.16825742845, 7013.649317534103, 7064.258252883476, 7510.211427800003, 7569.053868266466, 7877.172896845863, 4176.498820141542, 4252.21334053195, 4271.786410679453, 4278.229918614679, 4368.104538569585, 2952.129121909042, 2971.435427268812, 2974.9702502975124, 3006.413749318862, 3023.1232942446445, 546.469924173551, 567.8381661226531, 569.4931510955253, 593.5963544789498, 594.8334466349429, 531.5773959702046, 561.9874098933617, 591.6036255708685, 623.8676801605072, 689.2934741889503, 8600.698975535826, 8693.0, 8741.344399170088, 8762.4742515448, 8925.062868398854, 560.8822147349102, 577.3158806813939, 598.7994022002591, 661.0645936000506, 694.0912490650711, 4023.6177563131455, 4117.402976568381, 4123.60825721556, 4219.51475580306, 4282.293421585404, 54517.454825452034, 56557.7172114145, 56792.43207567954, 57256.0, 57761.71119144378, 49807.750961245685, 50780.23829642558, 51035.489645103815, 51327.230091548656, 51329.743351283, 45375.54624453779, 45823.541764582595, 46167.07665846664, 46554.53445465502, 46621.76689116532, 8261.104420954503, 8317.41778075529, 8341.165883411853, 8611.48331100136, 8726.345524085593, 34024.0, 34323.313533729684, 35282.64717352896, 35319.646803531636, 35550.46674299939, 39895.80052099721, 40433.59566404416, 42870.0, 42879.3568096485, 43183.35224971565, 8651.134886511298, 8705.260052895575, 9454.621815127319, 9899.752506187402, 10101.191904647463, 10620.309679871092, 10758.300710454108, 11161.162912781412, 11788.764224715285, 11914.76170476603, 10807.278024735944, 10981.560737570408, 11118.110551156049, 11149.442527873736, 11308.426041604931, 10883.183761218099, 11131.10951123892, 11281.92821681939, 11318.26431281964, 11517.94241028823, 10323.432211228455, 10608.204384671335, 10624.203184761329, 10700.785984280115, 11197.60808371703, 8701.34739894523, 8745.737627871174, 8781.467089375052, 8862.379633425857, 9185.035571264922, 9062.32032597571, 9324.440533568008, 9345.906540934775, 9356.298277629068, 9476.857847132436], "unit": "score", "name": "yui.html", "value": 6195.835973251436}], "name": "dromaeo_css", "value": 6855.478053529188}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 112.0, 112.0, 112.0, 126.0, 114.0, 114.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 113.9}, {"lowerIsBetter": true, "replicates": [148.0, 135.0, 151.0, 161.0, 128.0, 159.0, 150.0, 125.0, 177.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [163.0, 168.0, 162.0, 164.0, 162.0, 164.0, 165.0, 169.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 77.0, 71.0, 133.0, 71.0, 72.0, 73.0, 75.0], "unit": "score", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 139.0, 100.0, 99.0, 96.0, 141.0, 95.0, 98.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 111.0, 110.0, 109.0, 111.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 154.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 60.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 77.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [88.0, 83.0, 82.0, 91.0, 83.0, 81.0, 82.0, 86.0, 93.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [115.0, 115.0, 120.0, 119.0, 118.0, 126.0, 134.0, 121.0, 125.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [146.0, 144.0, 150.0, 148.0, 147.0, 131.0, 143.0, 143.0, 145.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 67.0, 67.0, 67.0, 69.0, 69.0, 68.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1512.0999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.61775422325275], "unit": "score", "name": "Richards", "value": 213.15347599999996}, {"lowerIsBetter": false, "replicates": [187.86398647379298], "unit": "score", "name": "DeltaBlue", "value": 351.946114}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [1121.0762331838564], "unit": "score", "name": "RayTrace", "value": 660.070188}, {"lowerIsBetter": false, "replicates": [729.92700729927], "unit": "score", "name": "Earley", "value": 913.0543100000001}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [40725.490196078434], "unit": "score", "name": "RegExp", "value": 22.368914299470404}, {"lowerIsBetter": false, "replicates": [628.5355122564425], "unit": "score", "name": "Splay", "value": 129.65218100000004}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20187.198483768738}]} 17:25:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20187.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1512.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6855.48"}}} 17:25:08 INFO - Return code: 0 17:25:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:25:08 INFO - # TBPL SUCCESS # 17:25:08 INFO - Running post-action listener: _resource_record_post_action 17:25:08 INFO - Running post-run listener: _resource_record_post_run 17:25:09 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 552316928; Read time: 0; Write time: 429960 17:25:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237019136; Read time: 0; Write time: 197260 17:25:09 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 315297792; Read time: 0; Write time: 232700 17:25:09 INFO - Running post-run listener: _upload_blobber_files 17:25:09 INFO - Blob upload gear active. 17:25:09 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:25:09 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 17:25:09 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:25:09 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:25:09 INFO - (blobuploader) - INFO - Open directory for files ... 17:25:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:25:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:25:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:10 INFO - (blobuploader) - INFO - Done attempting. 17:25:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:25:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:25:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:11 INFO - (blobuploader) - INFO - Done attempting. 17:25:11 INFO - (blobuploader) - INFO - Iteration through files over. 17:25:11 INFO - Return code: 0 17:25:11 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:25:11 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:25:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0008d964b51ba29bc1d6ba180789ecb71334369e96febf2cb98d533fd5453cb1823fd70a23db6984de0b5ceec28513c4530fc713b754ea42100bfed0a6d732ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ff393e4ddf5b2f6e173398d069c05ffc62a741eef09e2944700c7dd29c730fe39764654356ddb4c3a5016c99c6d944388278967b45beee50d27fd13ce766063"} 17:25:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:25:11 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:25:11 INFO - Contents: 17:25:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0008d964b51ba29bc1d6ba180789ecb71334369e96febf2cb98d533fd5453cb1823fd70a23db6984de0b5ceec28513c4530fc713b754ea42100bfed0a6d732ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ff393e4ddf5b2f6e173398d069c05ffc62a741eef09e2944700c7dd29c730fe39764654356ddb4c3a5016c99c6d944388278967b45beee50d27fd13ce766063"} 17:25:11 INFO - Copying logs to upload dir... 17:25:11 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1282.282511 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-14 17:25:11.252562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 17:25:11.255914) ========= 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=1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0008d964b51ba29bc1d6ba180789ecb71334369e96febf2cb98d533fd5453cb1823fd70a23db6984de0b5ceec28513c4530fc713b754ea42100bfed0a6d732ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ff393e4ddf5b2f6e173398d069c05ffc62a741eef09e2944700c7dd29c730fe39764654356ddb4c3a5016c99c6d944388278967b45beee50d27fd13ce766063"} build_url:https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0008d964b51ba29bc1d6ba180789ecb71334369e96febf2cb98d533fd5453cb1823fd70a23db6984de0b5ceec28513c4530fc713b754ea42100bfed0a6d732ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ff393e4ddf5b2f6e173398d069c05ffc62a741eef09e2944700c7dd29c730fe39764654356ddb4c3a5016c99c6d944388278967b45beee50d27fd13ce766063"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 17:25:11.280634) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:25:11.280971) ========= 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=1f5564757af27664ca02d71f000001b0-1452819783.730139-1131952130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:25:11.365365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 17:25:11.365700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 17:25:11.365992) ========= ========= Total master_lag: 0.29 =========