builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1452880812.76 results: success (0) buildid: 20160115073420 builduid: 863c819af0cf44ccbb0b12abe9271fce revision: 7701bd27ec28b32d99f470d599c9ef2eddc9b94c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:12.762993) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:12.763642) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:12.763932) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006343 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:12.791122) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:12.791381) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:12.819482) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:12.819754) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027719 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:12.869921) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:12.870169) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:12.870494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:12.870774) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 10:00:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.4M=0s 2016-01-15 10:00:13 (23.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:13.049834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:13.050509) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.110610 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:13.178951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:13.179713) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7701bd27ec28b32d99f470d599c9ef2eddc9b94c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7701bd27ec28b32d99f470d599c9ef2eddc9b94c --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=b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 10:00:13,253 truncating revision to first 12 chars 2016-01-15 10:00:13,253 Setting DEBUG logging. 2016-01-15 10:00:13,254 attempt 1/10 2016-01-15 10:00:13,254 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7701bd27ec28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 10:00:13,489 unpacking tar archive at: mozilla-inbound-7701bd27ec28/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535196 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:13.728432) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:13.728770) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004410 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:13.779632) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:13.779989) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:13.791619) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:13.791925) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:13.792356) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-01-15 10:00:13.792694) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:00:14 INFO - MultiFileLogger online at 20160115 10:00:14 in /builds/slave/test-pgo 10:00:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:00:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:00:14 INFO - {'append_to_log': False, 10:00:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:00:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:00:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:00:14 INFO - 'branch': 'Mozilla-Inbound', 10:00:14 INFO - 'buildbot_json_path': 'buildprops.json', 10:00:14 INFO - 'config_files': ('talos/linux_config.py',), 10:00:14 INFO - 'default_actions': ('clobber', 10:00:14 INFO - 'read-buildbot-config', 10:00:14 INFO - 'download-and-extract', 10:00:14 INFO - 'populate-webroot', 10:00:14 INFO - 'create-virtualenv', 10:00:14 INFO - 'install', 10:00:14 INFO - 'run-tests'), 10:00:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:00:14 INFO - 'download_minidump_stackwalk': True, 10:00:14 INFO - 'download_symbols': 'ondemand', 10:00:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:00:14 INFO - 'tooltool.py': '/tools/tooltool.py', 10:00:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:00:14 INFO - '/tools/misc-python/virtualenv.py')}, 10:00:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:00:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:00:14 INFO - 'installer_path': 'installer.exe', 10:00:14 INFO - 'log_level': 'info', 10:00:14 INFO - 'log_name': 'talos', 10:00:14 INFO - 'log_to_console': True, 10:00:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:00:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:00:14 INFO - 'opt_config_files': (), 10:00:14 INFO - 'pip_index': False, 10:00:14 INFO - 'sps_profile': False, 10:00:14 INFO - 'sps_profile_interval': 0, 10:00:14 INFO - 'suite': 'dromaeojs-e10s', 10:00:14 INFO - 'system_bits': '32', 10:00:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:00:14 INFO - 'title': 'talos-linux64-ix-007', 10:00:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:00:14 INFO - 'use_talos_json': True, 10:00:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:00:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:00:14 INFO - 'work_dir': 'build'} 10:00:14 INFO - ##### 10:00:14 INFO - ##### Running clobber step. 10:00:14 INFO - ##### 10:00:14 INFO - Running pre-action listener: _resource_record_pre_action 10:00:14 INFO - Running main action method: clobber 10:00:14 INFO - rmtree: /builds/slave/test-pgo/build 10:00:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:00:19 INFO - Running post-action listener: _resource_record_post_action 10:00:19 INFO - ##### 10:00:19 INFO - ##### Running read-buildbot-config step. 10:00:19 INFO - ##### 10:00:19 INFO - Running pre-action listener: _resource_record_pre_action 10:00:19 INFO - Running main action method: read_buildbot_config 10:00:19 INFO - Using buildbot properties: 10:00:19 INFO - { 10:00:19 INFO - "project": "", 10:00:19 INFO - "product": "firefox", 10:00:19 INFO - "script_repo_revision": "production", 10:00:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 10:00:19 INFO - "repository": "", 10:00:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 10:00:19 INFO - "buildid": "20160115073420", 10:00:19 INFO - "pgo_build": "True", 10:00:19 INFO - "basedir": "/builds/slave/test-pgo", 10:00:19 INFO - "buildnumber": 308, 10:00:19 INFO - "slavename": "talos-linux64-ix-007", 10:00:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:00:19 INFO - "platform": "ubuntu64_hw", 10:00:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:00:19 INFO - "branch": "mozilla-inbound", 10:00:19 INFO - "repo_path": "integration/mozilla-inbound", 10:00:19 INFO - "revision": "7701bd27ec28b32d99f470d599c9ef2eddc9b94c", 10:00:19 INFO - "stage_platform": "linux64-pgo", 10:00:19 INFO - "builduid": "863c819af0cf44ccbb0b12abe9271fce", 10:00:19 INFO - "slavebuilddir": "test" 10:00:19 INFO - } 10:00:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:00:19 INFO - Running post-action listener: _resource_record_post_action 10:00:19 INFO - ##### 10:00:19 INFO - ##### Running download-and-extract step. 10:00:19 INFO - ##### 10:00:19 INFO - Running pre-action listener: _resource_record_pre_action 10:00:19 INFO - Running main action method: download_and_extract 10:00:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:19 INFO - https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/test_packages.json 10:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/test_packages.json 10:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:00:19 INFO - Downloaded 1448 bytes. 10:00:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:00:19 INFO - Using the following test package requirements: 10:00:19 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:19 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:00:19 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:00:19 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:19 INFO - u'jsshell-linux-x86_64.zip'], 10:00:19 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:00:19 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:19 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:00:19 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:00:19 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:00:19 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:19 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:00:19 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:19 INFO - https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/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 10:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/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 10:00:26 INFO - Downloaded 22475717 bytes. 10:00:26 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'] 10:00:26 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 10:00:28 INFO - Return code: 0 10:00:28 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 10:00: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')]} 10:00:28 INFO - https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/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 10:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/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 10:00:32 INFO - Downloaded 22475717 bytes. 10:00:32 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'] 10:00:32 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 10:00:33 INFO - Return code: 0 10:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:33 INFO - https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/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 10:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/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 10:00:36 INFO - Downloaded 11132144 bytes. 10:00:36 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'] 10:00:36 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 10:00:36 INFO - Return code: 0 10:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:36 INFO - https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/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 10:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/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 10:00:49 INFO - Downloaded 55924326 bytes. 10:00:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:00:49 INFO - mkdir: /builds/slave/test-pgo/properties 10:00:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:00:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:00:49 INFO - Contents: 10:00:49 INFO - build_url:https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:00:49 INFO - Running post-action listener: _resource_record_post_action 10:00:49 INFO - Running post-action listener: set_extra_try_arguments 10:00:49 INFO - ##### 10:00:49 INFO - ##### Running populate-webroot step. 10:00:49 INFO - ##### 10:00:49 INFO - Running pre-action listener: _resource_record_pre_action 10:00:49 INFO - Running main action method: populate_webroot 10:00:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:00:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:00:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:00:49 INFO - '--tppagecycles', 10:00:49 INFO - '7'], 10:00:49 INFO - 'tests': ['tsvgm']}}, 10:00:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:00:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:00:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:00:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:00:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:00:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:00:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:49 INFO - 'talos_options': ['--e10s'], 10:00:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:49 INFO - 'tests': ['damp', 'tps']}, 10:00:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:49 INFO - 'talos_options': ['--e10s'], 10:00:49 INFO - 'tests': ['damp', 'tps']}, 10:00:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:00:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:00:49 INFO - 'other': {'tests': ['a11yr', 10:00:49 INFO - 'ts_paint', 10:00:49 INFO - 'tpaint', 10:00:49 INFO - 'sessionrestore', 10:00:49 INFO - 'sessionrestore_no_auto_restore']}, 10:00:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:00:49 INFO - 'tests': ['a11yr', 10:00:49 INFO - 'ts_paint', 10:00:49 INFO - 'tpaint', 10:00:49 INFO - 'sessionrestore', 10:00:49 INFO - 'sessionrestore_no_auto_restore']}, 10:00:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:00:49 INFO - 'tests': ['a11yr', 10:00:49 INFO - 'ts_paint', 10:00:49 INFO - 'tpaint', 10:00:49 INFO - 'sessionrestore', 10:00:49 INFO - 'sessionrestore_no_auto_restore']}, 10:00:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:00:49 INFO - 'tests': ['a11yr', 10:00:49 INFO - 'ts_paint', 10:00:49 INFO - 'tpaint', 10:00:49 INFO - 'sessionrestore', 10:00:49 INFO - 'sessionrestore_no_auto_restore']}, 10:00:49 INFO - 'other_l64': {'tests': ['a11yr', 10:00:49 INFO - 'ts_paint', 10:00:49 INFO - 'tpaint', 10:00:49 INFO - 'sessionrestore', 10:00:49 INFO - 'sessionrestore_no_auto_restore']}, 10:00:49 INFO - 'other_nol64': {'tests': ['a11yr', 10:00:49 INFO - 'ts_paint', 10:00:49 INFO - 'tpaint', 10:00:49 INFO - 'sessionrestore', 10:00:49 INFO - 'sessionrestore_no_auto_restore']}, 10:00:49 INFO - 'svgr': {'tests': ['tsvgx', 10:00:49 INFO - 'tsvgr_opacity', 10:00:49 INFO - 'tart', 10:00:49 INFO - 'tscrollx', 10:00:49 INFO - 'cart']}, 10:00:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:00:49 INFO - 'tests': ['tsvgx', 10:00:49 INFO - 'tsvgr_opacity', 10:00:49 INFO - 'tart', 10:00:49 INFO - 'tscrollx', 10:00:49 INFO - 'cart']}, 10:00:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:49 INFO - 'tests': ['tp5o']}, 10:00:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:49 INFO - 'talos_options': ['--e10s'], 10:00:49 INFO - 'tests': ['tp5o']}, 10:00:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:49 INFO - 'talos_options': ['--xperf_path', 10:00:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:49 INFO - 'tests': ['tp5n']}, 10:00:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:49 INFO - 'talos_options': ['--e10s', 10:00:49 INFO - '--xperf_path', 10:00:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:49 INFO - 'tests': ['tp5n']}}, 10:00:49 INFO - 'talos.zip': {'path': '', 10:00:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:00:49 INFO - Running post-action listener: _resource_record_post_action 10:00:49 INFO - ##### 10:00:49 INFO - ##### Running create-virtualenv step. 10:00:49 INFO - ##### 10:00:49 INFO - Running pre-action listener: _resource_record_pre_action 10:00:49 INFO - Running main action method: create_virtualenv 10:00:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:00:49 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 10:00:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:00:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:00:49 INFO - Using real prefix '/usr' 10:00:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:00:49 INFO - Installing distribute.............................................................................................................................................................................................done. 10:00:51 INFO - Installing pip.................done. 10:00:51 INFO - Return code: 0 10:00:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:51 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 0x7f76cb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0660>, '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 0x1fc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1a10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', '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 10:00:51 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 10:00:51 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 10:00:51 INFO - Using env: {'DISPLAY': ':0', 10:00:51 INFO - 'HOME': '/home/cltbld', 10:00:51 INFO - 'LANG': 'en_US.UTF-8', 10:00:51 INFO - 'LANGUAGE': 'en_US:en', 10:00:51 INFO - 'LOGNAME': 'cltbld', 10:00:51 INFO - 'MAIL': '/var/mail/cltbld', 10:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:51 INFO - 'MOZ_NO_REMOTE': '1', 10:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:51 INFO - 'NO_EM_RESTART': '1', 10:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 10:00:51 INFO - 'SHELL': '/bin/bash', 10:00:51 INFO - 'SHLVL': '1', 10:00:51 INFO - 'TERM': 'linux', 10:00:51 INFO - 'TMOUT': '86400', 10:00:51 INFO - 'USER': 'cltbld', 10:00:51 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', 10:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:51 INFO - '_': '/tools/buildbot/bin/python'} 10:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:51 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 10:00:51 INFO - Cleaning up... 10:00:51 INFO - Return code: 0 10:00:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:51 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 0x7f76cb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0660>, '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 0x1fc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1a10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', '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 10:00:51 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 10:00:51 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 10:00:51 INFO - Using env: {'DISPLAY': ':0', 10:00:51 INFO - 'HOME': '/home/cltbld', 10:00:51 INFO - 'LANG': 'en_US.UTF-8', 10:00:51 INFO - 'LANGUAGE': 'en_US:en', 10:00:51 INFO - 'LOGNAME': 'cltbld', 10:00:51 INFO - 'MAIL': '/var/mail/cltbld', 10:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:51 INFO - 'MOZ_NO_REMOTE': '1', 10:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:51 INFO - 'NO_EM_RESTART': '1', 10:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 10:00:51 INFO - 'SHELL': '/bin/bash', 10:00:51 INFO - 'SHLVL': '1', 10:00:51 INFO - 'TERM': 'linux', 10:00:51 INFO - 'TMOUT': '86400', 10:00:51 INFO - 'USER': 'cltbld', 10:00:51 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', 10:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:51 INFO - '_': '/tools/buildbot/bin/python'} 10:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:52 INFO - Downloading/unpacking psutil>=0.7.1 10:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:00:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:00:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:00:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:53 INFO - Installing collected packages: psutil 10:00:53 INFO - Running setup.py install for psutil 10:00:53 INFO - building 'psutil._psutil_linux' extension 10:00:53 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 10:00:54 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 10:00:54 INFO - building 'psutil._psutil_posix' extension 10:00:54 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 10:00:54 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 10:00:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:54 INFO - Successfully installed psutil 10:00:54 INFO - Cleaning up... 10:00:54 INFO - Return code: 0 10:00:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f76cb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0660>, '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 0x1fc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1a10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', '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 10:00:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:00:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:00:54 INFO - Using env: {'DISPLAY': ':0', 10:00:54 INFO - 'HOME': '/home/cltbld', 10:00:54 INFO - 'LANG': 'en_US.UTF-8', 10:00:54 INFO - 'LANGUAGE': 'en_US:en', 10:00:54 INFO - 'LOGNAME': 'cltbld', 10:00:54 INFO - 'MAIL': '/var/mail/cltbld', 10:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:54 INFO - 'MOZ_NO_REMOTE': '1', 10:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:54 INFO - 'NO_EM_RESTART': '1', 10:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 10:00:54 INFO - 'SHELL': '/bin/bash', 10:00:54 INFO - 'SHLVL': '1', 10:00:54 INFO - 'TERM': 'linux', 10:00:54 INFO - 'TMOUT': '86400', 10:00:54 INFO - 'USER': 'cltbld', 10:00:54 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', 10:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:54 INFO - '_': '/tools/buildbot/bin/python'} 10:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:00:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:00:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:00:56 INFO - Installing collected packages: mozsystemmonitor 10:00:56 INFO - Running setup.py install for mozsystemmonitor 10:00:56 INFO - Successfully installed mozsystemmonitor 10:00:56 INFO - Cleaning up... 10:00:56 INFO - Return code: 0 10:00:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:56 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 0x7f76cb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0660>, '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 0x1fc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1a10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', '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 10:00:56 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 10:00:56 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 10:00:56 INFO - Using env: {'DISPLAY': ':0', 10:00:56 INFO - 'HOME': '/home/cltbld', 10:00:56 INFO - 'LANG': 'en_US.UTF-8', 10:00:56 INFO - 'LANGUAGE': 'en_US:en', 10:00:56 INFO - 'LOGNAME': 'cltbld', 10:00:56 INFO - 'MAIL': '/var/mail/cltbld', 10:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:56 INFO - 'MOZ_NO_REMOTE': '1', 10:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:56 INFO - 'NO_EM_RESTART': '1', 10:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:00:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:00:56 INFO - 'SHELL': '/bin/bash', 10:00:56 INFO - 'SHLVL': '1', 10:00:56 INFO - 'TERM': 'linux', 10:00:56 INFO - 'TMOUT': '86400', 10:00:56 INFO - 'USER': 'cltbld', 10:00:56 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', 10:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:56 INFO - '_': '/tools/buildbot/bin/python'} 10:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:56 INFO - Downloading/unpacking blobuploader==1.2.4 10:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:58 INFO - Downloading blobuploader-1.2.4.tar.gz 10:00:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:00:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:00:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:00:58 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 10:00:58 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 10:00:58 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 10:00:58 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 10:00:58 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 10:00:58 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 10:00:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:00:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:00:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:00:58 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 10:00:58 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 10:00:58 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 10:00:58 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 10:00:58 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 10:00:58 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 10:00:59 INFO - Downloading docopt-0.6.1.tar.gz 10:00:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:00:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:00:59 INFO - Installing collected packages: blobuploader, requests, docopt 10:00:59 INFO - Running setup.py install for blobuploader 10:00:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:00:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:00:59 INFO - Running setup.py install for requests 10:00:59 INFO - Running setup.py install for docopt 10:00:59 INFO - Successfully installed blobuploader requests docopt 10:00:59 INFO - Cleaning up... 10:00:59 INFO - Return code: 0 10:00:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:00:59 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')]} 10:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:59 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')]} 10:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:59 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 0x7f76cb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0660>, '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 0x1fc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1a10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', '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 10:00:59 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 10:00:59 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 10:00:59 INFO - Using env: {'DISPLAY': ':0', 10:00:59 INFO - 'HOME': '/home/cltbld', 10:00:59 INFO - 'LANG': 'en_US.UTF-8', 10:00:59 INFO - 'LANGUAGE': 'en_US:en', 10:00:59 INFO - 'LOGNAME': 'cltbld', 10:00:59 INFO - 'MAIL': '/var/mail/cltbld', 10:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:59 INFO - 'MOZ_NO_REMOTE': '1', 10:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:59 INFO - 'NO_EM_RESTART': '1', 10:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:00:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:00:59 INFO - 'SHELL': '/bin/bash', 10:00:59 INFO - 'SHLVL': '1', 10:00:59 INFO - 'TERM': 'linux', 10:00:59 INFO - 'TMOUT': '86400', 10:00:59 INFO - 'USER': 'cltbld', 10:00:59 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', 10:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:59 INFO - '_': '/tools/buildbot/bin/python'} 10:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:00 INFO - Running setup.py (path:/tmp/pip-BpnqSN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:00 INFO - Running setup.py (path:/tmp/pip-dHMT5A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:00 INFO - Running setup.py (path:/tmp/pip-Zgpwlv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:00 INFO - Running setup.py (path:/tmp/pip-53jOAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:00 INFO - Running setup.py (path:/tmp/pip-fZFqS8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:00 INFO - Running setup.py (path:/tmp/pip-YTYfvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:00 INFO - Running setup.py (path:/tmp/pip-sho4rd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:00 INFO - Running setup.py (path:/tmp/pip-JJoLbh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:00 INFO - Running setup.py (path:/tmp/pip-D8d9wD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:00 INFO - Running setup.py (path:/tmp/pip-KZcyE9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:00 INFO - Running setup.py (path:/tmp/pip-SE585Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:00 INFO - Running setup.py (path:/tmp/pip-SZUBH7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:00 INFO - Running setup.py (path:/tmp/pip-_Cx44d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:00 INFO - Running setup.py (path:/tmp/pip-FWujp3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:01 INFO - Running setup.py (path:/tmp/pip-sproew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:01 INFO - Running setup.py (path:/tmp/pip-kugZpy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:01 INFO - Running setup.py (path:/tmp/pip-01i104-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:01:01 INFO - Running setup.py install for manifestparser 10:01:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:01:01 INFO - Running setup.py install for mozcrash 10:01:01 INFO - Running setup.py install for mozdebug 10:01:01 INFO - Running setup.py install for mozdevice 10:01:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:01:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:01:01 INFO - Running setup.py install for mozfile 10:01:01 INFO - Running setup.py install for mozhttpd 10:01:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:01:01 INFO - Running setup.py install for mozinfo 10:01:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:01:01 INFO - Running setup.py install for mozInstall 10:01:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:01:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:01:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:01:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:01:02 INFO - Running setup.py install for mozleak 10:01:02 INFO - Running setup.py install for mozlog 10:01:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:01:02 INFO - Running setup.py install for moznetwork 10:01:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:01:02 INFO - Running setup.py install for mozprocess 10:01:02 INFO - Running setup.py install for mozprofile 10:01:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:01:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:01:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:01:02 INFO - Running setup.py install for mozrunner 10:01:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:01:02 INFO - Running setup.py install for mozscreenshot 10:01:02 INFO - Running setup.py install for moztest 10:01:02 INFO - Running setup.py install for mozversion 10:01:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:01:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:01:03 INFO - Cleaning up... 10:01:03 INFO - Return code: 0 10:01:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:03 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 0x7f76cb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0660>, '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 0x1fc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1a10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', '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 10:01:03 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 10:01:03 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 10:01:03 INFO - Using env: {'DISPLAY': ':0', 10:01:03 INFO - 'HOME': '/home/cltbld', 10:01:03 INFO - 'LANG': 'en_US.UTF-8', 10:01:03 INFO - 'LANGUAGE': 'en_US:en', 10:01:03 INFO - 'LOGNAME': 'cltbld', 10:01:03 INFO - 'MAIL': '/var/mail/cltbld', 10:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:03 INFO - 'MOZ_NO_REMOTE': '1', 10:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:03 INFO - 'NO_EM_RESTART': '1', 10:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:03 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:03 INFO - 'SHELL': '/bin/bash', 10:01:03 INFO - 'SHLVL': '1', 10:01:03 INFO - 'TERM': 'linux', 10:01:03 INFO - 'TMOUT': '86400', 10:01:03 INFO - 'USER': 'cltbld', 10:01:03 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', 10:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:03 INFO - '_': '/tools/buildbot/bin/python'} 10:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:03 INFO - Running setup.py (path:/tmp/pip-e3GdmR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:03 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)) 10:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:03 INFO - Running setup.py (path:/tmp/pip-KCOV98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:03 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)) 10:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:03 INFO - Running setup.py (path:/tmp/pip-5tHfGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:03 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)) 10:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:03 INFO - Running setup.py (path:/tmp/pip-9SDuOX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:03 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)) 10:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:03 INFO - Running setup.py (path:/tmp/pip-GduCtb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:03 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)) 10:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:03 INFO - Running setup.py (path:/tmp/pip-p5fbeM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:03 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)) 10:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:03 INFO - Running setup.py (path:/tmp/pip-tE3Ee5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:03 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)) 10:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:03 INFO - Running setup.py (path:/tmp/pip-4T2hMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:03 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)) 10:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:03 INFO - Running setup.py (path:/tmp/pip-6LlwfW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:03 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)) 10:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:03 INFO - Running setup.py (path:/tmp/pip-ZnZJNs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:03 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)) 10:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:03 INFO - Running setup.py (path:/tmp/pip-1LU7EJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:04 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)) 10:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:04 INFO - Running setup.py (path:/tmp/pip-hGX7fc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:04 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)) 10:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:04 INFO - Running setup.py (path:/tmp/pip-ICK8Zc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:04 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)) 10:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:04 INFO - Running setup.py (path:/tmp/pip-FbpK_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:04 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)) 10:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:04 INFO - Running setup.py (path:/tmp/pip-6b0sM2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:04 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)) 10:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:04 INFO - Running setup.py (path:/tmp/pip-Knf63x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:04 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)) 10:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:04 INFO - Running setup.py (path:/tmp/pip-CZNWqR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:04 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)) 10:01:04 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)) 10:01:04 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)) 10:01:04 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)) 10:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:04 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)) 10:01:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:06 INFO - Downloading blessings-1.5.1.tar.gz 10:01:06 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 10:01:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:01:06 INFO - Installing collected packages: blessings 10:01:06 INFO - Running setup.py install for blessings 10:01:06 INFO - Successfully installed blessings 10:01:06 INFO - Cleaning up... 10:01:06 INFO - Return code: 0 10:01:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:01:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:01:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:01:06 INFO - Reading from file tmpfile_stdout 10:01:06 INFO - Current package versions: 10:01:06 INFO - argparse == 1.2.1 10:01:06 INFO - blessings == 1.5.1 10:01:06 INFO - blobuploader == 1.2.4 10:01:06 INFO - docopt == 0.6.1 10:01:06 INFO - manifestparser == 1.1 10:01:06 INFO - mozInstall == 1.12 10:01:06 INFO - mozcrash == 0.16 10:01:06 INFO - mozdebug == 0.1 10:01:06 INFO - mozdevice == 0.48 10:01:06 INFO - mozfile == 1.2 10:01:06 INFO - mozhttpd == 0.7 10:01:06 INFO - mozinfo == 0.9 10:01:06 INFO - mozleak == 0.1 10:01:06 INFO - mozlog == 3.1 10:01:06 INFO - moznetwork == 0.27 10:01:06 INFO - mozprocess == 0.22 10:01:06 INFO - mozprofile == 0.28 10:01:06 INFO - mozrunner == 6.11 10:01:06 INFO - mozscreenshot == 0.1 10:01:06 INFO - mozsystemmonitor == 0.0 10:01:06 INFO - moztest == 0.7 10:01:06 INFO - mozversion == 1.4 10:01:06 INFO - psutil == 3.1.1 10:01:06 INFO - requests == 1.2.3 10:01:06 INFO - wsgiref == 0.1.2 10:01:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f76cb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0660>, '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 0x1fc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1a10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', '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 10:01:06 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 10:01:06 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 10:01:06 INFO - Using env: {'DISPLAY': ':0', 10:01:06 INFO - 'HOME': '/home/cltbld', 10:01:06 INFO - 'LANG': 'en_US.UTF-8', 10:01:06 INFO - 'LANGUAGE': 'en_US:en', 10:01:06 INFO - 'LOGNAME': 'cltbld', 10:01:06 INFO - 'MAIL': '/var/mail/cltbld', 10:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:06 INFO - 'MOZ_NO_REMOTE': '1', 10:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:06 INFO - 'NO_EM_RESTART': '1', 10:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:06 INFO - 'SHELL': '/bin/bash', 10:01:06 INFO - 'SHLVL': '1', 10:01:06 INFO - 'TERM': 'linux', 10:01:06 INFO - 'TMOUT': '86400', 10:01:06 INFO - 'USER': 'cltbld', 10:01:06 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', 10:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:06 INFO - '_': '/tools/buildbot/bin/python'} 10:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:06 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)) 10:01:06 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)) 10:01:06 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)) 10:01:06 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)) 10:01:06 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)) 10:01:06 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)) 10:01:06 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)) 10:01:06 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)) 10:01:06 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)) 10:01:06 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)) 10:01:06 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)) 10:01:06 INFO - Cleaning up... 10:01:06 INFO - Return code: 0 10:01:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f76cb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0660>, '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 0x1fc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1a10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', '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 10:01:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:01:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:01:06 INFO - Using env: {'DISPLAY': ':0', 10:01:06 INFO - 'HOME': '/home/cltbld', 10:01:06 INFO - 'LANG': 'en_US.UTF-8', 10:01:06 INFO - 'LANGUAGE': 'en_US:en', 10:01:06 INFO - 'LOGNAME': 'cltbld', 10:01:06 INFO - 'MAIL': '/var/mail/cltbld', 10:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:06 INFO - 'MOZ_NO_REMOTE': '1', 10:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:06 INFO - 'NO_EM_RESTART': '1', 10:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:06 INFO - 'SHELL': '/bin/bash', 10:01:06 INFO - 'SHLVL': '1', 10:01:06 INFO - 'TERM': 'linux', 10:01:06 INFO - 'TMOUT': '86400', 10:01:06 INFO - 'USER': 'cltbld', 10:01:06 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', 10:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:06 INFO - '_': '/tools/buildbot/bin/python'} 10:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:07 INFO - Downloading/unpacking jsonschema 10:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:01:08 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 10:01:08 INFO - Downloading/unpacking functools32 (from jsonschema) 10:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:09 INFO - Downloading functools32-3.2.3-2.tar.gz 10:01:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:01:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:01:09 INFO - warning: no files found matching '*.txt' 10:01:09 INFO - no previously-included directories found matching 'build' 10:01:09 INFO - no previously-included directories found matching 'dist' 10:01:09 INFO - no previously-included directories found matching '.git*' 10:01:09 INFO - Installing collected packages: jsonschema, functools32 10:01:09 INFO - Running setup.py install for functools32 10:01:09 INFO - warning: no files found matching '*.txt' 10:01:09 INFO - no previously-included directories found matching 'build' 10:01:09 INFO - no previously-included directories found matching 'dist' 10:01:09 INFO - no previously-included directories found matching '.git*' 10:01:09 INFO - Successfully installed jsonschema functools32 10:01:09 INFO - Cleaning up... 10:01:09 INFO - Return code: 0 10:01:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:09 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 0x7f76cb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0660>, '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 0x1fc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1a10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', '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 10:01:09 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 10:01:09 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 10:01:09 INFO - Using env: {'DISPLAY': ':0', 10:01:09 INFO - 'HOME': '/home/cltbld', 10:01:09 INFO - 'LANG': 'en_US.UTF-8', 10:01:09 INFO - 'LANGUAGE': 'en_US:en', 10:01:09 INFO - 'LOGNAME': 'cltbld', 10:01:09 INFO - 'MAIL': '/var/mail/cltbld', 10:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:09 INFO - 'MOZ_NO_REMOTE': '1', 10:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:09 INFO - 'NO_EM_RESTART': '1', 10:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:09 INFO - 'SHELL': '/bin/bash', 10:01:09 INFO - 'SHLVL': '1', 10:01:09 INFO - 'TERM': 'linux', 10:01:09 INFO - 'TMOUT': '86400', 10:01:09 INFO - 'USER': 'cltbld', 10:01:09 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', 10:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:09 INFO - '_': '/tools/buildbot/bin/python'} 10:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:09 INFO - Downloading/unpacking flake8 10:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:01:11 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 10:01:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:01:11 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 10:01:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:11 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 10:01:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:01:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:01:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:01:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:01:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:01:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:01:11 INFO - no previously-included directories found matching 'docs/_build' 10:01:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:01:11 INFO - Running setup.py install for pep8 10:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:01:12 INFO - no previously-included directories found matching 'docs/_build' 10:01:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:01:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:01:12 INFO - Cleaning up... 10:01:12 INFO - Return code: 0 10:01:12 INFO - Running post-action listener: _resource_record_post_action 10:01:12 INFO - Running post-action listener: _start_resource_monitoring 10:01:12 INFO - Starting resource monitoring. 10:01:12 INFO - ##### 10:01:12 INFO - ##### Running install step. 10:01:12 INFO - ##### 10:01:12 INFO - Running pre-action listener: _resource_record_pre_action 10:01:12 INFO - Running main action method: install 10:01:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:01:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:01:12 INFO - Reading from file tmpfile_stdout 10:01:12 INFO - Detecting whether we're running mozinstall >=1.0... 10:01:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:01:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:01:12 INFO - Reading from file tmpfile_stdout 10:01:12 INFO - Output received: 10:01:12 INFO - Usage: mozinstall [options] installer 10:01:12 INFO - Options: 10:01:12 INFO - -h, --help show this help message and exit 10:01:12 INFO - -d DEST, --destination=DEST 10:01:12 INFO - Directory to install application into. [default: 10:01:12 INFO - "/builds/slave/test-pgo"] 10:01:12 INFO - --app=APP Application being installed. [default: firefox] 10:01:12 INFO - mkdir: /builds/slave/test-pgo/build/application 10:01:12 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'] 10:01:12 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 10:01:28 INFO - Reading from file tmpfile_stdout 10:01:28 INFO - Output received: 10:01:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:01:28 INFO - Running post-action listener: _resource_record_post_action 10:01:28 INFO - ##### 10:01:28 INFO - ##### Running run-tests step. 10:01:28 INFO - ##### 10:01:28 INFO - Running pre-action listener: _resource_record_pre_action 10:01:28 INFO - Running main action method: run_tests 10:01:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:01:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:01:28 INFO - Python 2.7.3 10:01:28 INFO - Return code: 0 10:01:28 INFO - grabbing minidump binary from tooltool 10:01: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')]} 10:01:28 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 0x1fc0660>, '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 0x1fc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:01:28 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 10:01:28 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 10:01:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:01:28 INFO - Return code: 0 10:01:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:01:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:01:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:01:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:01:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:01:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:01:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:01:29 INFO - Return code: 0 10:01:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 10:01:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 10:01:29 INFO - Using env: {'DISPLAY': ':0', 10:01:29 INFO - 'HOME': '/home/cltbld', 10:01:29 INFO - 'LANG': 'en_US.UTF-8', 10:01:29 INFO - 'LANGUAGE': 'en_US:en', 10:01:29 INFO - 'LOGNAME': 'cltbld', 10:01:29 INFO - 'MAIL': '/var/mail/cltbld', 10:01:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:01:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:29 INFO - 'MOZ_NO_REMOTE': '1', 10:01:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:29 INFO - 'NO_EM_RESTART': '1', 10:01:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:29 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:01:29 INFO - 'SHELL': '/bin/bash', 10:01:29 INFO - 'SHLVL': '1', 10:01:29 INFO - 'TERM': 'linux', 10:01:29 INFO - 'TMOUT': '86400', 10:01:29 INFO - 'USER': 'cltbld', 10:01:29 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833', 10:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:29 INFO - '_': '/tools/buildbot/bin/python'} 10:01:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 10:01:29 INFO - mozversion application_buildid: 20160115073420 10:01:29 INFO - mozversion application_changeset: 7701bd27ec28b32d99f470d599c9ef2eddc9b94c 10:01:29 INFO - mozversion application_display_name: Nightly 10:01:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:01:29 INFO - mozversion application_name: Firefox 10:01:29 INFO - mozversion application_remotingname: firefox 10:01:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:01:29 INFO - mozversion application_vendor: Mozilla 10:01:29 INFO - mozversion application_version: 46.0a1 10:01:29 INFO - mozversion platform_buildid: 20160115073420 10:01:29 INFO - mozversion platform_changeset: 7701bd27ec28b32d99f470d599c9ef2eddc9b94c 10:01:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:01:29 INFO - mozversion platform_version: 46.0a1 10:01:29 INFO - using testdate: 1452880889 10:01:29 INFO - actual date: 1452880889 10:01:29 INFO - starting webserver on 'localhost:36688' 10:01:29 INFO - SUITE-START | Running 3 tests 10:01:29 INFO - TEST-START | dromaeo_css 10:01:29 INFO - operating with platform_type : linux_ 10:01:29 INFO - Initialising browser for dromaeo_css test... 10:01:29 INFO - TEST-INFO | started process 3885 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmrx6qJ/profile http://localhost:36688/getInfo.html) 10:01:33 INFO - PROCESS | 3885 | 10:01:33 INFO - PROCESS | 3885 | (process:3970): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:01:34 INFO - PROCESS | 3885 | __metrics Screen width/height:1600/1200 10:01:34 INFO - PROCESS | 3885 | colorDepth:24 10:01:34 INFO - PROCESS | 3885 | Browser inner width/height: 1024/697 10:01:34 INFO - PROCESS | 3885 | __metrics 10:01:34 INFO - PROCESS | 3885 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:01:35 INFO - TEST-INFO | 3885: exit 0 10:01:35 INFO - Browser initialized. 10:01:35 INFO - Running cycle 1/1 for dromaeo_css test... 10:01:35 INFO - TEST-INFO | started process 4019 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmrx6qJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:36 INFO - PROCESS | 4019 | 10:01:36 INFO - PROCESS | 4019 | (process:4077): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:01:47 INFO - PROCESS | 4019 | RSS: Main: 150859776 10:01:47 INFO - PROCESS | 4019 | 10:02:36 INFO - PROCESS | 4019 | 1452880956927 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] 10:04:45 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:36688/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36688/tests/dromaeo/cssquery-ext.html) 10:04:46 INFO - PROCESS | 4019 | RSS: Main: 156266496 10:04:46 INFO - PROCESS | 4019 | 10:07:48 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:36688/tests/dromaeo/cssquery-ext.html (next: http://localhost:36688/tests/dromaeo/cssquery-jquery.html) 10:07:49 INFO - PROCESS | 4019 | RSS: Main: 151998464 10:07:49 INFO - PROCESS | 4019 | 10:10:51 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:36688/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36688/tests/dromaeo/cssquery-mootools.html) 10:10:51 INFO - PROCESS | 4019 | RSS: Main: 151146496 10:10:51 INFO - PROCESS | 4019 | 10:13:53 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:36688/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36688/tests/dromaeo/cssquery-prototype.html) 10:13:54 INFO - PROCESS | 4019 | RSS: Main: 150814720 10:13:54 INFO - PROCESS | 4019 | 10:16:56 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:36688/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36688/tests/dromaeo/cssquery-yui.html) 10:16:57 INFO - PROCESS | 4019 | RSS: Main: 151728128 10:16:57 INFO - PROCESS | 4019 | 10:19:59 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:36688/tests/dromaeo/cssquery-yui.html (next: http://localhost:36688/tests/dromaeo/cssquery-dojo.html) 10:20:00 INFO - PROCESS | 4019 | RSS: Main: 153763840 10:20:00 INFO - PROCESS | 4019 | 10:20:00 INFO - PROCESS | 4019 | __start_tp_report 10:20:00 INFO - PROCESS | 4019 | _x_x_mozilla_page_load 10:20:00 INFO - PROCESS | 4019 | _x_x_mozilla_page_load_details 10:20:00 INFO - PROCESS | 4019 | |i|pagename|runs| 10:20:00 INFO - PROCESS | 4019 | |0;dojo.html;3210.7110360067572;3214.324991751732;3230.9030729078136;3234.5309930060134;3258.9022329330114;5223.503767142125;5293.602979776513;5328.653637513559;5329.387120481146;5362.544183744381;5246.37043554773;5360.088784906566;5375.865603359918;5423.83728488145;5479.986202552521;4849.102915960541;4903.9754801225945;4950.405951285851;4986.4514903360605;4991.800327986876;4945.901081978376;4953.975230123844;4973.229149481818;4999.75001249936;5009.499050094998;4813.6389770767155;4850.320955066293;4869.853904382892;4896.559309662111;4930.531599498042;4837.685550439211;4860.149473842063;4868.756562171912;4877.780499877514;4904.362432883738;4850.490698476645;4857.101436234273;4872.488388719169;4884.560389564921;4888.266759985995;5122.92315615266;5123.462036486189;5149.433562308143;5243.947560524384;5271.182966640177;5795.1017592273265;5806.767729290866;5811.012127938261;5813.593048486608;5816.302043754734;5631.549476041907;5831.562632802515;5853.2976042875125;5854.677992710399;5863.179154918314;5269.815556455505;5350.3312085989255;5379.085555455582;5416.079266524661;5437.537809286216;5901.940980590225;5904.911426328608;5915.881682366415;5922.2597175353085;5927.525797936155;5596.244506991586;5682.062459694104;5709.571782116358;5735.569832262514;5758.021136406821;5744.741486633112;5779.797707080232;5780.53755699543;5782.653040817564;5824.126381042793;5684.744186511617;5733.770649173986;5768.077107662753;5785.305763308345;5811.622244554175;5629.380768115504;5718.228039214653;5724.341700704389;5759.280089988752;5780.219670344533;4439.689221754511;4443.622292105143;4455.064436468313;4481.5070342262325;4491.416115904912;3975.5030621172355;3982.7012974027066;4000.2799496090984;4016.377461493473;4020.43713880057;5224.634275600747;5286;5395.325584301962;5441.646292990943;5515.062439385314;5755.194272801811;5760.251167348218;5760.74076666551;5778.8266352009505;5792.478676919013;5363.892722145613;5417.901246843092;5422.945770542323;5425.755840987165;5426.213199086189;4811.855644330676;4845.830395936196;4905.435874874363;4978.6763860348965;5005.124103281911;6038.607490513103;6040.395960403925;6053.636781793107;6053.8486537836025;6069.757209711651;5813.709314534341;5824.9417505826095;5832.533397328289;5838.503727183237;5846.678432686073;5845.678487683218;5877.353491115889;6017.428344307284;6035.879282414415;6117.724702388314;5694.629849059798;5714.5999780015;5737.885242295214;5745.396733342939;5747.885042299215;5704.087346024616;5814.592978491465;5847.8245652630485;5852.619579727304;5865.237519122486;5561.749721262472;5635.323761148525;5639.88720225585;5660.490555849993;5750.568707347049;5602.719864006865;5608.10270356741;5632;5643.322801263875;5676.829695109153;5412.594055445936;5492.231087647652;5529;5532.419095994863;5553.333599968029;5638.802641907513;5676.403977582295;5685.914711279417;5703.942960570507;5720.313562372542;5538.778448862;5561.833145005657;5594.1608758686525;5616.971915140562;5627.8593035174445 10:20:00 INFO - PROCESS | 4019 | |1;ext.html;515.2554558662733;522.2218893848164;535.4966331648251;560.8541779137424;570.4723131103729;28000;36142;36333;36467.81766091172;36585;39138.21723565527;39465.605343946554;39588.406173907344;39694.80152599233;39762;8448;8577.742667719978;8637.438566493189;8660.480371177719;8689.131086891324;8329.125441828612;8477.237048665618;8481.66073357065;8485.66057357705;8485.830283394329;8484.194001569871;8509.106543812872;8558.572071396406;8560.48637081774;8566.657333706644;8379.58102094896;8453.196946290092;8523.74428767138;8617.09520500351;8678.479291242546;8578.871316930252;8635.784105397352;8661.393702440831;8695.087015863306;8695.347848911357;38554;39052.21895562073;39070.41394379087;39126.41310380347;39165.41251881196;3152.4640811062172;3194.4569423198113;3290.07877794218;3331.6501767314567;3519.8592056317716;28848.27879303013;28943.56584651232;29175.854120729262;29279.2680182995;29538.852305738335;3755.455458958463;3775.886723398275;3808.5048943637426;3830.7510011849417;3910.1397692507885;265461;265798;267826;268572.657136715;269018;52200.738996304775;53050;56001;56253.43746562564;56365.71817140888;62116;63364;63368.683156583924;63414.36585634177;63592;15899.602509937113;15977.920110399373;16010.839891601168;16069.839301607068;16173.919130404272;11531.13516486267;11586.47860846264;11595.942020289845;11614.709632259091;11640.592579259855;18630.44108676742;18640.254389824255;18800.529986750167;19424.8057519423;19522.219111235674;7757.534547927143;7769.844603108019;7939.245771651684;7958.363330933512;8030;918.4397517514311;941.0730430525927;1004.9397036177853;1103.6799328194895;1148.655403378983;27863.721362786113;29625.25936851596;30262.394752104836;30968.84515577453;31369.215769605944;1008.8561806161906;1034.0590063042596;1062.8671416072991;1075.3601607043797;1090.1714696830466;13244.205347678977;13301.135426197266;13350.732985340239;13376.264305463294;13378.264195469343;317664;319078;322835;324292;325080;48953.755231223615;49038.26442603364;49403.752981234866;49427.752861235465;49739.25391119136;1323.953661621858;1347.3802051056623;1347.4946894914408;1353.8713822186876;1366.7129902720342;25087.498250034532;26329.473410532064;26497.33756656099;26628.467430651664;26668;48183.75908120437;48772.2684159745;49221.507784923124;49247;49249.75375123245;233366;236107;237463.0634234158;237824;238117;30749.92500749907;31309.43452827304;31386.68613313929;31407;31769.8411507941;38171;39927.600723992386;40706.59293407028;41439;41566.376504353066;34300.48549271713;34464.31071378508;34812.82593587016;35322.29355412826;35324;35508.64491355053;38543;38692.80653596714;39313.41029884611;40317;33692.663073369935;33832.66167338295;34172.82913585416;34179.14552136217;34215.144621384665;30349;31948.20129496781;32163.839180803945;32594.348113038082;32692;24197.879010604833;24209.636855447534;24623.13819016326;25046.123385681414;25194.496110078064 10:20:00 INFO - PROCESS | 4019 | |2;jquery.html;368.14503525162377;370.9387950988087;371.23525537392953;373.18645353130177;375.6056141051895;15261.23693815309;16396.83603163968;16917.661646767057;17139.228734706936;17736.201870915807;10804.459777011138;11233.943830280858;16247.593810154753;16383.344666213367;16383.83616163838;4871.9025619487675;5483.917741233885;5496.80761173359;5499.50504454599;5527.889442211153;4510.302848874929;5449.591280653947;5495.587830912677;5497.8075767348155;5519.69641669708;4968.080905032581;5141.203113517392;5187.351581052369;5415.241866138744;5426.104692725696;5049.444561098277;5074.771635276403;5105.081085404626;5105.668131571436;5546.278983732089;5366.06093933564;5371.167469042305;5372.462753724635;5373.81191658294;5374.838754837361;13275.86724132756;19090.809091909043;19843.90078049615;19881.701774473393;19993.500162495908;1869.8597605179666;1965.685490321556;1979.8835887995117;2047.406252186864;2183.2795177591356;9651.565679544437;10609.310394824312;11132.610358637408;12824.935875320656;12853;1795.8473529749988;1831.7618709567805;1852.2128095559333;1858.869879108463;1862.8044055374262;56197.71901140468;57350;57814.71092644552;57839.71080144614;59680;10079.193664506822;10142.087212150942;10210.948945255226;10283.588656453658;10346.120579750655;13435.932820335836;13458.730825383438;13520.661983450493;13526.18842869431;13598.32008399576;7258.564486130744;7340.192578816326;7598.924010759933;7656.119546252252;7657.157712651604;7204.56772593646;7228.31331023552;7239.746608868664;7272.018277532571;7389.113306403158;4396.648268138541;4428.402165707653;4432.645388368923;4440.578145076212;4446.666500012448;1813.6010077782867;1830.350225669868;1836.977020325483;1871.2327945542263;1904.495308743184;854.3421565394611;885.3227281129941;913.6162811619135;1025.8461230815437;1073.1093192650083;15388.307526161127;15643.452479163174;15911.920440397724;16521.91739041297;17026.148692565323;798.0503201190564;885.300612516105;924.6255266617031;956.5408603870181;967.5694316029441;5791.710414479259;5880.529867533117;6103.84740381494;6111.877762444727;6175.135481032659;555156;555603;558912;568674;580167;72445;72680;72761;72997.6350118246;77572.61213694008;451.71767645221735;461.04793601213385;463.05536705121847;464.7420681521788;465.0907475884637;10446.112080473245;10555.577776888838;10752.354858708502;14177.645558860699;14949.476768313058;30690.539641905834;31715.524267136472;32466.513002304513;33173.668263318024;33233.169170770925;37460;37526.2494750098;38002.61997380101;41186.79406603068;43753.34369984389;6533;6936.132983377078;6986.860262794818;7274.599897005715;7393.778186654409;9699.951500242454;10676.519556619816;10709.250352475563;10831.620893268699;11059.336439813314;6789.592624442549;7159.606221657858;7220.375415531464;7461.701531938662;7656.119546252252;7123.257545844991;7214.71141154348;7454.739084132029;7619.65711542993;7755.961220193863;7511.51175173612;7859.4891332063235;7908.52548847071;7973.401994850294;8010.319122874621;10136.290459668047;10331.225158113322;10438.164946804389;10447.94776026115;10506.36961782265;10298.330608510423;10444.2166837489;10449.68650940473;10499.107575856138;10631.521581528696 10:20:00 INFO - PROCESS | 4019 | |3;mootools.html;1510.9093454392735;1530.502586659336;1719.3810228317802;1821.899795511248;1851.324266642674;7914.24814642608;8085.555294458803;8104.068032176301;8170.591470426484;8210.507369557823;8184.836303273931;8223.177682231788;8260.380471464634;8265;8273.875891861611;2351.600227961242;2388.8566685998894;2392.0670938334065;2393.4614711689906;2398.4843258699375;2409.217004473553;2420.818438617102;2438.036975394718;2439.865807380593;2451.8038556915494;2330.1378489958656;2374.845635033726;2381.9642705359433;2394.425337918896;2402.1712509184304;2367.490989437262;2379.048380647746;2385.7137143542714;2394.820388470872;2396.7363590005084;2409.361519197414;2420.165043060141;2420.673209116764;2422.2733180045916;2426.065964603623;8040.477368971056;8067.354611631055;8075.596220189026;8076.071251806059;8113.066997295268;4873.853784386474;5030.170021946375;5033.345665063555;5040.672356296829;5055.039542486916;3182.5067114597273;3196.744260459158;3234.3692979868933;3241.675832416763;3248.5127230915314;971.2715463402449;972.547765289144;972.7033254857266;1012.86832711747;1031.752379428939;11515.654530364103;11589.36258505782;11617.18679692422;11617.18679692422;11620.128490363257;4352.630026447724;4444.355568442623;4513.097380523908;4519.54804519552;4525.411696479437;9218.124278193562;9230.86153707695;9306.115918987685;9307.395019323721;9351.345405821663;4890.779914903838;4920.72935988524;4944.035912996931;4965.503449655078;4995.525425084611;4480.103979204172;4504.324351347324;4526.547345265447;4528.071745292207;4540.500544940054;3655.323765103464;3729.160938788805;3737.663610275034;3753.1930634913624;3759.661630453272;1151.2689442204094;1161.349644199251;1163.9359835208975;1181.9940900295614;1206.4510647655295;1010.8584798128268;1034.6689059501039;1035.49260862177;1163.2380790582183;1287.9871201288054;7180.5691658500655;7222.566646001257;7286.162091359455;7291.161516425679;7330.120385553768;1081.1296905990753;1087.635642059903;1091.4651820608003;1095.5179720922768;1110.5169251375678;5407.215953686772;5483.259759932438;5496.367917689517;5502.477264659851;5539.362973258127;9483.90516094844;9722.569357660585;9741.123298903132;9795.804083918281;9940.900590993997;9526.90473095274;9627.229821614254;9632.373895696757;9718.930917599058;9722.854157187649;7528.247175282538;7571.053618297603;7577.431692622965;7608.972788673458;7709.267619576131;7510.8497830042;7527.774166775005;7541.396688264816;7554.244575542401;7613.809654758676;8672.089430609694;8812.603432845666;8981.595828187877;9144.222741067084;9195.310351723514;9086.45481271126;9171.587278572613;9211.815763684555;9224.215941644767;9279.72160835176;7363.595002274712;7498.32515073646;7499.700011999459;7502.287282708134;7521.887171692539;7599.924000760143;7636.389088872766;7667.3099421052375;7673;7694.269044440769;6926.9307306926285;7485.925140748523;7519.812004699927;7579.54522728638;7675.808104797201;6818.62439146174;6961.199462061928;6986.371226589631;7075.540089894141;7090.220075791762;6872.209695885037;6916.066331045245;6945.861082778417;6972.860542789014;6986.685599147949;6156.415140561639;6221.253449586078;6221.3156552778255;6222.875542489034;6245.406686364788;6266.467350275278;6354.3963323484195;6472.546921715623;6477.643729594917;6517.576357536745 10:20:00 INFO - PROCESS | 4019 | |4;prototype.html;342.7771948233649;343.4761987968348;354.19420817639883;355.28587539046526;357.32465639940517;6198.690065496729;6250.406211409914;6341.112244285798;6376;6387.776427825027;6081.878362432749;6241.875162496747;6265.436110750032;6281.089242059898;6282.685865706708;4767.761611919407;4801.759912004403;4803.423589169304;4810.134175848346;4820.156472617296;4799.400074990626;4808.062427826575;4812.278158276269;4817.4219093708625;4825.493323201066;4715.12770137524;4813.253945638432;4813.614910807127;4820.25286080658;4821.349117869096;4727.290906364038;4730.030343779517;4763.618910487153;4769.18923782956;4784.784684689214;4223.092035212444;4223.619874211305;4238.660907127453;4251.787410629487;4252.277112890816;5981.282246130449;5986.790462333841;5987.742574059453;6002.159697642333;6006.609570377911;5441.319835020622;5541;5544.6118771686;5561.776409189972;5568.52667523261;6607.405333519958;6619.073329733841;6626.635535045571;6628.966855165741;6631.93368066318;4565.383673204108;4601.723896566216;4606.147862645421;4618.722876627413;4619.030003699228;6753;6895.55178913369;6909.067275917737;6966.79099627012;6994.685239164199;4640.814367425332;4642.675012749075;4654.627629789608;4664.533546645308;4693.272542755878;4733.9763301183275;4738.976305118453;4750.429948406213;4754.976225118852;4759.50025247344;5533.889322213533;5536.723163841792;5546.584006199551;5552.416996215339;5571.1086226203615;6574.704138313788;6674.399304062561;6726.226483954408;6738.561993470409;6739.292374300726;1653.1321056445222;1654.0571874031687;1700.039477695123;1701.1494252873563;1704.0457343887463;1130.5534313945946;1138.0099313597223;1139.601139601133;1150.2810743285447;1150.8331291962618;6294.339094395114;6319.526035547352;6319.715612797435;6325.620462772248;6340.3342649022115;6812.080369150101;6856.142982127234;6859;6860.108185935796;6877.828054298682;6249.25008998923;6306.337834527309;6312.0531920211415;6314.526410519229;6316.747330106744;3761.2101458693433;3798.088458769875;3798.1264309209037;3800.809959502014;3805.334066538345;7341.559506429631;7346.889796653055;7354.889676654854;7355.264473552709;7366.337029667248;7005;7188.317109874553;7218.422526197892;7251.891221631679;7254.709811607582;7260.273972602803;7278.417726581861;7280.199178090405;7284.927150728425;7294.197638259787;6977.79066628002;6982.197047339621;6984.126984126984;6986.441084713312;6994.650267486503;6689.899651505329;6915.481338899704;6923.238443771081;6929;6939.479539034492;7231.2768723127265;7275.745348912763;7312.488125831141;7324.523905946096;7334.193238743841;4732.976335118303;4733.810647574196;4757.881052973703;4758.976205118952;4764.071006153767;6837.3162683731225;6848.075509806312;6979.232284448808;7042.366187043191;7051.894221586577;6730.663466826737;6757.425618822259;6763.458923286224;6799.150106236721;6836.350546698056;6793.966030169818;6816.931830681629;6817.5909445433435;6825.385715285648;6840.589564626139;6559.967200164159;6696.732130714717;6714.127163468718;6721.966390168018;6724.630145341857;6776.254611992578;6810.557313774589;6843;6843.076184715199;6865.794026179223;6680.164979377578;6692.029655699994;6692.631905245258;6697;6704.195496540447 10:20:00 INFO - PROCESS | 4019 | |5;yui.html;654.2312782480584;666.167290886392;787.8109253779095;803.1286054630727;833.6030674999378;13367.398467068968;13412.128211666235;13432.194068355893;13498.527551535673;13521.864781352184;12551.995840332775;12615;12672.746545069092;12698.111132220749;12704.237745735263;653.6698967021659;665.3911670821217;799.3445374792673;812.5246730662569;813.4346629092782;779.6101949025488;782.7221336425572;792.5244853088159;793.6904607203195;794.5629903553023;830.754927296446;835.2357592802579;837.5644664774313;842.5029232752674;844.1769274956898;829.1128492513013;831.3847752663016;832.6003518311245;833.0544831616129;839.08539691736;619.6777675608703;620.8665136995522;622.9034499652561;623.8845813524467;624.8250489862845;13058.738825223443;13157.144785588906;13163;13205.405756740874;13293.86706132936;12628.873711262953;12645.936770316182;12910.354482275849;13241.470341186341;13358.666033349147;10359.533820978075;10385.221108416823;10526.631567895163;10638.946805266001;10939.781204375868;4141.937870931938;4250.957490425087;4256.063665993507;4361.018770776582;4363.825446982117;46112;46146.76926615379;46230.53769462296;46543;48126.03747925022;9245.815083698288;9632.807343853225;10021.498925053718;10242.129418999319;10295.639652612123;17311.489833974003;17393.217305221042;17408.912955435142;17458.912705436647;17662.823371766375;7676.654550545239;7677.0403699537555;7735;7735.497192682457;7744.883826742604;4215.915681686349;4477.731336119843;4551.726896386227;4570.3829982951875;4580.290055041474;2958.644962604458;2982.3737015227043;3026.7124623160767;3027.6518200406795;3039.0730827097946;581.1921429213397;588.785093440891;599.5832896137143;600.0279547133672;601.2514419547691;579.5421616922584;579.8898209340211;594.8602078511547;623.4420193926501;664.9442010048231;7784.844303113906;7945.364370850433;8250.917490825135;9271.165595096474;9665.178459830993;556.6993823335354;571.44855214718;592.1591340296789;603.6316857156976;674.8043067510465;3876.917850309011;4029.6171863672903;4064.6138616831354;4097.262492751273;4175.54069052404;55408.72295638577;55732.72133639306;55975.720121399136;56185.71907140438;56609.71695141498;50240.49759502431;51441.22838157356;51681.483185167664;52104.73947630238;52123;44945;45135.774321128185;45281;45285.54714452814;45541.31688024682;6873.20958089806;7821.687132514636;7827.139014708491;7919.564423956507;8050.074241462306;32379.51430728588;33046.83476582602;33576;33640.3271934555;33756;40969.59030409658;44288.33567496554;44772.55227447814;45009.42467013639;45147;9433.198178154933;9784.412935223909;10647.414392208502;10687.061058209054;11174.608888689181;11457.885421146015;11632.011279041377;11680.649580512598;11813.645590632295;11988.100892433276;10633.149348052291;10755;10981.341119532854;11375.31748095117;11634.12744044217;11127.276727012719;11323.660290191307;11478.88521114778;11526.942365288456;12093.697657558632;11109.94445027802;11387.430628468377;11551.249168804;11616.12879034059;11766.82349764737;8164.428490005643;8237.752867413987;8437.426584891668;8495.108013658724;8496.70261540843;8461.661533538589;8616.870746938926;8690.78273043179;8853.07042760501;9034.593443294936 10:20:00 INFO - PROCESS | 4019 | __end_tp_report 10:20:00 INFO - PROCESS | 4019 | __start_cc_report 10:20:00 INFO - PROCESS | 4019 | _x_x_mozilla_cycle_collect,320 10:20:00 INFO - PROCESS | 4019 | __end_cc_report 10:20:00 INFO - PROCESS | 4019 | __startTimestamp1452882000200__endTimestamp 10:20:00 INFO - PROCESS | 4019 | 10:20:00 INFO - PROCESS | 4019 | ------- Summary: start ------- 10:20:00 INFO - PROCESS | 4019 | Number of tests: 6 10:20:00 INFO - PROCESS | 4019 | 10:20:00 INFO - PROCESS | 4019 | [#0] dojo.html Cycles:165 Average:5359.69 Median:5561.83 stddev:599.28 (10.8%) stddev-sans-first:576.92 10:20:00 INFO - PROCESS | 4019 | Values: 3210.7 3214.3 3230.9 3234.5 3258.9 5223.5 5293.6 5328.7 5329.4 5362.5 5246.4 5360.1 5375.9 5423.8 5480.0 4849.1 4904.0 4950.4 4986.5 4991.8 4945.9 4954.0 4973.2 4999.8 5009.5 4813.6 4850.3 4869.9 4896.6 4930.5 4837.7 4860.1 4868.8 4877.8 4904.4 4850.5 4857.1 4872.5 4884.6 4888.3 5122.9 5123.5 5149.4 5243.9 5271.2 5795.1 5806.8 5811.0 5813.6 5816.3 5631.5 5831.6 5853.3 5854.7 5863.2 5269.8 5350.3 5379.1 5416.1 5437.5 5901.9 5904.9 5915.9 5922.3 5927.5 5596.2 5682.1 5709.6 5735.6 5758.0 5744.7 5779.8 5780.5 5782.7 5824.1 5684.7 5733.8 5768.1 5785.3 5811.6 5629.4 5718.2 5724.3 5759.3 5780.2 4439.7 4443.6 4455.1 4481.5 4491.4 3975.5 3982.7 4000.3 4016.4 4020.4 5224.6 5286.0 5395.3 5441.6 5515.1 5755.2 5760.3 5760.7 5778.8 5792.5 5363.9 5417.9 5422.9 5425.8 5426.2 4811.9 4845.8 4905.4 4978.7 5005.1 6038.6 6040.4 6053.6 6053.8 6069.8 5813.7 5824.9 5832.5 5838.5 5846.7 5845.7 5877.4 6017.4 6035.9 6117.7 5694.6 5714.6 5737.9 5745.4 5747.9 5704.1 5814.6 5847.8 5852.6 5865.2 5561.7 5635.3 5639.9 5660.5 5750.6 5602.7 5608.1 5632.0 5643.3 5676.8 5412.6 5492.2 5529.0 5532.4 5553.3 5638.8 5676.4 5685.9 5703.9 5720.3 5538.8 5561.8 5594.2 5617.0 5627.9 10:20:00 INFO - PROCESS | 4019 | 10:20:00 INFO - PROCESS | 4019 | [#1] ext.html Cycles:180 Average:44385.20 Median:19166.34 stddev:72490.13 (378.2%) stddev-sans-first:72618.65 10:20:00 INFO - PROCESS | 4019 | Values: 515.3 522.2 535.5 560.9 570.5 28000.0 36142.0 36333.0 36467.8 36585.0 39138.2 39465.6 39588.4 39694.8 39762.0 8448.0 8577.7 8637.4 8660.5 8689.1 8329.1 8477.2 8481.7 8485.7 8485.8 8484.2 8509.1 8558.6 8560.5 8566.7 8379.6 8453.2 8523.7 8617.1 8678.5 8578.9 8635.8 8661.4 8695.1 8695.3 38554.0 39052.2 39070.4 39126.4 39165.4 3152.5 3194.5 3290.1 3331.7 3519.9 28848.3 28943.6 29175.9 29279.3 29538.9 3755.5 3775.9 3808.5 3830.8 3910.1 265461.0 265798.0 267826.0 268572.7 269018.0 52200.7 53050.0 56001.0 56253.4 56365.7 62116.0 63364.0 63368.7 63414.4 63592.0 15899.6 15977.9 16010.8 16069.8 16173.9 11531.1 11586.5 11595.9 11614.7 11640.6 18630.4 18640.3 18800.5 19424.8 19522.2 7757.5 7769.8 7939.2 7958.4 8030.0 918.4 941.1 1004.9 1103.7 1148.7 27863.7 29625.3 30262.4 30968.8 31369.2 1008.9 1034.1 1062.9 1075.4 1090.2 13244.2 13301.1 13350.7 13376.3 13378.3 317664.0 319078.0 322835.0 324292.0 325080.0 48953.8 49038.3 49403.8 49427.8 49739.3 1324.0 1347.4 1347.5 1353.9 1366.7 25087.5 26329.5 26497.3 26628.5 26668.0 48183.8 48772.3 49221.5 49247.0 49249.8 233366.0 236107.0 237463.1 237824.0 238117.0 30749.9 31309.4 31386.7 31407.0 31769.8 38171.0 39927.6 40706.6 41439.0 41566.4 34300.5 34464.3 34812.8 35322.3 35324.0 35508.6 38543.0 38692.8 39313.4 40317.0 33692.7 33832.7 34172.8 34179.1 34215.1 30349.0 31948.2 32163.8 32594.3 32692.0 24197.9 24209.6 24623.1 25046.1 25194.5 10:20:00 INFO - PROCESS | 4019 | 10:20:00 INFO - PROCESS | 4019 | [#2] jquery.html Cycles:180 Average:27799.64 Median:2481.01 stddev:92142.35 (3713.9%) stddev-sans-first:92377.81 10:20:00 INFO - PROCESS | 4019 | Values: 368.1 370.9 371.2 373.2 375.6 15261.2 16396.8 16917.7 17139.2 17736.2 10804.5 11233.9 16247.6 16383.3 16383.8 4871.9 5483.9 5496.8 5499.5 5527.9 4510.3 5449.6 5495.6 5497.8 5519.7 4968.1 5141.2 5187.4 5415.2 5426.1 5049.4 5074.8 5105.1 5105.7 5546.3 5366.1 5371.2 5372.5 5373.8 5374.8 13275.9 19090.8 19843.9 19881.7 19993.5 1869.9 1965.7 1979.9 2047.4 2183.3 9651.6 10609.3 11132.6 12824.9 12853.0 1795.8 1831.8 1852.2 1858.9 1862.8 56197.7 57350.0 57814.7 57839.7 59680.0 10079.2 10142.1 10210.9 10283.6 10346.1 13435.9 13458.7 13520.7 13526.2 13598.3 7258.6 7340.2 7598.9 7656.1 7657.2 7204.6 7228.3 7239.7 7272.0 7389.1 4396.6 4428.4 4432.6 4440.6 4446.7 1813.6 1830.4 1837.0 1871.2 1904.5 854.3 885.3 913.6 1025.8 1073.1 15388.3 15643.5 15911.9 16521.9 17026.1 798.1 885.3 924.6 956.5 967.6 5791.7 5880.5 6103.8 6111.9 6175.1 555156.0 555603.0 558912.0 568674.0 580167.0 72445.0 72680.0 72761.0 72997.6 77572.6 451.7 461.0 463.1 464.7 465.1 10446.1 10555.6 10752.4 14177.6 14949.5 30690.5 31715.5 32466.5 33173.7 33233.2 37460.0 37526.2 38002.6 41186.8 43753.3 6533.0 6936.1 6986.9 7274.6 7393.8 9700.0 10676.5 10709.3 10831.6 11059.3 6789.6 7159.6 7220.4 7461.7 7656.1 7123.3 7214.7 7454.7 7619.7 7756.0 7511.5 7859.5 7908.5 7973.4 8010.3 10136.3 10331.2 10438.2 10447.9 10506.4 10298.3 10444.2 10449.7 10499.1 10631.5 10:20:00 INFO - PROCESS | 4019 | 10:20:00 INFO - PROCESS | 4019 | [#3] mootools.html Cycles:180 Average:5660.62 Median:6234.14 stddev:2958.38 (47.5%) stddev-sans-first:2950.23 10:20:00 INFO - PROCESS | 4019 | Values: 1510.9 1530.5 1719.4 1821.9 1851.3 7914.2 8085.6 8104.1 8170.6 8210.5 8184.8 8223.2 8260.4 8265.0 8273.9 2351.6 2388.9 2392.1 2393.5 2398.5 2409.2 2420.8 2438.0 2439.9 2451.8 2330.1 2374.8 2382.0 2394.4 2402.2 2367.5 2379.0 2385.7 2394.8 2396.7 2409.4 2420.2 2420.7 2422.3 2426.1 8040.5 8067.4 8075.6 8076.1 8113.1 4873.9 5030.2 5033.3 5040.7 5055.0 3182.5 3196.7 3234.4 3241.7 3248.5 971.3 972.5 972.7 1012.9 1031.8 11515.7 11589.4 11617.2 11617.2 11620.1 4352.6 4444.4 4513.1 4519.5 4525.4 9218.1 9230.9 9306.1 9307.4 9351.3 4890.8 4920.7 4944.0 4965.5 4995.5 4480.1 4504.3 4526.5 4528.1 4540.5 3655.3 3729.2 3737.7 3753.2 3759.7 1151.3 1161.3 1163.9 1182.0 1206.5 1010.9 1034.7 1035.5 1163.2 1288.0 7180.6 7222.6 7286.2 7291.2 7330.1 1081.1 1087.6 1091.5 1095.5 1110.5 5407.2 5483.3 5496.4 5502.5 5539.4 9483.9 9722.6 9741.1 9795.8 9940.9 9526.9 9627.2 9632.4 9718.9 9722.9 7528.2 7571.1 7577.4 7609.0 7709.3 7510.8 7527.8 7541.4 7554.2 7613.8 8672.1 8812.6 8981.6 9144.2 9195.3 9086.5 9171.6 9211.8 9224.2 9279.7 7363.6 7498.3 7499.7 7502.3 7521.9 7599.9 7636.4 7667.3 7673.0 7694.3 6926.9 7485.9 7519.8 7579.5 7675.8 6818.6 6961.2 6986.4 7075.5 7090.2 6872.2 6916.1 6945.9 6972.9 6986.7 6156.4 6221.3 6221.3 6222.9 6245.4 6266.5 6354.4 6472.5 6477.6 6517.6 10:20:00 INFO - PROCESS | 4019 | 10:20:00 INFO - PROCESS | 4019 | [#4] prototype.html Cycles:180 Average:5615.60 Median:6313.29 stddev:1711.70 (27.1%) stddev-sans-first:1670.13 10:20:00 INFO - PROCESS | 4019 | Values: 342.8 343.5 354.2 355.3 357.3 6198.7 6250.4 6341.1 6376.0 6387.8 6081.9 6241.9 6265.4 6281.1 6282.7 4767.8 4801.8 4803.4 4810.1 4820.2 4799.4 4808.1 4812.3 4817.4 4825.5 4715.1 4813.3 4813.6 4820.3 4821.3 4727.3 4730.0 4763.6 4769.2 4784.8 4223.1 4223.6 4238.7 4251.8 4252.3 5981.3 5986.8 5987.7 6002.2 6006.6 5441.3 5541.0 5544.6 5561.8 5568.5 6607.4 6619.1 6626.6 6629.0 6631.9 4565.4 4601.7 4606.1 4618.7 4619.0 6753.0 6895.6 6909.1 6966.8 6994.7 4640.8 4642.7 4654.6 4664.5 4693.3 4734.0 4739.0 4750.4 4755.0 4759.5 5533.9 5536.7 5546.6 5552.4 5571.1 6574.7 6674.4 6726.2 6738.6 6739.3 1653.1 1654.1 1700.0 1701.1 1704.0 1130.6 1138.0 1139.6 1150.3 1150.8 6294.3 6319.5 6319.7 6325.6 6340.3 6812.1 6856.1 6859.0 6860.1 6877.8 6249.3 6306.3 6312.1 6314.5 6316.7 3761.2 3798.1 3798.1 3800.8 3805.3 7341.6 7346.9 7354.9 7355.3 7366.3 7005.0 7188.3 7218.4 7251.9 7254.7 7260.3 7278.4 7280.2 7284.9 7294.2 6977.8 6982.2 6984.1 6986.4 6994.7 6689.9 6915.5 6923.2 6929.0 6939.5 7231.3 7275.7 7312.5 7324.5 7334.2 4733.0 4733.8 4757.9 4759.0 4764.1 6837.3 6848.1 6979.2 7042.4 7051.9 6730.7 6757.4 6763.5 6799.2 6836.4 6794.0 6816.9 6817.6 6825.4 6840.6 6560.0 6696.7 6714.1 6722.0 6724.6 6776.3 6810.6 6843.0 6843.1 6865.8 6680.2 6692.0 6692.6 6697.0 6704.2 10:20:00 INFO - PROCESS | 4019 | 10:20:00 INFO - PROCESS | 4019 | [#5] yui.html Cycles:180 Average:13506.58 Median:25346.15 stddev:15614.95 (61.6%) stddev-sans-first:15628.92 10:20:00 INFO - PROCESS | 4019 | Values: 654.2 666.2 787.8 803.1 833.6 13367.4 13412.1 13432.2 13498.5 13521.9 12552.0 12615.0 12672.7 12698.1 12704.2 653.7 665.4 799.3 812.5 813.4 779.6 782.7 792.5 793.7 794.6 830.8 835.2 837.6 842.5 844.2 829.1 831.4 832.6 833.1 839.1 619.7 620.9 622.9 623.9 624.8 13058.7 13157.1 13163.0 13205.4 13293.9 12628.9 12645.9 12910.4 13241.5 13358.7 10359.5 10385.2 10526.6 10638.9 10939.8 4141.9 4251.0 4256.1 4361.0 4363.8 46112.0 46146.8 46230.5 46543.0 48126.0 9245.8 9632.8 10021.5 10242.1 10295.6 17311.5 17393.2 17408.9 17458.9 17662.8 7676.7 7677.0 7735.0 7735.5 7744.9 4215.9 4477.7 4551.7 4570.4 4580.3 2958.6 2982.4 3026.7 3027.7 3039.1 581.2 588.8 599.6 600.0 601.3 579.5 579.9 594.9 623.4 664.9 7784.8 7945.4 8250.9 9271.2 9665.2 556.7 571.4 592.2 603.6 674.8 3876.9 4029.6 4064.6 4097.3 4175.5 55408.7 55732.7 55975.7 56185.7 56609.7 50240.5 51441.2 51681.5 52104.7 52123.0 44945.0 45135.8 45281.0 45285.5 45541.3 6873.2 7821.7 7827.1 7919.6 8050.1 32379.5 33046.8 33576.0 33640.3 33756.0 40969.6 44288.3 44772.6 45009.4 45147.0 9433.2 9784.4 10647.4 10687.1 11174.6 11457.9 11632.0 11680.6 11813.6 11988.1 10633.1 10755.0 10981.3 11375.3 11634.1 11127.3 11323.7 11478.9 11526.9 12093.7 11109.9 11387.4 11551.2 11616.1 11766.8 8164.4 8237.8 8437.4 8495.1 8496.7 8461.7 8616.9 8690.8 8853.1 9034.6 10:20:00 INFO - PROCESS | 4019 | -------- Summary: end -------- 10:20:00 INFO - PROCESS | 4019 | 10:20:00 INFO - TEST-INFO | 4019: exit 0 10:20:00 INFO - TEST-OK | dromaeo_css | took 1111121ms 10:20:00 INFO - TEST-START | kraken 10:20:00 INFO - operating with platform_type : linux_ 10:20:00 INFO - Initialising browser for kraken test... 10:20:00 INFO - TEST-INFO | started process 4264 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuHb2FJ/profile http://localhost:36688/getInfo.html) 10:20:04 INFO - PROCESS | 4264 | 10:20:04 INFO - PROCESS | 4264 | (process:4338): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:20:05 INFO - PROCESS | 4264 | __metrics Screen width/height:1600/1200 10:20:05 INFO - PROCESS | 4264 | colorDepth:24 10:20:05 INFO - PROCESS | 4264 | Browser inner width/height: 1024/697 10:20:05 INFO - PROCESS | 4264 | __metrics 10:20:05 INFO - PROCESS | 4264 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:20:06 INFO - TEST-INFO | 4264: exit 0 10:20:06 INFO - Browser initialized. 10:20:06 INFO - Running cycle 1/1 for kraken test... 10:20:06 INFO - TEST-INFO | started process 4387 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuHb2FJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:07 INFO - PROCESS | 4387 | 10:20:07 INFO - PROCESS | 4387 | (process:4445): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:20:18 INFO - PROCESS | 4387 | RSS: Main: 150814720 10:20:18 INFO - PROCESS | 4387 | 10:20:20 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36688/tests/kraken/driver.html?testName=audio-beat-detection) 10:20:21 INFO - PROCESS | 4387 | RSS: Main: 151564288 10:20:21 INFO - PROCESS | 4387 | 10:20:24 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36688/tests/kraken/driver.html?testName=audio-dft) 10:20:24 INFO - PROCESS | 4387 | RSS: Main: 155459584 10:20:24 INFO - PROCESS | 4387 | 10:20:27 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36688/tests/kraken/driver.html?testName=audio-fft) 10:20:28 INFO - PROCESS | 4387 | RSS: Main: 147902464 10:20:28 INFO - PROCESS | 4387 | 10:20:30 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36688/tests/kraken/driver.html?testName=audio-oscillator) 10:20:31 INFO - PROCESS | 4387 | RSS: Main: 148377600 10:20:31 INFO - PROCESS | 4387 | 10:20:33 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36688/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:20:33 INFO - PROCESS | 4387 | RSS: Main: 149364736 10:20:33 INFO - PROCESS | 4387 | 10:20:36 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36688/tests/kraken/driver.html?testName=imaging-darkroom) 10:20:37 INFO - PROCESS | 4387 | RSS: Main: 150609920 10:20:37 INFO - PROCESS | 4387 | 10:20:40 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36688/tests/kraken/driver.html?testName=imaging-desaturate) 10:20:41 INFO - PROCESS | 4387 | RSS: Main: 149716992 10:20:41 INFO - PROCESS | 4387 | 10:20:44 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36688/tests/kraken/driver.html?testName=json-parse-financial) 10:20:44 INFO - PROCESS | 4387 | RSS: Main: 149614592 10:20:44 INFO - PROCESS | 4387 | 10:20:46 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36688/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:20:47 INFO - PROCESS | 4387 | RSS: Main: 149536768 10:20:47 INFO - PROCESS | 4387 | 10:20:48 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36688/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:20:49 INFO - PROCESS | 4387 | RSS: Main: 150216704 10:20:49 INFO - PROCESS | 4387 | 10:20:51 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36688/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:20:52 INFO - PROCESS | 4387 | RSS: Main: 150290432 10:20:52 INFO - PROCESS | 4387 | 10:20:54 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:55 INFO - PROCESS | 4387 | RSS: Main: 150290432 10:20:55 INFO - PROCESS | 4387 | 10:20:57 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:58 INFO - PROCESS | 4387 | RSS: Main: 150626304 10:20:58 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:36688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36688/tests/kraken/driver.html?testName=ai-astar) 10:21:00 INFO - PROCESS | 4387 | RSS: Main: 151289856 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | __start_tp_report 10:21:00 INFO - PROCESS | 4387 | _x_x_mozilla_page_load 10:21:00 INFO - PROCESS | 4387 | _x_x_mozilla_page_load_details 10:21:00 INFO - PROCESS | 4387 | |i|pagename|runs| 10:21:00 INFO - PROCESS | 4387 | |0;ai-astar;112;107;112;111;112;123;110;114;111;112 10:21:00 INFO - PROCESS | 4387 | |1;audio-beat-detection;154;134;153;166;128;157;157;134;164;127 10:21:00 INFO - PROCESS | 4387 | |2;audio-dft;161;162;162;163;161;162;161;169;167;163 10:21:00 INFO - PROCESS | 4387 | |3;audio-fft;73;72;71;74;75;74;72;142;71;82 10:21:00 INFO - PROCESS | 4387 | |4;audio-oscillator;96;97;148;97;96;97;152;97;97;151 10:21:00 INFO - PROCESS | 4387 | |5;imaging-gaussian-blur;110;111;110;110;109;109;111;110;109;110 10:21:00 INFO - PROCESS | 4387 | |6;imaging-darkroom;147;147;146;147;146;147;146;147;146;147 10:21:00 INFO - PROCESS | 4387 | |7;imaging-desaturate;97;96;100;99;96;96;97;99;95;96 10:21:00 INFO - PROCESS | 4387 | |8;json-parse-financial;60;58;60;58;59;63;60;59;57;64 10:21:00 INFO - PROCESS | 4387 | |9;json-stringify-tinderbox;67;67;67;67;68;68;67;68;67;68 10:21:00 INFO - PROCESS | 4387 | |10;stanford-crypto-aes;83;82;83;82;82;83;84;86;91;84 10:21:00 INFO - PROCESS | 4387 | |11;stanford-crypto-ccm;128;121;121;126;114;123;120;133;114;118 10:21:00 INFO - PROCESS | 4387 | |12;stanford-crypto-pbkdf2;149;142;151;149;140;154;153;146;151;141 10:21:00 INFO - PROCESS | 4387 | |13;stanford-crypto-sha256-iterative;68;68;68;71;75;70;73;66;68;74 10:21:00 INFO - PROCESS | 4387 | __end_tp_report 10:21:00 INFO - PROCESS | 4387 | __start_cc_report 10:21:00 INFO - PROCESS | 4387 | _x_x_mozilla_cycle_collect,736 10:21:00 INFO - PROCESS | 4387 | __end_cc_report 10:21:00 INFO - PROCESS | 4387 | __startTimestamp1452882060303__endTimestamp 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | ------- Summary: start ------- 10:21:00 INFO - PROCESS | 4387 | Number of tests: 14 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:4.14 (3.7%) stddev-sans-first:4.39 10:21:00 INFO - PROCESS | 4387 | Values: 112.0 107.0 112.0 111.0 112.0 123.0 110.0 114.0 111.0 112.0 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:155.50 stddev:15.03 (9.7%) stddev-sans-first:15.75 10:21:00 INFO - PROCESS | 4387 | Values: 154.0 134.0 153.0 166.0 128.0 157.0 157.0 134.0 164.0 127.0 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.50 stddev:2.73 (1.7%) stddev-sans-first:2.78 10:21:00 INFO - PROCESS | 4387 | Values: 161.0 162.0 162.0 163.0 161.0 162.0 161.0 169.0 167.0 163.0 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#3] audio-fft Cycles:10 Average:80.60 Median:73.50 stddev:21.81 (29.7%) stddev-sans-first:22.96 10:21:00 INFO - PROCESS | 4387 | Values: 73.0 72.0 71.0 74.0 75.0 74.0 72.0 142.0 71.0 82.0 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#4] audio-oscillator Cycles:10 Average:112.80 Median:97.00 stddev:25.92 (26.7%) stddev-sans-first:26.77 10:21:00 INFO - PROCESS | 4387 | Values: 96.0 97.0 148.0 97.0 96.0 97.0 152.0 97.0 97.0 151.0 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 10:21:00 INFO - PROCESS | 4387 | Values: 110.0 111.0 110.0 110.0 109.0 109.0 111.0 110.0 109.0 110.0 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:21:00 INFO - PROCESS | 4387 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:96.50 stddev:1.66 (1.7%) stddev-sans-first:1.76 10:21:00 INFO - PROCESS | 4387 | Values: 97.0 96.0 100.0 99.0 96.0 96.0 97.0 99.0 95.0 96.0 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:60.00 stddev:2.20 (3.7%) stddev-sans-first:2.33 10:21:00 INFO - PROCESS | 4387 | Values: 60.0 58.0 60.0 58.0 59.0 63.0 60.0 59.0 57.0 64.0 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 10:21:00 INFO - PROCESS | 4387 | Values: 67.0 67.0 67.0 67.0 68.0 68.0 67.0 68.0 67.0 68.0 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.50 stddev:2.75 (3.3%) stddev-sans-first:2.89 10:21:00 INFO - PROCESS | 4387 | Values: 83.0 82.0 83.0 82.0 82.0 83.0 84.0 86.0 91.0 84.0 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:122.00 stddev:6.00 (4.9%) stddev-sans-first:5.93 10:21:00 INFO - PROCESS | 4387 | Values: 128.0 121.0 121.0 126.0 114.0 123.0 120.0 133.0 114.0 118.0 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:150.00 stddev:5.08 (3.4%) stddev-sans-first:5.36 10:21:00 INFO - PROCESS | 4387 | Values: 149.0 142.0 151.0 149.0 140.0 154.0 153.0 146.0 151.0 141.0 10:21:00 INFO - PROCESS | 4387 | 10:21:00 INFO - PROCESS | 4387 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:3.03 (4.3%) stddev-sans-first:3.12 10:21:00 INFO - PROCESS | 4387 | Values: 68.0 68.0 68.0 71.0 75.0 70.0 73.0 66.0 68.0 74.0 10:21:00 INFO - PROCESS | 4387 | -------- Summary: end -------- 10:21:00 INFO - PROCESS | 4387 | 10:21:01 INFO - TEST-INFO | 4387: exit 0 10:21:01 INFO - TEST-OK | kraken | took 60381ms 10:21:01 INFO - TEST-START | v8_7 10:21:01 INFO - operating with platform_type : linux_ 10:21:01 INFO - Initialising browser for v8_7 test... 10:21:01 INFO - TEST-INFO | started process 4673 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbngQ3U/profile http://localhost:36688/getInfo.html) 10:21:05 INFO - PROCESS | 4673 | 10:21:05 INFO - PROCESS | 4673 | (process:4745): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:21:05 INFO - PROCESS | 4673 | __metrics Screen width/height:1600/1200 10:21:05 INFO - PROCESS | 4673 | colorDepth:24 10:21:05 INFO - PROCESS | 4673 | Browser inner width/height: 1024/697 10:21:05 INFO - PROCESS | 4673 | __metrics 10:21:06 INFO - PROCESS | 4673 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:21:07 INFO - TEST-INFO | 4673: exit 0 10:21:07 INFO - Browser initialized. 10:21:07 INFO - Running cycle 1/1 for v8_7 test... 10:21:07 INFO - TEST-INFO | started process 4794 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbngQ3U/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:08 INFO - PROCESS | 4794 | 10:21:08 INFO - PROCESS | 4794 | (process:4850): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:21:18 INFO - PROCESS | 4794 | RSS: Main: 150683648 10:21:18 INFO - PROCESS | 4794 | 10:21:41 INFO - PROCESS | 4794 | Cycle 1(1): loaded http://localhost:36688/tests/v8_7/run.html (next: http://localhost:36688/tests/v8_7/run.html) 10:21:41 INFO - PROCESS | 4794 | RSS: Main: 146169856 10:21:41 INFO - PROCESS | 4794 | 10:21:41 INFO - PROCESS | 4794 | __start_tp_report 10:21:41 INFO - PROCESS | 4794 | _x_x_mozilla_page_load 10:21:41 INFO - PROCESS | 4794 | _x_x_mozilla_page_load_details 10:21:41 INFO - PROCESS | 4794 | |i|pagename|runs| 10:21:41 INFO - PROCESS | 4794 | |0;Richards;166.8335001668335 10:21:41 INFO - PROCESS | 4794 | |1;DeltaBlue;188.67924528301887 10:21:41 INFO - PROCESS | 4794 | |2;Encrypt;280.19052956010086 10:21:41 INFO - PROCESS | 4794 | |3;Decrypt;5208.333333333333 10:21:41 INFO - PROCESS | 4794 | |4;RayTrace;1050.420168067227 10:21:41 INFO - PROCESS | 4794 | |5;Earley;748.502994011976 10:21:41 INFO - PROCESS | 4794 | |6;Boyer;12353.658536585366 10:21:41 INFO - PROCESS | 4794 | |7;RegExp;41918.36734693877 10:21:41 INFO - PROCESS | 4794 | |8;Splay;578.7037037037037 10:21:41 INFO - PROCESS | 4794 | |9;NavierStokes;4830.917874396136 10:21:41 INFO - PROCESS | 4794 | __end_tp_report 10:21:41 INFO - PROCESS | 4794 | __startTimestamp1452882101573__endTimestamp 10:21:41 INFO - PROCESS | 4794 | 10:21:41 INFO - PROCESS | 4794 | ------- Summary: start ------- 10:21:41 INFO - PROCESS | 4794 | Number of tests: 10 10:21:41 INFO - PROCESS | 4794 | 10:21:41 INFO - PROCESS | 4794 | [#0] Richards Cycles:1 Average:166.83 Median:166.83 stddev:0.00 (0.0%) 10:21:41 INFO - PROCESS | 4794 | Values: 166.8 10:21:41 INFO - PROCESS | 4794 | 10:21:41 INFO - PROCESS | 4794 | [#1] DeltaBlue Cycles:1 Average:188.68 Median:188.68 stddev:0.00 (0.0%) 10:21:41 INFO - PROCESS | 4794 | Values: 188.7 10:21:41 INFO - PROCESS | 4794 | 10:21:41 INFO - PROCESS | 4794 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 10:21:41 INFO - PROCESS | 4794 | Values: 280.2 10:21:41 INFO - PROCESS | 4794 | 10:21:41 INFO - PROCESS | 4794 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 10:21:41 INFO - PROCESS | 4794 | Values: 5208.3 10:21:41 INFO - PROCESS | 4794 | 10:21:41 INFO - PROCESS | 4794 | [#4] RayTrace Cycles:1 Average:1050.42 Median:1050.42 stddev:0.00 (0.0%) 10:21:41 INFO - PROCESS | 4794 | Values: 1050.4 10:21:41 INFO - PROCESS | 4794 | 10:21:41 INFO - PROCESS | 4794 | [#5] Earley Cycles:1 Average:748.50 Median:748.50 stddev:0.00 (0.0%) 10:21:41 INFO - PROCESS | 4794 | Values: 748.5 10:21:41 INFO - PROCESS | 4794 | 10:21:41 INFO - PROCESS | 4794 | [#6] Boyer Cycles:1 Average:12353.66 Median:12353.66 stddev:0.00 (0.0%) 10:21:41 INFO - PROCESS | 4794 | Values: 12353.7 10:21:41 INFO - PROCESS | 4794 | 10:21:41 INFO - PROCESS | 4794 | [#7] RegExp Cycles:1 Average:41918.37 Median:41918.37 stddev:0.00 (0.0%) 10:21:41 INFO - PROCESS | 4794 | Values: 41918.4 10:21:41 INFO - PROCESS | 4794 | 10:21:41 INFO - PROCESS | 4794 | [#8] Splay Cycles:1 Average:578.70 Median:578.70 stddev:0.00 (0.0%) 10:21:41 INFO - PROCESS | 4794 | Values: 578.7 10:21:41 INFO - PROCESS | 4794 | 10:21:41 INFO - PROCESS | 4794 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:21:41 INFO - PROCESS | 4794 | Values: 4830.9 10:21:41 INFO - PROCESS | 4794 | -------- Summary: end -------- 10:21:41 INFO - PROCESS | 4794 | 10:21:42 INFO - TEST-INFO | 4794: exit 0 10:21:42 INFO - TEST-OK | v8_7 | took 41193ms 10:21:42 INFO - SUITE-END | took 1212s 10:21:42 INFO - Completed test suite (00:20:12) 10:21:42 INFO - Working with test: dromaeo_css 10:21:42 INFO - Generating results file: dromaeo_css 10:21:42 INFO - Working with test: kraken 10:21:42 INFO - Generating results file: kraken 10:21:42 INFO - javascript benchmark 10:21:42 INFO - Working with test: v8_7 10:21:42 INFO - Generating results file: v8_7 10:21:42 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 10:21:42 INFO - process_Request line: dromaeo_css 6892.56 graph.html#tests=[[72,63,43]] 10:21:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:42 INFO - process_Request line: kraken 1520.60 graph.html#tests=[[232,63,43]] 10:21:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:42 INFO - process_Request line: v8_7 20336.96 graph.html#tests=[[230,63,43]] 10:21:42 INFO - RETURN: dromaeo_css: 6892.56 10:21:42 INFO - RETURN: kraken: 1520.60 10:21:42 INFO - RETURN: v8_7: 20336.96 10:21:42 INFO - javascript benchmark 10:21:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3210.7110360067572, 3214.324991751732, 3230.9030729078136, 3234.5309930060134, 3258.9022329330114, 5223.503767142125, 5293.602979776513, 5328.653637513559, 5329.387120481146, 5362.544183744381, 5246.37043554773, 5360.088784906566, 5375.865603359918, 5423.83728488145, 5479.986202552521, 4849.102915960541, 4903.9754801225945, 4950.405951285851, 4986.4514903360605, 4991.800327986876, 4945.901081978376, 4953.975230123844, 4973.229149481818, 4999.75001249936, 5009.499050094998, 4813.6389770767155, 4850.320955066293, 4869.853904382892, 4896.559309662111, 4930.531599498042, 4837.685550439211, 4860.149473842063, 4868.756562171912, 4877.780499877514, 4904.362432883738, 4850.490698476645, 4857.101436234273, 4872.488388719169, 4884.560389564921, 4888.266759985995, 5122.92315615266, 5123.462036486189, 5149.433562308143, 5243.947560524384, 5271.182966640177, 5795.1017592273265, 5806.767729290866, 5811.012127938261, 5813.593048486608, 5816.302043754734, 5631.549476041907, 5831.562632802515, 5853.2976042875125, 5854.677992710399, 5863.179154918314, 5269.815556455505, 5350.3312085989255, 5379.085555455582, 5416.079266524661, 5437.537809286216, 5901.940980590225, 5904.911426328608, 5915.881682366415, 5922.2597175353085, 5927.525797936155, 5596.244506991586, 5682.062459694104, 5709.571782116358, 5735.569832262514, 5758.021136406821, 5744.741486633112, 5779.797707080232, 5780.53755699543, 5782.653040817564, 5824.126381042793, 5684.744186511617, 5733.770649173986, 5768.077107662753, 5785.305763308345, 5811.622244554175, 5629.380768115504, 5718.228039214653, 5724.341700704389, 5759.280089988752, 5780.219670344533, 4439.689221754511, 4443.622292105143, 4455.064436468313, 4481.5070342262325, 4491.416115904912, 3975.5030621172355, 3982.7012974027066, 4000.2799496090984, 4016.377461493473, 4020.43713880057, 5224.634275600747, 5286.0, 5395.325584301962, 5441.646292990943, 5515.062439385314, 5755.194272801811, 5760.251167348218, 5760.74076666551, 5778.8266352009505, 5792.478676919013, 5363.892722145613, 5417.901246843092, 5422.945770542323, 5425.755840987165, 5426.213199086189, 4811.855644330676, 4845.830395936196, 4905.435874874363, 4978.6763860348965, 5005.124103281911, 6038.607490513103, 6040.395960403925, 6053.636781793107, 6053.8486537836025, 6069.757209711651, 5813.709314534341, 5824.9417505826095, 5832.533397328289, 5838.503727183237, 5846.678432686073, 5845.678487683218, 5877.353491115889, 6017.428344307284, 6035.879282414415, 6117.724702388314, 5694.629849059798, 5714.5999780015, 5737.885242295214, 5745.396733342939, 5747.885042299215, 5704.087346024616, 5814.592978491465, 5847.8245652630485, 5852.619579727304, 5865.237519122486, 5561.749721262472, 5635.323761148525, 5639.88720225585, 5660.490555849993, 5750.568707347049, 5602.719864006865, 5608.10270356741, 5632.0, 5643.322801263875, 5676.829695109153, 5412.594055445936, 5492.231087647652, 5529.0, 5532.419095994863, 5553.333599968029, 5638.802641907513, 5676.403977582295, 5685.914711279417, 5703.942960570507, 5720.313562372542, 5538.778448862, 5561.833145005657, 5594.1608758686525, 5616.971915140562, 5627.8593035174445], "unit": "score", "name": "dojo.html", "value": 5320.774692380065}, {"lowerIsBetter": false, "replicates": [515.2554558662733, 522.2218893848164, 535.4966331648251, 560.8541779137424, 570.4723131103729, 28000.0, 36142.0, 36333.0, 36467.81766091172, 36585.0, 39138.21723565527, 39465.605343946554, 39588.406173907344, 39694.80152599233, 39762.0, 8448.0, 8577.742667719978, 8637.438566493189, 8660.480371177719, 8689.131086891324, 8329.125441828612, 8477.237048665618, 8481.66073357065, 8485.66057357705, 8485.830283394329, 8484.194001569871, 8509.106543812872, 8558.572071396406, 8560.48637081774, 8566.657333706644, 8379.58102094896, 8453.196946290092, 8523.74428767138, 8617.09520500351, 8678.479291242546, 8578.871316930252, 8635.784105397352, 8661.393702440831, 8695.087015863306, 8695.347848911357, 38554.0, 39052.21895562073, 39070.41394379087, 39126.41310380347, 39165.41251881196, 3152.4640811062172, 3194.4569423198113, 3290.07877794218, 3331.6501767314567, 3519.8592056317716, 28848.27879303013, 28943.56584651232, 29175.854120729262, 29279.2680182995, 29538.852305738335, 3755.455458958463, 3775.886723398275, 3808.5048943637426, 3830.7510011849417, 3910.1397692507885, 265461.0, 265798.0, 267826.0, 268572.657136715, 269018.0, 52200.738996304775, 53050.0, 56001.0, 56253.43746562564, 56365.71817140888, 62116.0, 63364.0, 63368.683156583924, 63414.36585634177, 63592.0, 15899.602509937113, 15977.920110399373, 16010.839891601168, 16069.839301607068, 16173.919130404272, 11531.13516486267, 11586.47860846264, 11595.942020289845, 11614.709632259091, 11640.592579259855, 18630.44108676742, 18640.254389824255, 18800.529986750167, 19424.8057519423, 19522.219111235674, 7757.534547927143, 7769.844603108019, 7939.245771651684, 7958.363330933512, 8030.0, 918.4397517514311, 941.0730430525927, 1004.9397036177853, 1103.6799328194895, 1148.655403378983, 27863.721362786113, 29625.25936851596, 30262.394752104836, 30968.84515577453, 31369.215769605944, 1008.8561806161906, 1034.0590063042596, 1062.8671416072991, 1075.3601607043797, 1090.1714696830466, 13244.205347678977, 13301.135426197266, 13350.732985340239, 13376.264305463294, 13378.264195469343, 317664.0, 319078.0, 322835.0, 324292.0, 325080.0, 48953.755231223615, 49038.26442603364, 49403.752981234866, 49427.752861235465, 49739.25391119136, 1323.953661621858, 1347.3802051056623, 1347.4946894914408, 1353.8713822186876, 1366.7129902720342, 25087.498250034532, 26329.473410532064, 26497.33756656099, 26628.467430651664, 26668.0, 48183.75908120437, 48772.2684159745, 49221.507784923124, 49247.0, 49249.75375123245, 233366.0, 236107.0, 237463.0634234158, 237824.0, 238117.0, 30749.92500749907, 31309.43452827304, 31386.68613313929, 31407.0, 31769.8411507941, 38171.0, 39927.600723992386, 40706.59293407028, 41439.0, 41566.376504353066, 34300.48549271713, 34464.31071378508, 34812.82593587016, 35322.29355412826, 35324.0, 35508.64491355053, 38543.0, 38692.80653596714, 39313.41029884611, 40317.0, 33692.663073369935, 33832.66167338295, 34172.82913585416, 34179.14552136217, 34215.144621384665, 30349.0, 31948.20129496781, 32163.839180803945, 32594.348113038082, 32692.0, 24197.879010604833, 24209.636855447534, 24623.13819016326, 25046.123385681414, 25194.496110078064], "unit": "score", "name": "ext.html", "value": 18017.872260629607}, {"lowerIsBetter": false, "replicates": [368.14503525162377, 370.9387950988087, 371.23525537392953, 373.18645353130177, 375.6056141051895, 15261.23693815309, 16396.83603163968, 16917.661646767057, 17139.228734706936, 17736.201870915807, 10804.459777011138, 11233.943830280858, 16247.593810154753, 16383.344666213367, 16383.83616163838, 4871.9025619487675, 5483.917741233885, 5496.80761173359, 5499.50504454599, 5527.889442211153, 4510.302848874929, 5449.591280653947, 5495.587830912677, 5497.8075767348155, 5519.69641669708, 4968.080905032581, 5141.203113517392, 5187.351581052369, 5415.241866138744, 5426.104692725696, 5049.444561098277, 5074.771635276403, 5105.081085404626, 5105.668131571436, 5546.278983732089, 5366.06093933564, 5371.167469042305, 5372.462753724635, 5373.81191658294, 5374.838754837361, 13275.86724132756, 19090.809091909043, 19843.90078049615, 19881.701774473393, 19993.500162495908, 1869.8597605179666, 1965.685490321556, 1979.8835887995117, 2047.406252186864, 2183.2795177591356, 9651.565679544437, 10609.310394824312, 11132.610358637408, 12824.935875320656, 12853.0, 1795.8473529749988, 1831.7618709567805, 1852.2128095559333, 1858.869879108463, 1862.8044055374262, 56197.71901140468, 57350.0, 57814.71092644552, 57839.71080144614, 59680.0, 10079.193664506822, 10142.087212150942, 10210.948945255226, 10283.588656453658, 10346.120579750655, 13435.932820335836, 13458.730825383438, 13520.661983450493, 13526.18842869431, 13598.32008399576, 7258.564486130744, 7340.192578816326, 7598.924010759933, 7656.119546252252, 7657.157712651604, 7204.56772593646, 7228.31331023552, 7239.746608868664, 7272.018277532571, 7389.113306403158, 4396.648268138541, 4428.402165707653, 4432.645388368923, 4440.578145076212, 4446.666500012448, 1813.6010077782867, 1830.350225669868, 1836.977020325483, 1871.2327945542263, 1904.495308743184, 854.3421565394611, 885.3227281129941, 913.6162811619135, 1025.8461230815437, 1073.1093192650083, 15388.307526161127, 15643.452479163174, 15911.920440397724, 16521.91739041297, 17026.148692565323, 798.0503201190564, 885.300612516105, 924.6255266617031, 956.5408603870181, 967.5694316029441, 5791.710414479259, 5880.529867533117, 6103.84740381494, 6111.877762444727, 6175.135481032659, 555156.0, 555603.0, 558912.0, 568674.0, 580167.0, 72445.0, 72680.0, 72761.0, 72997.6350118246, 77572.61213694008, 451.71767645221735, 461.04793601213385, 463.05536705121847, 464.7420681521788, 465.0907475884637, 10446.112080473245, 10555.577776888838, 10752.354858708502, 14177.645558860699, 14949.476768313058, 30690.539641905834, 31715.524267136472, 32466.513002304513, 33173.668263318024, 33233.169170770925, 37460.0, 37526.2494750098, 38002.61997380101, 41186.79406603068, 43753.34369984389, 6533.0, 6936.132983377078, 6986.860262794818, 7274.599897005715, 7393.778186654409, 9699.951500242454, 10676.519556619816, 10709.250352475563, 10831.620893268699, 11059.336439813314, 6789.592624442549, 7159.606221657858, 7220.375415531464, 7461.701531938662, 7656.119546252252, 7123.257545844991, 7214.71141154348, 7454.739084132029, 7619.65711542993, 7755.961220193863, 7511.51175173612, 7859.4891332063235, 7908.52548847071, 7973.401994850294, 8010.319122874621, 10136.290459668047, 10331.225158113322, 10438.164946804389, 10447.94776026115, 10506.36961782265, 10298.330608510423, 10444.2166837489, 10449.68650940473, 10499.107575856138, 10631.521581528696], "unit": "score", "name": "jquery.html", "value": 7711.47700227984}, {"lowerIsBetter": false, "replicates": [1510.9093454392735, 1530.502586659336, 1719.3810228317802, 1821.899795511248, 1851.324266642674, 7914.24814642608, 8085.555294458803, 8104.068032176301, 8170.591470426484, 8210.507369557823, 8184.836303273931, 8223.177682231788, 8260.380471464634, 8265.0, 8273.875891861611, 2351.600227961242, 2388.8566685998894, 2392.0670938334065, 2393.4614711689906, 2398.4843258699375, 2409.217004473553, 2420.818438617102, 2438.036975394718, 2439.865807380593, 2451.8038556915494, 2330.1378489958656, 2374.845635033726, 2381.9642705359433, 2394.425337918896, 2402.1712509184304, 2367.490989437262, 2379.048380647746, 2385.7137143542714, 2394.820388470872, 2396.7363590005084, 2409.361519197414, 2420.165043060141, 2420.673209116764, 2422.2733180045916, 2426.065964603623, 8040.477368971056, 8067.354611631055, 8075.596220189026, 8076.071251806059, 8113.066997295268, 4873.853784386474, 5030.170021946375, 5033.345665063555, 5040.672356296829, 5055.039542486916, 3182.5067114597273, 3196.744260459158, 3234.3692979868933, 3241.675832416763, 3248.5127230915314, 971.2715463402449, 972.547765289144, 972.7033254857266, 1012.86832711747, 1031.752379428939, 11515.654530364103, 11589.36258505782, 11617.18679692422, 11617.18679692422, 11620.128490363257, 4352.630026447724, 4444.355568442623, 4513.097380523908, 4519.54804519552, 4525.411696479437, 9218.124278193562, 9230.86153707695, 9306.115918987685, 9307.395019323721, 9351.345405821663, 4890.779914903838, 4920.72935988524, 4944.035912996931, 4965.503449655078, 4995.525425084611, 4480.103979204172, 4504.324351347324, 4526.547345265447, 4528.071745292207, 4540.500544940054, 3655.323765103464, 3729.160938788805, 3737.663610275034, 3753.1930634913624, 3759.661630453272, 1151.2689442204094, 1161.349644199251, 1163.9359835208975, 1181.9940900295614, 1206.4510647655295, 1010.8584798128268, 1034.6689059501039, 1035.49260862177, 1163.2380790582183, 1287.9871201288054, 7180.5691658500655, 7222.566646001257, 7286.162091359455, 7291.161516425679, 7330.120385553768, 1081.1296905990753, 1087.635642059903, 1091.4651820608003, 1095.5179720922768, 1110.5169251375678, 5407.215953686772, 5483.259759932438, 5496.367917689517, 5502.477264659851, 5539.362973258127, 9483.90516094844, 9722.569357660585, 9741.123298903132, 9795.804083918281, 9940.900590993997, 9526.90473095274, 9627.229821614254, 9632.373895696757, 9718.930917599058, 9722.854157187649, 7528.247175282538, 7571.053618297603, 7577.431692622965, 7608.972788673458, 7709.267619576131, 7510.8497830042, 7527.774166775005, 7541.396688264816, 7554.244575542401, 7613.809654758676, 8672.089430609694, 8812.603432845666, 8981.595828187877, 9144.222741067084, 9195.310351723514, 9086.45481271126, 9171.587278572613, 9211.815763684555, 9224.215941644767, 9279.72160835176, 7363.595002274712, 7498.32515073646, 7499.700011999459, 7502.287282708134, 7521.887171692539, 7599.924000760143, 7636.389088872766, 7667.3099421052375, 7673.0, 7694.269044440769, 6926.9307306926285, 7485.925140748523, 7519.812004699927, 7579.54522728638, 7675.808104797201, 6818.62439146174, 6961.199462061928, 6986.371226589631, 7075.540089894141, 7090.220075791762, 6872.209695885037, 6916.066331045245, 6945.861082778417, 6972.860542789014, 6986.685599147949, 6156.415140561639, 6221.253449586078, 6221.3156552778255, 6222.875542489034, 6245.406686364788, 6266.467350275278, 6354.3963323484195, 6472.546921715623, 6477.643729594917, 6517.576357536745], "unit": "score", "name": "mootools.html", "value": 4636.134542040996}, {"lowerIsBetter": false, "replicates": [342.7771948233649, 343.4761987968348, 354.19420817639883, 355.28587539046526, 357.32465639940517, 6198.690065496729, 6250.406211409914, 6341.112244285798, 6376.0, 6387.776427825027, 6081.878362432749, 6241.875162496747, 6265.436110750032, 6281.089242059898, 6282.685865706708, 4767.761611919407, 4801.759912004403, 4803.423589169304, 4810.134175848346, 4820.156472617296, 4799.400074990626, 4808.062427826575, 4812.278158276269, 4817.4219093708625, 4825.493323201066, 4715.12770137524, 4813.253945638432, 4813.614910807127, 4820.25286080658, 4821.349117869096, 4727.290906364038, 4730.030343779517, 4763.618910487153, 4769.18923782956, 4784.784684689214, 4223.092035212444, 4223.619874211305, 4238.660907127453, 4251.787410629487, 4252.277112890816, 5981.282246130449, 5986.790462333841, 5987.742574059453, 6002.159697642333, 6006.609570377911, 5441.319835020622, 5541.0, 5544.6118771686, 5561.776409189972, 5568.52667523261, 6607.405333519958, 6619.073329733841, 6626.635535045571, 6628.966855165741, 6631.93368066318, 4565.383673204108, 4601.723896566216, 4606.147862645421, 4618.722876627413, 4619.030003699228, 6753.0, 6895.55178913369, 6909.067275917737, 6966.79099627012, 6994.685239164199, 4640.814367425332, 4642.675012749075, 4654.627629789608, 4664.533546645308, 4693.272542755878, 4733.9763301183275, 4738.976305118453, 4750.429948406213, 4754.976225118852, 4759.50025247344, 5533.889322213533, 5536.723163841792, 5546.584006199551, 5552.416996215339, 5571.1086226203615, 6574.704138313788, 6674.399304062561, 6726.226483954408, 6738.561993470409, 6739.292374300726, 1653.1321056445222, 1654.0571874031687, 1700.039477695123, 1701.1494252873563, 1704.0457343887463, 1130.5534313945946, 1138.0099313597223, 1139.601139601133, 1150.2810743285447, 1150.8331291962618, 6294.339094395114, 6319.526035547352, 6319.715612797435, 6325.620462772248, 6340.3342649022115, 6812.080369150101, 6856.142982127234, 6859.0, 6860.108185935796, 6877.828054298682, 6249.25008998923, 6306.337834527309, 6312.0531920211415, 6314.526410519229, 6316.747330106744, 3761.2101458693433, 3798.088458769875, 3798.1264309209037, 3800.809959502014, 3805.334066538345, 7341.559506429631, 7346.889796653055, 7354.889676654854, 7355.264473552709, 7366.337029667248, 7005.0, 7188.317109874553, 7218.422526197892, 7251.891221631679, 7254.709811607582, 7260.273972602803, 7278.417726581861, 7280.199178090405, 7284.927150728425, 7294.197638259787, 6977.79066628002, 6982.197047339621, 6984.126984126984, 6986.441084713312, 6994.650267486503, 6689.899651505329, 6915.481338899704, 6923.238443771081, 6929.0, 6939.479539034492, 7231.2768723127265, 7275.745348912763, 7312.488125831141, 7324.523905946096, 7334.193238743841, 4732.976335118303, 4733.810647574196, 4757.881052973703, 4758.976205118952, 4764.071006153767, 6837.3162683731225, 6848.075509806312, 6979.232284448808, 7042.366187043191, 7051.894221586577, 6730.663466826737, 6757.425618822259, 6763.458923286224, 6799.150106236721, 6836.350546698056, 6793.966030169818, 6816.931830681629, 6817.5909445433435, 6825.385715285648, 6840.589564626139, 6559.967200164159, 6696.732130714717, 6714.127163468718, 6721.966390168018, 6724.630145341857, 6776.254611992578, 6810.557313774589, 6843.0, 6843.076184715199, 6865.794026179223, 6680.164979377578, 6692.029655699994, 6692.631905245258, 6697.0, 6704.195496540447], "unit": "score", "name": "prototype.html", "value": 5058.293123349005}, {"lowerIsBetter": false, "replicates": [654.2312782480584, 666.167290886392, 787.8109253779095, 803.1286054630727, 833.6030674999378, 13367.398467068968, 13412.128211666235, 13432.194068355893, 13498.527551535673, 13521.864781352184, 12551.995840332775, 12615.0, 12672.746545069092, 12698.111132220749, 12704.237745735263, 653.6698967021659, 665.3911670821217, 799.3445374792673, 812.5246730662569, 813.4346629092782, 779.6101949025488, 782.7221336425572, 792.5244853088159, 793.6904607203195, 794.5629903553023, 830.754927296446, 835.2357592802579, 837.5644664774313, 842.5029232752674, 844.1769274956898, 829.1128492513013, 831.3847752663016, 832.6003518311245, 833.0544831616129, 839.08539691736, 619.6777675608703, 620.8665136995522, 622.9034499652561, 623.8845813524467, 624.8250489862845, 13058.738825223443, 13157.144785588906, 13163.0, 13205.405756740874, 13293.86706132936, 12628.873711262953, 12645.936770316182, 12910.354482275849, 13241.470341186341, 13358.666033349147, 10359.533820978075, 10385.221108416823, 10526.631567895163, 10638.946805266001, 10939.781204375868, 4141.937870931938, 4250.957490425087, 4256.063665993507, 4361.018770776582, 4363.825446982117, 46112.0, 46146.76926615379, 46230.53769462296, 46543.0, 48126.03747925022, 9245.815083698288, 9632.807343853225, 10021.498925053718, 10242.129418999319, 10295.639652612123, 17311.489833974003, 17393.217305221042, 17408.912955435142, 17458.912705436647, 17662.823371766375, 7676.654550545239, 7677.0403699537555, 7735.0, 7735.497192682457, 7744.883826742604, 4215.915681686349, 4477.731336119843, 4551.726896386227, 4570.3829982951875, 4580.290055041474, 2958.644962604458, 2982.3737015227043, 3026.7124623160767, 3027.6518200406795, 3039.0730827097946, 581.1921429213397, 588.785093440891, 599.5832896137143, 600.0279547133672, 601.2514419547691, 579.5421616922584, 579.8898209340211, 594.8602078511547, 623.4420193926501, 664.9442010048231, 7784.844303113906, 7945.364370850433, 8250.917490825135, 9271.165595096474, 9665.178459830993, 556.6993823335354, 571.44855214718, 592.1591340296789, 603.6316857156976, 674.8043067510465, 3876.917850309011, 4029.6171863672903, 4064.6138616831354, 4097.262492751273, 4175.54069052404, 55408.72295638577, 55732.72133639306, 55975.720121399136, 56185.71907140438, 56609.71695141498, 50240.49759502431, 51441.22838157356, 51681.483185167664, 52104.73947630238, 52123.0, 44945.0, 45135.774321128185, 45281.0, 45285.54714452814, 45541.31688024682, 6873.20958089806, 7821.687132514636, 7827.139014708491, 7919.564423956507, 8050.074241462306, 32379.51430728588, 33046.83476582602, 33576.0, 33640.3271934555, 33756.0, 40969.59030409658, 44288.33567496554, 44772.55227447814, 45009.42467013639, 45147.0, 9433.198178154933, 9784.412935223909, 10647.414392208502, 10687.061058209054, 11174.608888689181, 11457.885421146015, 11632.011279041377, 11680.649580512598, 11813.645590632295, 11988.100892433276, 10633.149348052291, 10755.0, 10981.341119532854, 11375.31748095117, 11634.12744044217, 11127.276727012719, 11323.660290191307, 11478.88521114778, 11526.942365288456, 12093.697657558632, 11109.94445027802, 11387.430628468377, 11551.249168804, 11616.12879034059, 11766.82349764737, 8164.428490005643, 8237.752867413987, 8437.426584891668, 8495.108013658724, 8496.70261540843, 8461.661533538589, 8616.870746938926, 8690.78273043179, 8853.07042760501, 9034.593443294936], "unit": "score", "name": "yui.html", "value": 6184.058712404758}], "name": "dromaeo_css", "value": 6892.559942283644}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 112.0, 111.0, 112.0, 123.0, 110.0, 114.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [154.0, 134.0, 153.0, 166.0, 128.0, 157.0, 157.0, 134.0, 164.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 163.0, 161.0, 162.0, 161.0, 169.0, 167.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 71.0, 74.0, 75.0, 74.0, 72.0, 142.0, 71.0, 82.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 148.0, 97.0, 96.0, 97.0, 152.0, 97.0, 97.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 112.8}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 109.0, 109.0, 111.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 100.0, 99.0, 96.0, 96.0, 97.0, 99.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 60.0, 58.0, 59.0, 63.0, 60.0, 59.0, 57.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 82.0, 82.0, 83.0, 84.0, 86.0, 91.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [128.0, 121.0, 121.0, 126.0, 114.0, 123.0, 120.0, 133.0, 114.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [149.0, 142.0, 151.0, 149.0, 140.0, 154.0, 153.0, 146.0, 151.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 71.0, 75.0, 70.0, 73.0, 66.0, 68.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1520.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.8335001668335], "unit": "score", "name": "Richards", "value": 211.6001880000001}, {"lowerIsBetter": false, "replicates": [188.67924528301887], "unit": "score", "name": "DeltaBlue", "value": 350.4253999999999}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1050.420168067227], "unit": "score", "name": "RayTrace", "value": 704.469528}, {"lowerIsBetter": false, "replicates": [748.502994011976], "unit": "score", "name": "Earley", "value": 890.3945680000003}, {"lowerIsBetter": false, "replicates": [12353.658536585366], "unit": "score", "name": "Boyer", "value": 53.948633761105626}, {"lowerIsBetter": false, "replicates": [41918.36734693877], "unit": "score", "name": "RegExp", "value": 21.732358812074008}, {"lowerIsBetter": false, "replicates": [578.7037037037037], "unit": "score", "name": "Splay", "value": 140.81644799999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20336.96155149847}]} 10:21:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20336.96"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1520.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6892.56"}}} 10:21:42 INFO - Return code: 0 10:21:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:21:42 INFO - # TBPL SUCCESS # 10:21:42 INFO - Running post-action listener: _resource_record_post_action 10:21:42 INFO - Running post-run listener: _resource_record_post_run 10:21:43 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 557056; Write bytes: 327999488; Read time: 380; Write time: 356040 10:21:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 18497536; Read time: 0; Write time: 2324 10:21:43 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 557056; Write bytes: 309501952; Read time: 380; Write time: 353716 10:21:43 INFO - Running post-run listener: _upload_blobber_files 10:21:43 INFO - Blob upload gear active. 10:21:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:21:43 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:21:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:21:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:21:44 INFO - (blobuploader) - INFO - Open directory for files ... 10:21:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:21:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:21:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:45 INFO - (blobuploader) - INFO - Done attempting. 10:21:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:21:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:21:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:46 INFO - (blobuploader) - INFO - Done attempting. 10:21:46 INFO - (blobuploader) - INFO - Iteration through files over. 10:21:46 INFO - Return code: 0 10:21:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:21:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:21:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df0e01264d6b7e80d0ab8caecbff22f16e716d4ca4cb19329dbb15e361f60b5dd9fa85d95d5a3695e6eb5c5d4e1915108bd7ea9f422fa517d326613c2cbde375", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d72a3f7a51dfd780d25a307c7f29eaaba6fda0144a8e282c143d86a5f50422edb2e01bf270826e6e2f9a2edec3290cb4d7834ea6d582cb3c95fefa9405cadeaf"} 10:21:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:21:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:21:46 INFO - Contents: 10:21:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df0e01264d6b7e80d0ab8caecbff22f16e716d4ca4cb19329dbb15e361f60b5dd9fa85d95d5a3695e6eb5c5d4e1915108bd7ea9f422fa517d326613c2cbde375", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d72a3f7a51dfd780d25a307c7f29eaaba6fda0144a8e282c143d86a5f50422edb2e01bf270826e6e2f9a2edec3290cb4d7834ea6d582cb3c95fefa9405cadeaf"} 10:21:46 INFO - Running post-run listener: copy_logs_to_upload_dir 10:21:46 INFO - Copying logs to upload dir... 10:21:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:21:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1292.670323 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-01-15 10:21:46.485096) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 10:21:46.489972) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df0e01264d6b7e80d0ab8caecbff22f16e716d4ca4cb19329dbb15e361f60b5dd9fa85d95d5a3695e6eb5c5d4e1915108bd7ea9f422fa517d326613c2cbde375", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d72a3f7a51dfd780d25a307c7f29eaaba6fda0144a8e282c143d86a5f50422edb2e01bf270826e6e2f9a2edec3290cb4d7834ea6d582cb3c95fefa9405cadeaf"} build_url:https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df0e01264d6b7e80d0ab8caecbff22f16e716d4ca4cb19329dbb15e361f60b5dd9fa85d95d5a3695e6eb5c5d4e1915108bd7ea9f422fa517d326613c2cbde375", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d72a3f7a51dfd780d25a307c7f29eaaba6fda0144a8e282c143d86a5f50422edb2e01bf270826e6e2f9a2edec3290cb4d7834ea6d582cb3c95fefa9405cadeaf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 10:21:46.517479) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:21:46.517832) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452880656.956351-112194833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:21:46.597246) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 10:21:46.600594) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 10:21:46.600922) ========= ========= Total master_lag: 0.25 =========