builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1452880806.98 results: success (0) buildid: 20160115073420 builduid: 863c819af0cf44ccbb0b12abe9271fce revision: 7701bd27ec28b32d99f470d599c9ef2eddc9b94c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:06.983556) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:06.984095) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:06.987001) ========= 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=0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006403 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:07.048677) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:07.049005) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:07.137604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:07.142057) ========= 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=0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009558 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:07.220600) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:07.220959) ========= 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:07.221358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:07.225706) ========= 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=0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 10:00:07-- 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% 206M=0s 2016-01-15 10:00:07 (206 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123762 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:07.423971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:07.424296) ========= 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=0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.065184 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:07.578897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:07.579206) ========= 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=0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 10:00:07,743 truncating revision to first 12 chars 2016-01-15 10:00:07,743 Setting DEBUG logging. 2016-01-15 10:00:07,743 attempt 1/10 2016-01-15 10:00:07,743 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:08,015 unpacking tar archive at: mozilla-inbound-7701bd27ec28/testing/mozharness/ program finished with exit code 0 elapsedTime=0.594452 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:08.270593) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:08.271042) ========= 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=0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004640 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:08.325145) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:08.325447) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:08.352283) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 10:00:08.352738) ========= 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:08.353217) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-01-15 10:00:08.353507) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:00:08 INFO - MultiFileLogger online at 20160115 10:00:08 in /builds/slave/test-pgo 10:00:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:08 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:00:08 INFO - {'append_to_log': False, 10:00:08 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:00:08 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:00:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:00:08 INFO - 'branch': 'Mozilla-Inbound', 10:00:08 INFO - 'buildbot_json_path': 'buildprops.json', 10:00:08 INFO - 'config_files': ('talos/linux_config.py',), 10:00:08 INFO - 'default_actions': ('clobber', 10:00:08 INFO - 'read-buildbot-config', 10:00:08 INFO - 'download-and-extract', 10:00:08 INFO - 'populate-webroot', 10:00:08 INFO - 'create-virtualenv', 10:00:08 INFO - 'install', 10:00:08 INFO - 'run-tests'), 10:00:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:00:08 INFO - 'download_minidump_stackwalk': True, 10:00:08 INFO - 'download_symbols': 'ondemand', 10:00:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:00:08 INFO - 'tooltool.py': '/tools/tooltool.py', 10:00:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:00:08 INFO - '/tools/misc-python/virtualenv.py')}, 10:00:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:00:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:00:08 INFO - 'installer_path': 'installer.exe', 10:00:08 INFO - 'log_level': 'info', 10:00:08 INFO - 'log_name': 'talos', 10:00:08 INFO - 'log_to_console': True, 10:00:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:00:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:00:08 INFO - 'opt_config_files': (), 10:00:08 INFO - 'pip_index': False, 10:00:08 INFO - 'sps_profile': False, 10:00:08 INFO - 'sps_profile_interval': 0, 10:00:08 INFO - 'suite': 'dromaeojs', 10:00:08 INFO - 'system_bits': '32', 10:00:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:00:08 INFO - 'title': 'talos-linux64-ix-029', 10:00:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:00:08 INFO - 'use_talos_json': True, 10:00:08 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:00:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:00:08 INFO - 'work_dir': 'build'} 10:00:08 INFO - ##### 10:00:08 INFO - ##### Running clobber step. 10:00:08 INFO - ##### 10:00:08 INFO - Running pre-action listener: _resource_record_pre_action 10:00:08 INFO - Running main action method: clobber 10:00:08 INFO - rmtree: /builds/slave/test-pgo/build 10:00:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:00:12 INFO - Running post-action listener: _resource_record_post_action 10:00:12 INFO - ##### 10:00:12 INFO - ##### Running read-buildbot-config step. 10:00:12 INFO - ##### 10:00:12 INFO - Running pre-action listener: _resource_record_pre_action 10:00:12 INFO - Running main action method: read_buildbot_config 10:00:12 INFO - Using buildbot properties: 10:00:12 INFO - { 10:00:12 INFO - "project": "", 10:00:12 INFO - "product": "firefox", 10:00:12 INFO - "script_repo_revision": "production", 10:00:12 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:00:12 INFO - "repository": "", 10:00:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:00:12 INFO - "buildid": "20160115073420", 10:00:12 INFO - "pgo_build": "True", 10:00:12 INFO - "basedir": "/builds/slave/test-pgo", 10:00:12 INFO - "buildnumber": 610, 10:00:12 INFO - "slavename": "talos-linux64-ix-029", 10:00:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:00:12 INFO - "platform": "ubuntu64_hw", 10:00:12 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:00:12 INFO - "branch": "mozilla-inbound", 10:00:12 INFO - "repo_path": "integration/mozilla-inbound", 10:00:12 INFO - "revision": "7701bd27ec28b32d99f470d599c9ef2eddc9b94c", 10:00:12 INFO - "stage_platform": "linux64-pgo", 10:00:12 INFO - "builduid": "863c819af0cf44ccbb0b12abe9271fce", 10:00:12 INFO - "slavebuilddir": "test" 10:00:12 INFO - } 10:00:12 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:12 INFO - Running post-action listener: _resource_record_post_action 10:00:12 INFO - ##### 10:00:12 INFO - ##### Running download-and-extract step. 10:00:12 INFO - ##### 10:00:12 INFO - Running pre-action listener: _resource_record_pre_action 10:00:12 INFO - Running main action method: download_and_extract 10:00:12 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:12 INFO - https://queue.taskcluster.net/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:00:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/test_packages.json 10:00:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjpH9Jp3SeSmJczKDhYfrw/artifacts/public/build/test_packages.json 10:00:12 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:12 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:14 INFO - Downloaded 1448 bytes. 10:00:14 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:00:14 INFO - Using the following test package requirements: 10:00:14 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:14 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:00:14 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:00:14 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:14 INFO - u'jsshell-linux-x86_64.zip'], 10:00:14 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:00:14 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:14 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:00:14 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:00:14 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:00:14 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:14 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:00:14 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:14 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:14 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:14 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:14 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:14 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:17 INFO - Downloaded 22475717 bytes. 10:00:17 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:17 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:18 INFO - Return code: 0 10:00:18 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: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:27 INFO - Downloaded 22475717 bytes. 10:00:27 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:27 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 - 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.talos.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.talos.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.talos.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.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.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.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:37 INFO - Downloaded 11132144 bytes. 10:00:37 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:37 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:37 INFO - Return code: 0 10:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:37 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:37 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:37 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:37 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:37 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:48 INFO - Downloaded 55924326 bytes. 10:00:48 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:48 INFO - mkdir: /builds/slave/test-pgo/properties 10:00:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:00:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:00:48 INFO - Contents: 10:00:48 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:48 INFO - Running post-action listener: _resource_record_post_action 10:00:48 INFO - Running post-action listener: set_extra_try_arguments 10:00:48 INFO - ##### 10:00:48 INFO - ##### Running populate-webroot step. 10:00:48 INFO - ##### 10:00:48 INFO - Running pre-action listener: _resource_record_pre_action 10:00:48 INFO - Running main action method: populate_webroot 10:00:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:00:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:00:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:00:48 INFO - '--tppagecycles', 10:00:48 INFO - '7'], 10:00:48 INFO - 'tests': ['tsvgm']}}, 10:00:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:00:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:00:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:00:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:00:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:00:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:00:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:48 INFO - 'talos_options': ['--e10s'], 10:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:48 INFO - 'tests': ['damp', 'tps']}, 10:00:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:48 INFO - 'talos_options': ['--e10s'], 10:00:48 INFO - 'tests': ['damp', 'tps']}, 10:00:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:00:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:00:48 INFO - 'other': {'tests': ['a11yr', 10:00:48 INFO - 'ts_paint', 10:00:48 INFO - 'tpaint', 10:00:48 INFO - 'sessionrestore', 10:00:48 INFO - 'sessionrestore_no_auto_restore']}, 10:00:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:00:48 INFO - 'tests': ['a11yr', 10:00:48 INFO - 'ts_paint', 10:00:48 INFO - 'tpaint', 10:00:48 INFO - 'sessionrestore', 10:00:48 INFO - 'sessionrestore_no_auto_restore']}, 10:00:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:00:48 INFO - 'tests': ['a11yr', 10:00:48 INFO - 'ts_paint', 10:00:48 INFO - 'tpaint', 10:00:48 INFO - 'sessionrestore', 10:00:48 INFO - 'sessionrestore_no_auto_restore']}, 10:00:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:00:48 INFO - 'tests': ['a11yr', 10:00:48 INFO - 'ts_paint', 10:00:48 INFO - 'tpaint', 10:00:48 INFO - 'sessionrestore', 10:00:48 INFO - 'sessionrestore_no_auto_restore']}, 10:00:48 INFO - 'other_l64': {'tests': ['a11yr', 10:00:48 INFO - 'ts_paint', 10:00:48 INFO - 'tpaint', 10:00:48 INFO - 'sessionrestore', 10:00:48 INFO - 'sessionrestore_no_auto_restore']}, 10:00:48 INFO - 'other_nol64': {'tests': ['a11yr', 10:00:48 INFO - 'ts_paint', 10:00:48 INFO - 'tpaint', 10:00:48 INFO - 'sessionrestore', 10:00:48 INFO - 'sessionrestore_no_auto_restore']}, 10:00:48 INFO - 'svgr': {'tests': ['tsvgx', 10:00:48 INFO - 'tsvgr_opacity', 10:00:48 INFO - 'tart', 10:00:48 INFO - 'tscrollx', 10:00:48 INFO - 'cart']}, 10:00:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:00:48 INFO - 'tests': ['tsvgx', 10:00:48 INFO - 'tsvgr_opacity', 10:00:48 INFO - 'tart', 10:00:48 INFO - 'tscrollx', 10:00:48 INFO - 'cart']}, 10:00:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:48 INFO - 'tests': ['tp5o']}, 10:00:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:48 INFO - 'talos_options': ['--e10s'], 10:00:48 INFO - 'tests': ['tp5o']}, 10:00:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:48 INFO - 'talos_options': ['--xperf_path', 10:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:48 INFO - 'tests': ['tp5n']}, 10:00:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:48 INFO - 'talos_options': ['--e10s', 10:00:48 INFO - '--xperf_path', 10:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:48 INFO - 'tests': ['tp5n']}}, 10:00:48 INFO - 'talos.zip': {'path': '', 10:00:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:00:48 INFO - Running post-action listener: _resource_record_post_action 10:00:48 INFO - ##### 10:00:48 INFO - ##### Running create-virtualenv step. 10:00:48 INFO - ##### 10:00:48 INFO - Running pre-action listener: _resource_record_pre_action 10:00:48 INFO - Running main action method: create_virtualenv 10:00:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:00:48 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:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:00:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:00:48 INFO - Using real prefix '/usr' 10:00:48 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 0x7fbf8b97bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b07f0>, '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 0x271c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c760>, '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', 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 0x7fbf8b97bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b07f0>, '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 0x271c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c760>, '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', 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 - Downloading/unpacking psutil>=0.7.1 10:00:51 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:51 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:51 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:51 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:51 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:51 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:53 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:53 INFO - building 'psutil._psutil_posix' extension 10:00:53 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 0x7fbf8b97bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b07f0>, '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 0x271c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c760>, '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', 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 0x7fbf8b97bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b07f0>, '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 0x271c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c760>, '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', 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:58 INFO - Downloading docopt-0.6.1.tar.gz 10:00:58 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:58 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 0x7fbf8b97bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b07f0>, '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 0x271c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c760>, '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', 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:00:59 INFO - Running setup.py (path:/tmp/pip-j1LCcY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:00:59 INFO - Running setup.py (path:/tmp/pip-OjxTr_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:00:59 INFO - Running setup.py (path:/tmp/pip-bzmvxO-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-_5vxvt-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-XZLcfD-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-Wqq4TA-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-wRQqJN-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-PPrWIM-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-QF0tbq-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-_ubYFT-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-ysuv_a-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-S2GVyh-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-tIUngq-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-s6Uuyw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:00 INFO - Running setup.py (path:/tmp/pip-Svld3U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:00 INFO - Running setup.py (path:/tmp/pip-AxwZDg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:00 INFO - Running setup.py (path:/tmp/pip-a9Kvgf-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:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:01:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:01:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:01:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:01:01 INFO - Running setup.py install for mozleak 10:01:01 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:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:01:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:01:02 INFO - Cleaning up... 10:01:02 INFO - Return code: 0 10:01:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:01:02 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:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:02 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:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:02 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 0x7fbf8b97bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b07f0>, '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 0x271c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c760>, '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 10:01:02 INFO - 'HOME': '/home/cltbld', 10:01:02 INFO - 'LANG': 'en_US.UTF-8', 10:01:02 INFO - 'LANGUAGE': 'en_US:en', 10:01:02 INFO - 'LOGNAME': 'cltbld', 10:01:02 INFO - 'MAIL': '/var/mail/cltbld', 10:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:02 INFO - 'MOZ_NO_REMOTE': '1', 10:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:02 INFO - 'NO_EM_RESTART': '1', 10:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:02 INFO - 'SHELL': '/bin/bash', 10:01:02 INFO - 'SHLVL': '1', 10:01:02 INFO - 'TERM': 'linux', 10:01:02 INFO - 'TMOUT': '86400', 10:01:02 INFO - 'USER': 'cltbld', 10:01:02 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', 10:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:02 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-_qrL8I-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-iCdD_I-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-5IT_8k-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-xEVfer-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-NanqX2-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-aThhPw-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-9AeBfe-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-g5L2v7-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-5xp17H-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-LJhysz-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-Lv4oJX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:03 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:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:03 INFO - Running setup.py (path:/tmp/pip-9otd2M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:03 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:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:03 INFO - Running setup.py (path:/tmp/pip-6dG0pB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:03 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:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:03 INFO - Running setup.py (path:/tmp/pip-eGKcaH-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-r3cFL5-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-hTaMuy-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-lByCHE-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:05 INFO - Downloading blessings-1.5.1.tar.gz 10:01:05 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:05 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 0x7fbf8b97bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b07f0>, '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 0x271c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c760>, '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', 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 0x7fbf8b97bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b07f0>, '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 0x271c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c760>, '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', 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 - Downloading/unpacking jsonschema 10:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 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:08 INFO - Downloading functools32-3.2.3-2.tar.gz 10:01:08 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:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:01:08 INFO - warning: no files found matching '*.txt' 10:01:08 INFO - no previously-included directories found matching 'build' 10:01:08 INFO - no previously-included directories found matching 'dist' 10:01:08 INFO - no previously-included directories found matching '.git*' 10:01:08 INFO - Installing collected packages: jsonschema, functools32 10:01:08 INFO - Running setup.py install for functools32 10:01:08 INFO - warning: no files found matching '*.txt' 10:01:08 INFO - no previously-included directories found matching 'build' 10:01:08 INFO - no previously-included directories found matching 'dist' 10:01:08 INFO - no previously-included directories found matching '.git*' 10:01:08 INFO - Successfully installed jsonschema functools32 10:01:08 INFO - Cleaning up... 10:01:08 INFO - Return code: 0 10:01:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:01:08 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:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:08 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:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:08 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 0x7fbf8b97bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b07f0>, '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 0x271c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c760>, '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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', '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:08 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:08 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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', 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: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 pep8 script to /builds/slave/test-pgo/build/venv/bin 10:01:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:01:11 INFO - Cleaning up... 10:01:11 INFO - Return code: 0 10:01:11 INFO - Running post-action listener: _resource_record_post_action 10:01:11 INFO - Running post-action listener: _start_resource_monitoring 10:01:11 INFO - Starting resource monitoring. 10:01:11 INFO - ##### 10:01:11 INFO - ##### Running install step. 10:01:11 INFO - ##### 10:01:11 INFO - Running pre-action listener: _resource_record_pre_action 10:01:11 INFO - Running main action method: install 10:01:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:01:11 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 0x27b07f0>, '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 0x271c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c760>, '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', '--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-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 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 --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-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 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': '0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922', 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', '--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-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 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:41746' 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 7071 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPyCgHz/profile http://localhost:41746/getInfo.html) 10:01:33 INFO - PROCESS | 7071 | __metrics Screen width/height:1600/1200 10:01:33 INFO - PROCESS | 7071 | colorDepth:24 10:01:33 INFO - PROCESS | 7071 | Browser inner width/height: 1024/697 10:01:33 INFO - PROCESS | 7071 | __metrics 10:01:33 INFO - PROCESS | 7071 | 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:33 INFO - PROCESS | 7071 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:01:34 INFO - TEST-INFO | 7071: exit 0 10:01:34 INFO - Browser initialized. 10:01:34 INFO - Running cycle 1/1 for dromaeo_css test... 10:01:34 INFO - TEST-INFO | started process 7162 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPyCgHz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:46 INFO - PROCESS | 7162 | RSS: Main: 150372352 10:01:46 INFO - PROCESS | 7162 | 10:02:37 INFO - PROCESS | 7162 | 1452880957950 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 | 7162 | Cycle 1(1): loaded http://localhost:41746/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41746/tests/dromaeo/cssquery-ext.html) 10:04:47 INFO - PROCESS | 7162 | RSS: Main: 283590656 10:04:47 INFO - PROCESS | 7162 | 10:07:49 INFO - PROCESS | 7162 | Cycle 1(1): loaded http://localhost:41746/tests/dromaeo/cssquery-ext.html (next: http://localhost:41746/tests/dromaeo/cssquery-jquery.html) 10:07:50 INFO - PROCESS | 7162 | RSS: Main: 232919040 10:07:50 INFO - PROCESS | 7162 | 10:10:52 INFO - PROCESS | 7162 | Cycle 1(1): loaded http://localhost:41746/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41746/tests/dromaeo/cssquery-mootools.html) 10:10:52 INFO - PROCESS | 7162 | RSS: Main: 226500608 10:10:52 INFO - PROCESS | 7162 | 10:13:54 INFO - PROCESS | 7162 | Cycle 1(1): loaded http://localhost:41746/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41746/tests/dromaeo/cssquery-prototype.html) 10:13:55 INFO - PROCESS | 7162 | RSS: Main: 209399808 10:13:55 INFO - PROCESS | 7162 | 10:16:57 INFO - PROCESS | 7162 | Cycle 1(1): loaded http://localhost:41746/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41746/tests/dromaeo/cssquery-yui.html) 10:16:58 INFO - PROCESS | 7162 | RSS: Main: 214786048 10:16:58 INFO - PROCESS | 7162 | 10:20:01 INFO - PROCESS | 7162 | Cycle 1(1): loaded http://localhost:41746/tests/dromaeo/cssquery-yui.html (next: http://localhost:41746/tests/dromaeo/cssquery-dojo.html) 10:20:01 INFO - PROCESS | 7162 | RSS: Main: 230285312 10:20:01 INFO - PROCESS | 7162 | 10:20:01 INFO - PROCESS | 7162 | __start_tp_report 10:20:01 INFO - PROCESS | 7162 | _x_x_mozilla_page_load 10:20:01 INFO - PROCESS | 7162 | _x_x_mozilla_page_load_details 10:20:01 INFO - PROCESS | 7162 | |i|pagename|runs| 10:20:01 INFO - PROCESS | 7162 | |0;dojo.html;3069.9079027629173;3117.6882311768813;3155.0377134973824;3167.3506931079132;3188.2507610711477;4949.703017818924;5044.974775126124;5077.517635824595;5078.3905931288255;5098.388193416786;5131.435542090377;5148.613853960949;5194.428612852583;5202.479752024805;5219.295395121658;4599.218132917404;4623.0984957933215;4642.048380082092;4707.411573553306;4739.4075740532435;4728.645351598644;4730.219513780222;4743.312219728137;4775.80896764129;4834.2990266411525;4592.7933243004145;4603.631709463235;4667.743274119922;4680.321353403771;4703.976480117612;4662.184117779375;4676.50896655853;4686.507916668735;4699.553542413465;4726.976365118187;4653.7207767534055;4665.906681866378;4676.836310729108;4678.3216433616935;4707.152712511746;4869.074875773627;4936.086823937583;4938.45676975536;4950.6782059166035;4955.1328517509655;5498;5517.144842549411;5519.668819870821;5526.613137080406;5529.557635389159;5471.753771080311;5536.474034966672;5544.390117087117;5553.389127196006;5558.110702287655;5228.320318358589;5237.659552129099;5240.790368385298;5242.056429842627;5243.606729495303;5623.831285061455;5663.32040155184;5684.516816070598;5687.289088863892;5733.3406658234;5328.3605967284175;5417.458254174551;5418.674879507243;5433.456654334614;5502.147167189092;5501.064818980783;5507.531859791882;5508.173773933942;5515.117581186991;5531.889362212733;5452.672839629635;5457.61796674229;5460;5470.425605311465;5506.03644362235;5308.893822123536;5382.407935127133;5388.784448622089;5446.428125046892;5459.372172200168;4232.090100628379;4232.619064284229;4260.211860805761;4268.87193384199;4268.893277668083;3792.6207379262405;3793.0517370657335;3801.9809900950318;3826.1391186982705;3827.61723827615;5006.724630145377;5023.773930173151;5053.039922414803;5080.364954380702;5091.821786237464;5445.373782015119;5465.480779325958;5471.972640136773;5475.123980163155;5487.176923461513;5097.9745101275;5102.821401250939;5105.081085404663;5107.336046313955;5150.97424512875;4598.655100867449;4664.603508701731;4700.506446823103;4743.359646447685;4829.44461386945;5659.349174844863;5696.829095127153;5711.543076553866;5717.62835415705;5721.170430287585;5467.4532546745;5488.231647569263;5490.533304669148;5503.911092964973;5551.389347171888;5494.642848215013;5576.77692892296;5657.32112146545;5678.375378708256;5729.28383952006;5467.72661366938;5473.698946557977;5477.370102438271;5478.233047373291;5481.616286859881;5416.214648875812;5519.558435325084;5557.110862262019;5567.47109024642;5622.100463925753;5366.899785544032;5379.784808607768;5428.782848686008;5439.184122381675;5468.152436372368;5385.649932754359;5391.16436952273;5399.190121481809;5399.892002160013;5405.837824865261;5271.920921186109;5309.522143007148;5310.415854255952;5328.3605967284175;5348.010618035676;5326.946730532645;5348;5413.24214609947;5419.268398766116;5431.37539182999;5308.362996440452;5352.732363381738;5354.277172581652;5364.490373414519;5371.221172929825 10:20:01 INFO - PROCESS | 7162 | |1;ext.html;541.8455740114068;555.5666580067549;571.9542436605072;594.0524862843763;595.7081030295155;28131;28620.42759144816;36009.63990360099;36232.27535449296;36364.27271454576;41312.79343603285;41705.791471042605;41761.373579396335;41813.16373672532;41881;8642.351823613222;8864.069272726336;8867.024627290994;8868.37921345506;8875;8550.40147189697;8654.22112009919;8664.39349245553;8673.349498787584;8683;8658.220760131588;8710.085441028696;8732.345074119436;8740.169683880022;8745.344099192554;8606.913930860705;8690.869636955451;8697.608607612672;8699.43453675509;8699.478031318142;8446.408751387406;8587.914120858773;8597.484150950962;8598.87101693475;8600.483970961763;39550.20899581992;39730.60269397298;39913;40020.59979400198;40113.59886401128;3043.8325892075927;3107.0678796361226;3188.0595224408853;3377.932441351159;3754.7747135171703;29854.701452985628;30006.699933000607;30088.8495557523;30334.84832575823;31190.37619247625;3929.5481019682816;3940.8029598520247;3978;3986.1031267964477;4055.986003499125;204152;206199;206357;206789;206857;52702;53264;57305.42694573084;58200.12699809506;59523;53337.73331133319;53373.7331313341;53493.46506534963;53581.73209133929;53611.731941340826;13396.196228226338;14962.551123466314;15072.849271507144;15088.170150641601;15094.39622415113;10249.84625230622;12373;12618.747625047448;12626.494940202288;12652.240865548096;19285.710714339297;19403.708944365844;19425.611487770166;19425.8057419424;19426.902865485583;7044.859102817915;7432.405407567381;7437.405007599379;7515.0085227414775;7531.472796904273;877.0746862060587;878.152582757642;912.7489940266347;923.2706162131975;933.1368484152132;26667;26836.329091772863;27099.477067981035;28048.158555243375;28587.428251434856;1019.8419245017034;1053.2785042246087;1054.8997845204694;1057.6932689520106;1125.763589646167;14727.484538041332;14767.113973161644;14785.852141478663;15113.924430377778;15145.167015814235;327073;329169;330247;332132;332483;46406.30390544145;46555.767221163675;46557.37049203261;51370;51531.22703159456;1312.6915174933883;1315.7565850317721;1323.1862404621088;1347.5755137131969;1349.413005342679;26692.733072669802;27495.725042749316;27850;28110.85944570264;28189.71810281953;45883.770581146884;46150;46265;46285.30572041489;46290.53709462862;283538;289144;313965;318638;319193;29277.560836587894;29318.26704332409;29534.556981644862;29536.852315738284;29606.111816645534;39434.21131577295;40512.79743601263;40645.796771017136;41201.1759764797;41232;34495.827520862236;34764.47853282152;34825.303493929474;35196.47205291974;36128.63871361253;32371.352572947937;32827.50758738573;32937;34392.14019649529;35914.64085359113;31252;31629.8418507906;32095.679043209268;32252.35495290128;32308.35383292274;28711;31006.68993310038;32229.677703223606;32247.193820154684;32289.838550807097;24339.369184936804;24368.49925705795;24501.622739223938;24590.385240369134;24638 10:20:01 INFO - PROCESS | 7162 | |2;jquery.html;369.4513647233859;371.6283716283716;372.99440508392377;373.0878003281975;374.26457011971473;13717.725645487084;13923.512677056306;15854.762178567316;16074.115923624197;16650.417235396762;11152.442377881094;11552.3646199459;16248.593785155377;16640.50078497644;16676.58308542287;3706.555213374399;4743.075100355432;4899.48555401683;4901.2648102784515;4901.705897646135;3782.9432558511644;5274.683518988853;5494.752736126864;5495.862603434906;5498.422665620093;5443.346798384179;5474.233607294982;5658.91511627326;6008.729607167688;6009.369016253296;5371.758270877781;5984.072468767348;6003.189569408118;6028.427299406571;6034.939650603482;5086.1353569892835;5104.64267501275;5162.1224391853475;5163.14808056674;5192.480751924815;12860.807087893689;16784.41254556097;19331.323403680803;19999.400017999484;20028.399148025583;2006.9598608027904;2116.544942837297;2127.829773618122;2223.9332820015425;2631.092273165774;9395.76510587234;9415.764605884839;9543.236541076698;9565.856512152322;9696.272779541563;1793.4261036468336;1810.8189181081787;1812.9031935678988;1823.3344829137402;1830.4966134313038;53796.81977915436;55833.44166558323;56748.716256418455;57687.711561442346;57697.711511442176;9857.260705447121;10095;10136.54385552652;10162;10310.587576497006;13327.466901324033;13328.933355333162;13337.66655833612;13355.866441335656;13364.198148111145;7324.194338622748;7338.376238019721;7372.152202496782;7385.81535461607;7517.624118794039;7000.859982800315;7096.325849044332;7178.641067946582;7266;7271.745488907863;3989.122393073519;4115.279826030433;4130.318497447887;4218.894527636772;4304.548022457597;1797.8022417534062;1810.728390741373;1828.3783513605438;1832.8350448459703;1851.2046809318026;854.0861278432142;862.047437581476;914.4147745442922;917.9495127767904;956.8803899512561;15309.617259568377;15321.846781532042;15684;16679.0826504541;16866.91566542184;900.6847603338779;905.7192270396198;932.9393589416802;946.5172761891484;962.2494454325637;9078.319126065571;9437.386569872937;9540.666076687421;9554.570044348022;9638.518074096268;381980;508672;516406;562736.9620860724;568514;64804.67597662076;66840.66579667167;73426;74886.25113748902;76585;1008.3344992305043;1089.0742868561817;1119.798436281461;1147.822087576427;1151.867535233459;11972.76054478923;13921.303934803422;14176.291185440481;14332.785008224677;14962.775558366851;30594.388112238077;30944;32058.35883282368;32067.198320042186;32220.516692250105;37458;37544;37545.4368184472;39834;39934.20131597294;6743.29195434492;6998.895016574654;7166.605836679033;7313.268673132644;7327;8724.56377181151;10732.83900741474;10940.234183607072;10953.780924381626;11074.778504430027;8584;8736;8769.210771030637;8779.34154938395;9047.366684332297;9243.491607961627;9551.856722149034;9613.903860961302;9684.661036863676;9701.805963880543;8992;9202.769930751785;9287.72136835896;9336.626534938527;9442;7279.59962202084;7394.408447324308;7480.251974802476;7546.811329716801;7576.962115189389;9127.178553930178;9221.308401869752;9466.905330946602;9490;9638.518074096408 10:20:01 INFO - PROCESS | 7162 | |3;mootools.html;1340.443715857919;1478.438193486475;1504.0749938787642;1660.5848537865534;1808.8733788634802;7155.5348902321375;7796.220377962201;7956.244156805109;7962.044554653436;7973;7844.450888437812;8019.478733882293;8025.598720064003;8035.959820200906;8043.436959412844;1933.9613207735838;1970.2513045042936;1971.5169783403087;2340.414896275927;2372.039324073753;2073.0567591745794;2081.0531208300185;2302.9539409211807;2351.2828587280874;2355.234548771656;2231.7768223177713;2254.86470811751;2263.649134384173;2270.9318720438414;2293.4381076636246;2261.5363850410627;2300.6318988961684;2322.6051571232847;2330.557194133109;2334.941626459335;2263.1060731011157;2269.7730226977337;2272.7727227277305;2276.7723227677266;2283.1209984156053;8170.918290817075;8230.465019773696;8234.258916697467;8235.29999950005;8260.917390826075;4883.291922671193;4958.404991401019;4985.551300382983;4995.700257984533;5016.523430274118;3065.6321241450946;3068.9386212275854;3139.921501962446;3159.3523327717994;3165.7150856422804;903.5978989349676;918.715198288526;925.3522534226069;951.8714973478561;959.3811991265665;11464.140189485739;11466.656000320003;11496;11540.307581545134;11545.30728156305;4533.795979180944;4556.681032327705;4582.88542786433;4624.815007399734;4627.699199552018;9735.951320243354;9742.9025709742;9743.707688769347;9746.171575416169;9758;4913.410390753133;4931.309616653672;4941.555260026615;4953.801847926043;4954.133026720309;4437.179121862466;4452.465704115527;4452.977735111303;4453.354263631755;4464.799084041226;3575.3385623659187;3859.1509867829595;3921.8039098045556;3936.4685767421606;3960.663343615767;1184.4847491341295;1222.6759908624222;1227.846519185102;1240.0389697984135;1252.5678640868887;1029.248648486609;1067.9733006674896;1218.4334284557724;1319.960401187966;1338.4646141543267;7458.291462311072;7520.285572870568;7530.962345188239;7543.698252069856;7543.924560754323;1056.7358160459885;1082.1126676125502;1088.1621151713136;1089.455272363818;1108.855848739675;5913.526917846562;6023.216981792339;6028.125921741411;6030.4572588467245;6033.336333003366;9401;9589.856152157723;9623.759406014766;9679.467629280316;9709.465979371062;9531.428114313163;9619.422834629944;9626.66306679277;9651.806963860683;9686.515674216262;7328.413726901835;7600;7637.968874202023;7664.65509052094;7672.65473053714;7496.400287977058;7525.134609519975;7587.544747315179;7625.771226863203;7639.503432276884;8941.642334306554;8996.775080623036;9117.680881169392;9153.130452606993;9194.586243619187;9123.406978546373;9355.672551460666;9390.436573805593;9407.952960235156;9524.619015239312;7300.707971681286;7398.408127349691;7402.518836275625;7408.703651854081;7408.9629551851895;6803.693833777393;6921.584704917721;7719.768406947801;7784.065912090586;7858.921410786048;7189.460790440842;7192.065031545865;7195.100612423447;7345.045144131229;7353.485256032241;6886.552374095668;7011.719531218694;7067.0459487968465;7076.363127318566;7224.819379515554;7115.359617634438;7163.964180179066;7166.140063192451;7169.318914703095;7173.031640728644;6583.604983700993;6589.505787065893;6707.631080290435;6861.073755043005;6878.071460352789;6690.19717633887;6707.66461676924;6741.02255173007;6750.898736519054;6757.425618822455 10:20:01 INFO - PROCESS | 7162 | |4;prototype.html;334.4314665069382;344.3251227593916;348.42857713350105;350.34135824649655;353.48003584586274;5665.518430933365;5799.652020878745;5818.098194779811;5882.176495290657;5904.114382842576;5663.830085097454;5815.47660710536;5837.270341207349;5845.883082338361;5862;4550.658700597452;4554.4990051094355;4559.45286565611;4559.680822342438;4562.133194693014;4348.434703488558;4436.578525040116;4454.37638730578;4498.8875278117985;4545.795439205227;4484.327350897359;4492.348609451627;4496.9775151124195;4502.2571275739465;4516.18708632446;4500.122476117159;4501.954980450187;4503.3245013248115;4504.054148628792;4508.413906192207;3991.0820511282277;3997.8200980955635;3998.8800335989968;3999.960000400017;4000.5599384067727;5422.484863937959;5512.200730894038;5543.279373681436;5575.080111781551;5595.692236926968;5144.151215049513;5184.274201611777;5191.247269145991;5199.298094757197;5203.947960520384;5828.737706803204;6170.475509581691;6171.166892469549;6172.722227499773;6178.783742569033;4159.126583417486;4245.532991370947;4319.892002699926;4330.870073897788;4341.717788343779;6319.684015799192;6409.230892292908;6411.0383442483535;6411.198600174932;6414.93585064148;4433.800478978454;4436.733795972252;4438.955610443854;4447.533009034069;4447.911041779146;4369.344598310279;4496.685232033792;4502.5047244803045;4507.842225522091;4508.661850361236;5140.537351638296;5168.819091331786;5174.404943431478;5179.352580927384;5181.689098654093;6170.7223174957235;6197.411245931629;6215.471684906834;6219.346968568235;6231.875362492816;1570.8350623184629;1595.8085029796498;1598.296749430247;1598.5204438668352;1598.85610295074;1057.2335057083553;1068.1348108032364;1069.9251052426255;1076.0638244726981;1102.1238115698038;5853.385394533598;5882.794102206488;5887.705614719247;5894.410558944071;5900.380460051719;6307.148534947723;6368.840778980562;6371.617702937839;6372.490200783926;6376.234851817719;5854.95076723152;5876.6180198286975;5885.735141918624;5889.352171261158;5894.67579283135;3332.266901281763;3436.295559410315;3437;3440.913977150591;3440.9311813763584;6695;6699.296573859675;6701.664916754143;6703.061571380011;6706.5640733352175;6598.505112116611;6599.241087274929;6599.373059559334;6612.107365505692;6614.8346291343105;6458.095866578588;6667.499937504706;6683;6685.899711504331;6691.665416729047;6130.785422510369;6193.81418557444;6394.520410969289;6439.935600643934;6463.321351258238;6170.074488826712;6295.213098362705;6328.493720502257;6333.2716737575765;6354.936450635434;6671.39957403836;6673.1992160941;6676.766313179015;6683.799486015428;6691.933080669131;4419.911601768011;4447.888802779957;4504.527024662363;4506.211413002646;4509.571590698878;6429.196350456193;6432.13166222554;6439.291677915332;6446.742130314735;6447.9032814508755;6240.251169859646;6246.531510136667;6257.7184026718;6270.686465676789;6278.811635650938;6140.5701600887505;6257.43683068526;6260.436560709558;6260.624362538262;6273.874522509615;6133.877322453615;6140.723667434887;6146.293176284785;6150.815475535741;6151.200343955257;6266.060090986389;6286.4342209201395;6286.622802631857;6286.6856657166045;6286.779962701284;5999.400059993965;6133.478654314434;6137.355577664281;6147.108669242845;6151.415615516519 10:20:01 INFO - PROCESS | 7162 | |5;yui.html;680.3434685528464;693.5214701855722;714.8141483214364;832.8792325112859;841.3353450773889;13370.264635445059;13458.528951486713;13464.46142154315;13513;13578.253196074213;12602.621921342352;12645.304508252042;12662.43019064142;12665.55670551531;12720.55478058268;666.933306669334;676.7225437570597;796.6136423834436;813.3615112136988;819.19309480162;810.4934415990007;814.0800894988685;814.3729328417115;818.9344852411823;822.268181318627;705.6930235347614;853.6457370191363;860.1054902900976;863.9697610583631;864.3215076165211;708.6138054760169;843.5191940593865;861.9439736417113;864.6238886084542;865.074370423647;633.0441034038589;635.5741653092439;637.6843462486053;638.1544453598954;638.7189636559946;13037.152585082034;13086.083974121815;13103.672408189776;13110.27893465859;13129;12300.630981070582;12399.504019839196;12618.305993170372;12699;13153.671158221025;10215.489225538768;10449.164066874631;10596.735081622945;11029.227954043221;11191.384473853936;3605.152789094561;3615.891523254307;3636.781793092423;3643.7267204959735;3716.2753263113705;44948.55051449476;46347.30479042817;47151.76424117892;47180.528194717954;47221.29168062482;10019.899801002042;10030.398176109456;10154.847677284846;10371.429571373495;10411.427371494488;17388.13059347053;17506.474805755846;17511.03689297101;17573.384931527336;17581.120943952752;7069.752558660422;7359.742409015766;7714.768556943301;7720.382369410434;7862.174471680506;4214.325707886724;4220.345846393814;4226.049138943713;4293.592108749664;4345.97827010863;2974.2861713188677;3000.159955212544;3001.3997200559975;3002.789804713649;3008.6088808455197;554.2462251338177;571.9599628025999;577.9393163717833;579.2469789273927;580.0052909260638;598.3209057719432;599.4185639929261;616.3528295289927;633.9841503962438;645.686841881687;8316.37627177952;8387.454815437099;8403.83192336162;8523.786905327417;8539;573.263356586784;590.9970450147807;607.0348146447081;635.2726128582839;682.8429461223947;3456.412409890325;3532.9637695505944;3603.0992251937014;3626.9093272668392;3733.6453036961443;50004.249936250984;50563.74718126386;50741.492585073676;50764.23853642198;58804.7059764707;47794.5220547797;48297.517024830006;48524.757376212896;48605.5139448608;48820.26769598459;47589.76205118952;47996.520034799905;48739.5126048735;48950;49241.75379123153;8527.18991695788;8563.186497282748;8852.55737213124;8935.821283574422;8997;32930.34139317248;33335.33329333448;33936.490952635235;34418.82790586031;34436.48345274873;43202.13595728005;43398.34902476402;43522;43569.732270079236;44709.32936006028;10872.238943274211;10966.232363734782;11046.502907369348;11295.604653837405;11329.150313726339;11378.54485820558;11407;11437;11560.710982225175;11809.468573914366;10327.48362581883;10508.327212220142;10625.25623206368;10905.127589792639;10962.671119866416;10658.644996183682;10910.61812836547;10971.835422468828;10997.945010275218;11073.72315692082;9262.95368523153;10747.516361763895;10804.67585972422;11165.665030049111;11642.476088576204;8705.3035757138;8996.145366190201;9183.678571249975;9283.210927071275;9289.953550232205;8996.730098097067;9121.177080425823;9182.540872956191;9211.815763684823;9214.907850921405 10:20:01 INFO - PROCESS | 7162 | __end_tp_report 10:20:01 INFO - PROCESS | 7162 | __start_cc_report 10:20:01 INFO - PROCESS | 7162 | _x_x_mozilla_cycle_collect,1107 10:20:01 INFO - PROCESS | 7162 | __end_cc_report 10:20:01 INFO - PROCESS | 7162 | __startTimestamp1452882001457__endTimestamp 10:20:01 INFO - PROCESS | 7162 | 10:20:01 INFO - PROCESS | 7162 | ------- Summary: start ------- 10:20:01 INFO - PROCESS | 7162 | Number of tests: 6 10:20:01 INFO - PROCESS | 7162 | 10:20:01 INFO - PROCESS | 7162 | [#0] dojo.html Cycles:165 Average:5109.51 Median:5328.36 stddev:557.24 (10.5%) stddev-sans-first:535.49 10:20:01 INFO - PROCESS | 7162 | Values: 3069.9 3117.7 3155.0 3167.4 3188.3 4949.7 5045.0 5077.5 5078.4 5098.4 5131.4 5148.6 5194.4 5202.5 5219.3 4599.2 4623.1 4642.0 4707.4 4739.4 4728.6 4730.2 4743.3 4775.8 4834.3 4592.8 4603.6 4667.7 4680.3 4704.0 4662.2 4676.5 4686.5 4699.6 4727.0 4653.7 4665.9 4676.8 4678.3 4707.2 4869.1 4936.1 4938.5 4950.7 4955.1 5498.0 5517.1 5519.7 5526.6 5529.6 5471.8 5536.5 5544.4 5553.4 5558.1 5228.3 5237.7 5240.8 5242.1 5243.6 5623.8 5663.3 5684.5 5687.3 5733.3 5328.4 5417.5 5418.7 5433.5 5502.1 5501.1 5507.5 5508.2 5515.1 5531.9 5452.7 5457.6 5460.0 5470.4 5506.0 5308.9 5382.4 5388.8 5446.4 5459.4 4232.1 4232.6 4260.2 4268.9 4268.9 3792.6 3793.1 3802.0 3826.1 3827.6 5006.7 5023.8 5053.0 5080.4 5091.8 5445.4 5465.5 5472.0 5475.1 5487.2 5098.0 5102.8 5105.1 5107.3 5151.0 4598.7 4664.6 4700.5 4743.4 4829.4 5659.3 5696.8 5711.5 5717.6 5721.2 5467.5 5488.2 5490.5 5503.9 5551.4 5494.6 5576.8 5657.3 5678.4 5729.3 5467.7 5473.7 5477.4 5478.2 5481.6 5416.2 5519.6 5557.1 5567.5 5622.1 5366.9 5379.8 5428.8 5439.2 5468.2 5385.6 5391.2 5399.2 5399.9 5405.8 5271.9 5309.5 5310.4 5328.4 5348.0 5326.9 5348.0 5413.2 5419.3 5431.4 5308.4 5352.7 5354.3 5364.5 5371.2 10:20:01 INFO - PROCESS | 7162 | 10:20:01 INFO - PROCESS | 7162 | [#1] ext.html Cycles:180 Average:44310.63 Median:34630.15 stddev:74804.73 (216.0%) stddev-sans-first:74942.39 10:20:01 INFO - PROCESS | 7162 | Values: 541.8 555.6 572.0 594.1 595.7 28131.0 28620.4 36009.6 36232.3 36364.3 41312.8 41705.8 41761.4 41813.2 41881.0 8642.4 8864.1 8867.0 8868.4 8875.0 8550.4 8654.2 8664.4 8673.3 8683.0 8658.2 8710.1 8732.3 8740.2 8745.3 8606.9 8690.9 8697.6 8699.4 8699.5 8446.4 8587.9 8597.5 8598.9 8600.5 39550.2 39730.6 39913.0 40020.6 40113.6 3043.8 3107.1 3188.1 3377.9 3754.8 29854.7 30006.7 30088.8 30334.8 31190.4 3929.5 3940.8 3978.0 3986.1 4056.0 204152.0 206199.0 206357.0 206789.0 206857.0 52702.0 53264.0 57305.4 58200.1 59523.0 53337.7 53373.7 53493.5 53581.7 53611.7 13396.2 14962.6 15072.8 15088.2 15094.4 10249.8 12373.0 12618.7 12626.5 12652.2 19285.7 19403.7 19425.6 19425.8 19426.9 7044.9 7432.4 7437.4 7515.0 7531.5 877.1 878.2 912.7 923.3 933.1 26667.0 26836.3 27099.5 28048.2 28587.4 1019.8 1053.3 1054.9 1057.7 1125.8 14727.5 14767.1 14785.9 15113.9 15145.2 327073.0 329169.0 330247.0 332132.0 332483.0 46406.3 46555.8 46557.4 51370.0 51531.2 1312.7 1315.8 1323.2 1347.6 1349.4 26692.7 27495.7 27850.0 28110.9 28189.7 45883.8 46150.0 46265.0 46285.3 46290.5 283538.0 289144.0 313965.0 318638.0 319193.0 29277.6 29318.3 29534.6 29536.9 29606.1 39434.2 40512.8 40645.8 41201.2 41232.0 34495.8 34764.5 34825.3 35196.5 36128.6 32371.4 32827.5 32937.0 34392.1 35914.6 31252.0 31629.8 32095.7 32252.4 32308.4 28711.0 31006.7 32229.7 32247.2 32289.8 24339.4 24368.5 24501.6 24590.4 24638.0 10:20:01 INFO - PROCESS | 7162 | 10:20:01 INFO - PROCESS | 7162 | [#2] jquery.html Cycles:180 Average:26153.42 Median:260799.24 stddev:83716.57 (32.1%) stddev-sans-first:83929.03 10:20:01 INFO - PROCESS | 7162 | Values: 369.5 371.6 373.0 373.1 374.3 13717.7 13923.5 15854.8 16074.1 16650.4 11152.4 11552.4 16248.6 16640.5 16676.6 3706.6 4743.1 4899.5 4901.3 4901.7 3782.9 5274.7 5494.8 5495.9 5498.4 5443.3 5474.2 5658.9 6008.7 6009.4 5371.8 5984.1 6003.2 6028.4 6034.9 5086.1 5104.6 5162.1 5163.1 5192.5 12860.8 16784.4 19331.3 19999.4 20028.4 2007.0 2116.5 2127.8 2223.9 2631.1 9395.8 9415.8 9543.2 9565.9 9696.3 1793.4 1810.8 1812.9 1823.3 1830.5 53796.8 55833.4 56748.7 57687.7 57697.7 9857.3 10095.0 10136.5 10162.0 10310.6 13327.5 13328.9 13337.7 13355.9 13364.2 7324.2 7338.4 7372.2 7385.8 7517.6 7000.9 7096.3 7178.6 7266.0 7271.7 3989.1 4115.3 4130.3 4218.9 4304.5 1797.8 1810.7 1828.4 1832.8 1851.2 854.1 862.0 914.4 917.9 956.9 15309.6 15321.8 15684.0 16679.1 16866.9 900.7 905.7 932.9 946.5 962.2 9078.3 9437.4 9540.7 9554.6 9638.5 381980.0 508672.0 516406.0 562737.0 568514.0 64804.7 66840.7 73426.0 74886.3 76585.0 1008.3 1089.1 1119.8 1147.8 1151.9 11972.8 13921.3 14176.3 14332.8 14962.8 30594.4 30944.0 32058.4 32067.2 32220.5 37458.0 37544.0 37545.4 39834.0 39934.2 6743.3 6998.9 7166.6 7313.3 7327.0 8724.6 10732.8 10940.2 10953.8 11074.8 8584.0 8736.0 8769.2 8779.3 9047.4 9243.5 9551.9 9613.9 9684.7 9701.8 8992.0 9202.8 9287.7 9336.6 9442.0 7279.6 7394.4 7480.3 7546.8 7577.0 9127.2 9221.3 9466.9 9490.0 9638.5 10:20:01 INFO - PROCESS | 7162 | 10:20:01 INFO - PROCESS | 7162 | [#3] mootools.html Cycles:180 Average:5678.06 Median:6745.96 stddev:2999.25 (44.5%) stddev-sans-first:2989.94 10:20:01 INFO - PROCESS | 7162 | Values: 1340.4 1478.4 1504.1 1660.6 1808.9 7155.5 7796.2 7956.2 7962.0 7973.0 7844.5 8019.5 8025.6 8036.0 8043.4 1934.0 1970.3 1971.5 2340.4 2372.0 2073.1 2081.1 2303.0 2351.3 2355.2 2231.8 2254.9 2263.6 2270.9 2293.4 2261.5 2300.6 2322.6 2330.6 2334.9 2263.1 2269.8 2272.8 2276.8 2283.1 8170.9 8230.5 8234.3 8235.3 8260.9 4883.3 4958.4 4985.6 4995.7 5016.5 3065.6 3068.9 3139.9 3159.4 3165.7 903.6 918.7 925.4 951.9 959.4 11464.1 11466.7 11496.0 11540.3 11545.3 4533.8 4556.7 4582.9 4624.8 4627.7 9736.0 9742.9 9743.7 9746.2 9758.0 4913.4 4931.3 4941.6 4953.8 4954.1 4437.2 4452.5 4453.0 4453.4 4464.8 3575.3 3859.2 3921.8 3936.5 3960.7 1184.5 1222.7 1227.8 1240.0 1252.6 1029.2 1068.0 1218.4 1320.0 1338.5 7458.3 7520.3 7531.0 7543.7 7543.9 1056.7 1082.1 1088.2 1089.5 1108.9 5913.5 6023.2 6028.1 6030.5 6033.3 9401.0 9589.9 9623.8 9679.5 9709.5 9531.4 9619.4 9626.7 9651.8 9686.5 7328.4 7600.0 7638.0 7664.7 7672.7 7496.4 7525.1 7587.5 7625.8 7639.5 8941.6 8996.8 9117.7 9153.1 9194.6 9123.4 9355.7 9390.4 9408.0 9524.6 7300.7 7398.4 7402.5 7408.7 7409.0 6803.7 6921.6 7719.8 7784.1 7858.9 7189.5 7192.1 7195.1 7345.0 7353.5 6886.6 7011.7 7067.0 7076.4 7224.8 7115.4 7164.0 7166.1 7169.3 7173.0 6583.6 6589.5 6707.6 6861.1 6878.1 6690.2 6707.7 6741.0 6750.9 6757.4 10:20:01 INFO - PROCESS | 7162 | 10:20:01 INFO - PROCESS | 7162 | [#4] prototype.html Cycles:180 Average:5199.18 Median:5869.31 stddev:1556.04 (26.5%) stddev-sans-first:1516.96 10:20:01 INFO - PROCESS | 7162 | Values: 334.4 344.3 348.4 350.3 353.5 5665.5 5799.7 5818.1 5882.2 5904.1 5663.8 5815.5 5837.3 5845.9 5862.0 4550.7 4554.5 4559.5 4559.7 4562.1 4348.4 4436.6 4454.4 4498.9 4545.8 4484.3 4492.3 4497.0 4502.3 4516.2 4500.1 4502.0 4503.3 4504.1 4508.4 3991.1 3997.8 3998.9 4000.0 4000.6 5422.5 5512.2 5543.3 5575.1 5595.7 5144.2 5184.3 5191.2 5199.3 5203.9 5828.7 6170.5 6171.2 6172.7 6178.8 4159.1 4245.5 4319.9 4330.9 4341.7 6319.7 6409.2 6411.0 6411.2 6414.9 4433.8 4436.7 4439.0 4447.5 4447.9 4369.3 4496.7 4502.5 4507.8 4508.7 5140.5 5168.8 5174.4 5179.4 5181.7 6170.7 6197.4 6215.5 6219.3 6231.9 1570.8 1595.8 1598.3 1598.5 1598.9 1057.2 1068.1 1069.9 1076.1 1102.1 5853.4 5882.8 5887.7 5894.4 5900.4 6307.1 6368.8 6371.6 6372.5 6376.2 5855.0 5876.6 5885.7 5889.4 5894.7 3332.3 3436.3 3437.0 3440.9 3440.9 6695.0 6699.3 6701.7 6703.1 6706.6 6598.5 6599.2 6599.4 6612.1 6614.8 6458.1 6667.5 6683.0 6685.9 6691.7 6130.8 6193.8 6394.5 6439.9 6463.3 6170.1 6295.2 6328.5 6333.3 6354.9 6671.4 6673.2 6676.8 6683.8 6691.9 4419.9 4447.9 4504.5 4506.2 4509.6 6429.2 6432.1 6439.3 6446.7 6447.9 6240.3 6246.5 6257.7 6270.7 6278.8 6140.6 6257.4 6260.4 6260.6 6273.9 6133.9 6140.7 6146.3 6150.8 6151.2 6266.1 6286.4 6286.6 6286.7 6286.8 5999.4 6133.5 6137.4 6147.1 6151.4 10:20:01 INFO - PROCESS | 7162 | 10:20:01 INFO - PROCESS | 7162 | [#5] yui.html Cycles:180 Average:13396.20 Median:46749.53 stddev:15339.09 (32.8%) stddev-sans-first:15352.39 10:20:01 INFO - PROCESS | 7162 | Values: 680.3 693.5 714.8 832.9 841.3 13370.3 13458.5 13464.5 13513.0 13578.3 12602.6 12645.3 12662.4 12665.6 12720.6 666.9 676.7 796.6 813.4 819.2 810.5 814.1 814.4 818.9 822.3 705.7 853.6 860.1 864.0 864.3 708.6 843.5 861.9 864.6 865.1 633.0 635.6 637.7 638.2 638.7 13037.2 13086.1 13103.7 13110.3 13129.0 12300.6 12399.5 12618.3 12699.0 13153.7 10215.5 10449.2 10596.7 11029.2 11191.4 3605.2 3615.9 3636.8 3643.7 3716.3 44948.6 46347.3 47151.8 47180.5 47221.3 10019.9 10030.4 10154.8 10371.4 10411.4 17388.1 17506.5 17511.0 17573.4 17581.1 7069.8 7359.7 7714.8 7720.4 7862.2 4214.3 4220.3 4226.0 4293.6 4346.0 2974.3 3000.2 3001.4 3002.8 3008.6 554.2 572.0 577.9 579.2 580.0 598.3 599.4 616.4 634.0 645.7 8316.4 8387.5 8403.8 8523.8 8539.0 573.3 591.0 607.0 635.3 682.8 3456.4 3533.0 3603.1 3626.9 3733.6 50004.2 50563.7 50741.5 50764.2 58804.7 47794.5 48297.5 48524.8 48605.5 48820.3 47589.8 47996.5 48739.5 48950.0 49241.8 8527.2 8563.2 8852.6 8935.8 8997.0 32930.3 33335.3 33936.5 34418.8 34436.5 43202.1 43398.3 43522.0 43569.7 44709.3 10872.2 10966.2 11046.5 11295.6 11329.2 11378.5 11407.0 11437.0 11560.7 11809.5 10327.5 10508.3 10625.3 10905.1 10962.7 10658.6 10910.6 10971.8 10997.9 11073.7 9263.0 10747.5 10804.7 11165.7 11642.5 8705.3 8996.1 9183.7 9283.2 9290.0 8996.7 9121.2 9182.5 9211.8 9214.9 10:20:01 INFO - PROCESS | 7162 | -------- Summary: end -------- 10:20:01 INFO - PROCESS | 7162 | 10:20:02 INFO - TEST-INFO | 7162: exit 0 10:20:02 INFO - TEST-OK | dromaeo_css | took 1112550ms 10:20:02 INFO - TEST-START | kraken 10:20:02 INFO - operating with platform_type : linux_ 10:20:02 INFO - Initialising browser for kraken test... 10:20:02 INFO - TEST-INFO | started process 7364 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3Y8Y2t/profile http://localhost:41746/getInfo.html) 10:20:05 INFO - PROCESS | 7364 | __metrics Screen width/height:1600/1200 10:20:05 INFO - PROCESS | 7364 | colorDepth:24 10:20:05 INFO - PROCESS | 7364 | Browser inner width/height: 1024/697 10:20:05 INFO - PROCESS | 7364 | __metrics 10:20:05 INFO - PROCESS | 7364 | 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:05 INFO - PROCESS | 7364 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:20:06 INFO - TEST-INFO | 7364: 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 7443 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3Y8Y2t/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:18 INFO - PROCESS | 7443 | RSS: Main: 149532672 10:20:18 INFO - PROCESS | 7443 | 10:20:20 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41746/tests/kraken/driver.html?testName=audio-beat-detection) 10:20:21 INFO - PROCESS | 7443 | RSS: Main: 186224640 10:20:21 INFO - PROCESS | 7443 | 10:20:24 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41746/tests/kraken/driver.html?testName=audio-dft) 10:20:24 INFO - PROCESS | 7443 | RSS: Main: 176545792 10:20:24 INFO - PROCESS | 7443 | 10:20:27 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41746/tests/kraken/driver.html?testName=audio-fft) 10:20:28 INFO - PROCESS | 7443 | RSS: Main: 162594816 10:20:28 INFO - PROCESS | 7443 | 10:20:30 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41746/tests/kraken/driver.html?testName=audio-oscillator) 10:20:30 INFO - PROCESS | 7443 | RSS: Main: 162508800 10:20:30 INFO - PROCESS | 7443 | 10:20:33 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41746/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:20:33 INFO - PROCESS | 7443 | RSS: Main: 165851136 10:20:33 INFO - PROCESS | 7443 | 10:20:36 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41746/tests/kraken/driver.html?testName=imaging-darkroom) 10:20:37 INFO - PROCESS | 7443 | RSS: Main: 166735872 10:20:37 INFO - PROCESS | 7443 | 10:20:40 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41746/tests/kraken/driver.html?testName=imaging-desaturate) 10:20:41 INFO - PROCESS | 7443 | RSS: Main: 167256064 10:20:41 INFO - PROCESS | 7443 | 10:20:43 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41746/tests/kraken/driver.html?testName=json-parse-financial) 10:20:44 INFO - PROCESS | 7443 | RSS: Main: 165240832 10:20:44 INFO - PROCESS | 7443 | 10:20:45 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41746/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:20:46 INFO - PROCESS | 7443 | RSS: Main: 176205824 10:20:46 INFO - PROCESS | 7443 | 10:20:48 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:20:48 INFO - PROCESS | 7443 | RSS: Main: 174481408 10:20:48 INFO - PROCESS | 7443 | 10:20:50 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:20:51 INFO - PROCESS | 7443 | RSS: Main: 182308864 10:20:51 INFO - PROCESS | 7443 | 10:20:53 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:54 INFO - PROCESS | 7443 | RSS: Main: 190906368 10:20:54 INFO - PROCESS | 7443 | 10:20:56 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:57 INFO - PROCESS | 7443 | RSS: Main: 189837312 10:20:57 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41746/tests/kraken/driver.html?testName=ai-astar) 10:20:59 INFO - PROCESS | 7443 | RSS: Main: 245870592 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | __start_tp_report 10:20:59 INFO - PROCESS | 7443 | _x_x_mozilla_page_load 10:20:59 INFO - PROCESS | 7443 | _x_x_mozilla_page_load_details 10:20:59 INFO - PROCESS | 7443 | |i|pagename|runs| 10:20:59 INFO - PROCESS | 7443 | |0;ai-astar;108;110;106;109;112;111;99;110;109;110 10:20:59 INFO - PROCESS | 7443 | |1;audio-beat-detection;158;125;157;164;123;149;146;124;163;130 10:20:59 INFO - PROCESS | 7443 | |2;audio-dft;160;161;160;160;160;161;159;163;159;161 10:20:59 INFO - PROCESS | 7443 | |3;audio-fft;72;71;100;95;77;73;75;100;95;70 10:20:59 INFO - PROCESS | 7443 | |4;audio-oscillator;96;95;143;95;95;95;141;96;96;139 10:20:59 INFO - PROCESS | 7443 | |5;imaging-gaussian-blur;109;109;110;110;110;110;110;109;110;109 10:20:59 INFO - PROCESS | 7443 | |6;imaging-darkroom;146;146;146;145;146;145;145;145;145;145 10:20:59 INFO - PROCESS | 7443 | |7;imaging-desaturate;96;95;96;95;95;96;95;96;96;95 10:20:59 INFO - PROCESS | 7443 | |8;json-parse-financial;58;56;57;55;56;55;57;65;55;53 10:20:59 INFO - PROCESS | 7443 | |9;json-stringify-tinderbox;67;68;68;67;67;67;67;68;68;68 10:20:59 INFO - PROCESS | 7443 | |10;stanford-crypto-aes;79;82;81;82;82;81;82;81;83;82 10:20:59 INFO - PROCESS | 7443 | |11;stanford-crypto-ccm;121;111;125;129;112;116;115;117;115;113 10:20:59 INFO - PROCESS | 7443 | |12;stanford-crypto-pbkdf2;147;139;143;145;143;136;144;144;145;145 10:20:59 INFO - PROCESS | 7443 | |13;stanford-crypto-sha256-iterative;67;68;69;70;67;67;68;68;67;66 10:20:59 INFO - PROCESS | 7443 | __end_tp_report 10:20:59 INFO - PROCESS | 7443 | __start_cc_report 10:20:59 INFO - PROCESS | 7443 | _x_x_mozilla_cycle_collect,949 10:20:59 INFO - PROCESS | 7443 | __end_cc_report 10:20:59 INFO - PROCESS | 7443 | __startTimestamp1452882059423__endTimestamp 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | ------- Summary: start ------- 10:20:59 INFO - PROCESS | 7443 | Number of tests: 14 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:3.69 (3.4%) stddev-sans-first:3.91 10:20:59 INFO - PROCESS | 7443 | Values: 108.0 110.0 106.0 109.0 112.0 111.0 99.0 110.0 109.0 110.0 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:153.00 stddev:16.84 (11.0%) stddev-sans-first:17.07 10:20:59 INFO - PROCESS | 7443 | Values: 158.0 125.0 157.0 164.0 123.0 149.0 146.0 124.0 163.0 130.0 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 10:20:59 INFO - PROCESS | 7443 | Values: 160.0 161.0 160.0 160.0 160.0 161.0 159.0 163.0 159.0 161.0 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#3] audio-fft Cycles:10 Average:82.80 Median:74.00 stddev:12.91 (17.4%) stddev-sans-first:13.09 10:20:59 INFO - PROCESS | 7443 | Values: 72.0 71.0 100.0 95.0 77.0 73.0 75.0 100.0 95.0 70.0 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:95.00 stddev:22.04 (23.2%) stddev-sans-first:22.86 10:20:59 INFO - PROCESS | 7443 | Values: 96.0 95.0 143.0 95.0 95.0 95.0 141.0 96.0 96.0 139.0 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:20:59 INFO - PROCESS | 7443 | Values: 109.0 109.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:20:59 INFO - PROCESS | 7443 | Values: 146.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:20:59 INFO - PROCESS | 7443 | Values: 96.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.50 stddev:3.23 (5.7%) stddev-sans-first:3.40 10:20:59 INFO - PROCESS | 7443 | Values: 58.0 56.0 57.0 55.0 56.0 55.0 57.0 65.0 55.0 53.0 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 10:20:59 INFO - PROCESS | 7443 | Values: 67.0 68.0 68.0 67.0 67.0 67.0 67.0 68.0 68.0 68.0 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:82.00 stddev:1.08 (1.3%) stddev-sans-first:0.67 10:20:59 INFO - PROCESS | 7443 | Values: 79.0 82.0 81.0 82.0 82.0 81.0 82.0 81.0 83.0 82.0 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:116.50 stddev:5.85 (5.0%) stddev-sans-first:6.06 10:20:59 INFO - PROCESS | 7443 | Values: 121.0 111.0 125.0 129.0 112.0 116.0 115.0 117.0 115.0 113.0 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:144.50 stddev:3.25 (2.2%) stddev-sans-first:3.12 10:20:59 INFO - PROCESS | 7443 | Values: 147.0 139.0 143.0 145.0 143.0 136.0 144.0 144.0 145.0 145.0 10:20:59 INFO - PROCESS | 7443 | 10:20:59 INFO - PROCESS | 7443 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 10:20:59 INFO - PROCESS | 7443 | Values: 67.0 68.0 69.0 70.0 67.0 67.0 68.0 68.0 67.0 66.0 10:20:59 INFO - PROCESS | 7443 | -------- Summary: end -------- 10:20:59 INFO - PROCESS | 7443 | 10:21:00 INFO - TEST-INFO | 7443: exit 0 10:21:00 INFO - TEST-OK | kraken | took 58257ms 10:21:00 INFO - TEST-START | v8_7 10:21:00 INFO - operating with platform_type : linux_ 10:21:00 INFO - Initialising browser for v8_7 test... 10:21:00 INFO - TEST-INFO | started process 7693 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbdN2YP/profile http://localhost:41746/getInfo.html) 10:21:03 INFO - PROCESS | 7693 | __metrics Screen width/height:1600/1200 10:21:03 INFO - PROCESS | 7693 | colorDepth:24 10:21:03 INFO - PROCESS | 7693 | Browser inner width/height: 1024/697 10:21:03 INFO - PROCESS | 7693 | __metrics 10:21:03 INFO - PROCESS | 7693 | 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:03 INFO - PROCESS | 7693 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:21:04 INFO - TEST-INFO | 7693: exit 0 10:21:04 INFO - Browser initialized. 10:21:04 INFO - Running cycle 1/1 for v8_7 test... 10:21:04 INFO - TEST-INFO | started process 7775 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbdN2YP/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:16 INFO - PROCESS | 7775 | RSS: Main: 149901312 10:21:16 INFO - PROCESS | 7775 | 10:21:39 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:41746/tests/v8_7/run.html (next: http://localhost:41746/tests/v8_7/run.html) 10:21:39 INFO - PROCESS | 7775 | RSS: Main: 574570496 10:21:39 INFO - PROCESS | 7775 | 10:21:39 INFO - PROCESS | 7775 | __start_tp_report 10:21:39 INFO - PROCESS | 7775 | _x_x_mozilla_page_load 10:21:39 INFO - PROCESS | 7775 | _x_x_mozilla_page_load_details 10:21:39 INFO - PROCESS | 7775 | |i|pagename|runs| 10:21:39 INFO - PROCESS | 7775 | |0;Richards;165.59032952475576 10:21:39 INFO - PROCESS | 7775 | |1;DeltaBlue;188.89308651303364 10:21:39 INFO - PROCESS | 7775 | |2;Encrypt;280.1120448179272 10:21:39 INFO - PROCESS | 7775 | |3;Decrypt;5175.257731958763 10:21:39 INFO - PROCESS | 7775 | |4;RayTrace;1972.3865877712033 10:21:39 INFO - PROCESS | 7775 | |5;Earley;762.1951219512196 10:21:39 INFO - PROCESS | 7775 | |6;Boyer;12219.512195121952 10:21:39 INFO - PROCESS | 7775 | |7;RegExp;41600 10:21:39 INFO - PROCESS | 7775 | |8;Splay;574.9427917620137 10:21:39 INFO - PROCESS | 7775 | |9;NavierStokes;4840.579710144928 10:21:39 INFO - PROCESS | 7775 | __end_tp_report 10:21:39 INFO - PROCESS | 7775 | __startTimestamp1452882099408__endTimestamp 10:21:39 INFO - PROCESS | 7775 | 10:21:39 INFO - PROCESS | 7775 | ------- Summary: start ------- 10:21:39 INFO - PROCESS | 7775 | Number of tests: 10 10:21:39 INFO - PROCESS | 7775 | 10:21:39 INFO - PROCESS | 7775 | [#0] Richards Cycles:1 Average:165.59 Median:165.59 stddev:0.00 (0.0%) 10:21:39 INFO - PROCESS | 7775 | Values: 165.6 10:21:39 INFO - PROCESS | 7775 | 10:21:39 INFO - PROCESS | 7775 | [#1] DeltaBlue Cycles:1 Average:188.89 Median:188.89 stddev:0.00 (0.0%) 10:21:39 INFO - PROCESS | 7775 | Values: 188.9 10:21:39 INFO - PROCESS | 7775 | 10:21:39 INFO - PROCESS | 7775 | [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 10:21:39 INFO - PROCESS | 7775 | Values: 280.1 10:21:39 INFO - PROCESS | 7775 | 10:21:39 INFO - PROCESS | 7775 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 10:21:39 INFO - PROCESS | 7775 | Values: 5175.3 10:21:39 INFO - PROCESS | 7775 | 10:21:39 INFO - PROCESS | 7775 | [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 10:21:39 INFO - PROCESS | 7775 | Values: 1972.4 10:21:39 INFO - PROCESS | 7775 | 10:21:39 INFO - PROCESS | 7775 | [#5] Earley Cycles:1 Average:762.20 Median:762.20 stddev:0.00 (0.0%) 10:21:39 INFO - PROCESS | 7775 | Values: 762.2 10:21:39 INFO - PROCESS | 7775 | 10:21:39 INFO - PROCESS | 7775 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 10:21:39 INFO - PROCESS | 7775 | Values: 12219.5 10:21:39 INFO - PROCESS | 7775 | 10:21:39 INFO - PROCESS | 7775 | [#7] RegExp Cycles:1 Average:41600.00 Median:41600.00 stddev:0.00 (0.0%) 10:21:39 INFO - PROCESS | 7775 | Values: 41600.0 10:21:39 INFO - PROCESS | 7775 | 10:21:39 INFO - PROCESS | 7775 | [#8] Splay Cycles:1 Average:574.94 Median:574.94 stddev:0.00 (0.0%) 10:21:39 INFO - PROCESS | 7775 | Values: 574.9 10:21:39 INFO - PROCESS | 7775 | 10:21:39 INFO - PROCESS | 7775 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 10:21:39 INFO - PROCESS | 7775 | Values: 4840.6 10:21:39 INFO - PROCESS | 7775 | -------- Summary: end -------- 10:21:39 INFO - PROCESS | 7775 | 10:21:40 INFO - TEST-INFO | 7775: exit 0 10:21:40 INFO - TEST-OK | v8_7 | took 39953ms 10:21:40 INFO - SUITE-END | took 1210s 10:21:40 INFO - Completed test suite (00:20:10) 10:21:40 INFO - Working with test: dromaeo_css 10:21:40 INFO - Generating results file: dromaeo_css 10:21:40 INFO - Working with test: kraken 10:21:40 INFO - Generating results file: kraken 10:21:40 INFO - javascript benchmark 10:21:40 INFO - Working with test: v8_7 10:21:40 INFO - Generating results file: v8_7 10:21:40 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 10:21:40 INFO - process_Request line: dromaeo_css 6765.15 graph.html#tests=[[72,63,35]] 10:21:40 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:40 INFO - process_Request line: kraken 1489.00 graph.html#tests=[[232,63,35]] 10:21:40 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:40 INFO - process_Request line: v8_7 19124.53 graph.html#tests=[[230,63,35]] 10:21:40 INFO - RETURN: dromaeo_css: 6765.15 10:21:40 INFO - RETURN: kraken: 1489.00 10:21:40 INFO - RETURN: v8_7: 19124.53 10:21:40 INFO - javascript benchmark 10:21:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3069.9079027629173, 3117.6882311768813, 3155.0377134973824, 3167.3506931079132, 3188.2507610711477, 4949.703017818924, 5044.974775126124, 5077.517635824595, 5078.3905931288255, 5098.388193416786, 5131.435542090377, 5148.613853960949, 5194.428612852583, 5202.479752024805, 5219.295395121658, 4599.218132917404, 4623.0984957933215, 4642.048380082092, 4707.411573553306, 4739.4075740532435, 4728.645351598644, 4730.219513780222, 4743.312219728137, 4775.80896764129, 4834.2990266411525, 4592.7933243004145, 4603.631709463235, 4667.743274119922, 4680.321353403771, 4703.976480117612, 4662.184117779375, 4676.50896655853, 4686.507916668735, 4699.553542413465, 4726.976365118187, 4653.7207767534055, 4665.906681866378, 4676.836310729108, 4678.3216433616935, 4707.152712511746, 4869.074875773627, 4936.086823937583, 4938.45676975536, 4950.6782059166035, 4955.1328517509655, 5498.0, 5517.144842549411, 5519.668819870821, 5526.613137080406, 5529.557635389159, 5471.753771080311, 5536.474034966672, 5544.390117087117, 5553.389127196006, 5558.110702287655, 5228.320318358589, 5237.659552129099, 5240.790368385298, 5242.056429842627, 5243.606729495303, 5623.831285061455, 5663.32040155184, 5684.516816070598, 5687.289088863892, 5733.3406658234, 5328.3605967284175, 5417.458254174551, 5418.674879507243, 5433.456654334614, 5502.147167189092, 5501.064818980783, 5507.531859791882, 5508.173773933942, 5515.117581186991, 5531.889362212733, 5452.672839629635, 5457.61796674229, 5460.0, 5470.425605311465, 5506.03644362235, 5308.893822123536, 5382.407935127133, 5388.784448622089, 5446.428125046892, 5459.372172200168, 4232.090100628379, 4232.619064284229, 4260.211860805761, 4268.87193384199, 4268.893277668083, 3792.6207379262405, 3793.0517370657335, 3801.9809900950318, 3826.1391186982705, 3827.61723827615, 5006.724630145377, 5023.773930173151, 5053.039922414803, 5080.364954380702, 5091.821786237464, 5445.373782015119, 5465.480779325958, 5471.972640136773, 5475.123980163155, 5487.176923461513, 5097.9745101275, 5102.821401250939, 5105.081085404663, 5107.336046313955, 5150.97424512875, 4598.655100867449, 4664.603508701731, 4700.506446823103, 4743.359646447685, 4829.44461386945, 5659.349174844863, 5696.829095127153, 5711.543076553866, 5717.62835415705, 5721.170430287585, 5467.4532546745, 5488.231647569263, 5490.533304669148, 5503.911092964973, 5551.389347171888, 5494.642848215013, 5576.77692892296, 5657.32112146545, 5678.375378708256, 5729.28383952006, 5467.72661366938, 5473.698946557977, 5477.370102438271, 5478.233047373291, 5481.616286859881, 5416.214648875812, 5519.558435325084, 5557.110862262019, 5567.47109024642, 5622.100463925753, 5366.899785544032, 5379.784808607768, 5428.782848686008, 5439.184122381675, 5468.152436372368, 5385.649932754359, 5391.16436952273, 5399.190121481809, 5399.892002160013, 5405.837824865261, 5271.920921186109, 5309.522143007148, 5310.415854255952, 5328.3605967284175, 5348.010618035676, 5326.946730532645, 5348.0, 5413.24214609947, 5419.268398766116, 5431.37539182999, 5308.362996440452, 5352.732363381738, 5354.277172581652, 5364.490373414519, 5371.221172929825], "unit": "score", "name": "dojo.html", "value": 5074.275597701578}, {"lowerIsBetter": false, "replicates": [541.8455740114068, 555.5666580067549, 571.9542436605072, 594.0524862843763, 595.7081030295155, 28131.0, 28620.42759144816, 36009.63990360099, 36232.27535449296, 36364.27271454576, 41312.79343603285, 41705.791471042605, 41761.373579396335, 41813.16373672532, 41881.0, 8642.351823613222, 8864.069272726336, 8867.024627290994, 8868.37921345506, 8875.0, 8550.40147189697, 8654.22112009919, 8664.39349245553, 8673.349498787584, 8683.0, 8658.220760131588, 8710.085441028696, 8732.345074119436, 8740.169683880022, 8745.344099192554, 8606.913930860705, 8690.869636955451, 8697.608607612672, 8699.43453675509, 8699.478031318142, 8446.408751387406, 8587.914120858773, 8597.484150950962, 8598.87101693475, 8600.483970961763, 39550.20899581992, 39730.60269397298, 39913.0, 40020.59979400198, 40113.59886401128, 3043.8325892075927, 3107.0678796361226, 3188.0595224408853, 3377.932441351159, 3754.7747135171703, 29854.701452985628, 30006.699933000607, 30088.8495557523, 30334.84832575823, 31190.37619247625, 3929.5481019682816, 3940.8029598520247, 3978.0, 3986.1031267964477, 4055.986003499125, 204152.0, 206199.0, 206357.0, 206789.0, 206857.0, 52702.0, 53264.0, 57305.42694573084, 58200.12699809506, 59523.0, 53337.73331133319, 53373.7331313341, 53493.46506534963, 53581.73209133929, 53611.731941340826, 13396.196228226338, 14962.551123466314, 15072.849271507144, 15088.170150641601, 15094.39622415113, 10249.84625230622, 12373.0, 12618.747625047448, 12626.494940202288, 12652.240865548096, 19285.710714339297, 19403.708944365844, 19425.611487770166, 19425.8057419424, 19426.902865485583, 7044.859102817915, 7432.405407567381, 7437.405007599379, 7515.0085227414775, 7531.472796904273, 877.0746862060587, 878.152582757642, 912.7489940266347, 923.2706162131975, 933.1368484152132, 26667.0, 26836.329091772863, 27099.477067981035, 28048.158555243375, 28587.428251434856, 1019.8419245017034, 1053.2785042246087, 1054.8997845204694, 1057.6932689520106, 1125.763589646167, 14727.484538041332, 14767.113973161644, 14785.852141478663, 15113.924430377778, 15145.167015814235, 327073.0, 329169.0, 330247.0, 332132.0, 332483.0, 46406.30390544145, 46555.767221163675, 46557.37049203261, 51370.0, 51531.22703159456, 1312.6915174933883, 1315.7565850317721, 1323.1862404621088, 1347.5755137131969, 1349.413005342679, 26692.733072669802, 27495.725042749316, 27850.0, 28110.85944570264, 28189.71810281953, 45883.770581146884, 46150.0, 46265.0, 46285.30572041489, 46290.53709462862, 283538.0, 289144.0, 313965.0, 318638.0, 319193.0, 29277.560836587894, 29318.26704332409, 29534.556981644862, 29536.852315738284, 29606.111816645534, 39434.21131577295, 40512.79743601263, 40645.796771017136, 41201.1759764797, 41232.0, 34495.827520862236, 34764.47853282152, 34825.303493929474, 35196.47205291974, 36128.63871361253, 32371.352572947937, 32827.50758738573, 32937.0, 34392.14019649529, 35914.64085359113, 31252.0, 31629.8418507906, 32095.679043209268, 32252.35495290128, 32308.35383292274, 28711.0, 31006.68993310038, 32229.677703223606, 32247.193820154684, 32289.838550807097, 24339.369184936804, 24368.49925705795, 24501.622739223938, 24590.385240369134, 24638.0], "unit": "score", "name": "ext.html", "value": 17832.470294402996}, {"lowerIsBetter": false, "replicates": [369.4513647233859, 371.6283716283716, 372.99440508392377, 373.0878003281975, 374.26457011971473, 13717.725645487084, 13923.512677056306, 15854.762178567316, 16074.115923624197, 16650.417235396762, 11152.442377881094, 11552.3646199459, 16248.593785155377, 16640.50078497644, 16676.58308542287, 3706.555213374399, 4743.075100355432, 4899.48555401683, 4901.2648102784515, 4901.705897646135, 3782.9432558511644, 5274.683518988853, 5494.752736126864, 5495.862603434906, 5498.422665620093, 5443.346798384179, 5474.233607294982, 5658.91511627326, 6008.729607167688, 6009.369016253296, 5371.758270877781, 5984.072468767348, 6003.189569408118, 6028.427299406571, 6034.939650603482, 5086.1353569892835, 5104.64267501275, 5162.1224391853475, 5163.14808056674, 5192.480751924815, 12860.807087893689, 16784.41254556097, 19331.323403680803, 19999.400017999484, 20028.399148025583, 2006.9598608027904, 2116.544942837297, 2127.829773618122, 2223.9332820015425, 2631.092273165774, 9395.76510587234, 9415.764605884839, 9543.236541076698, 9565.856512152322, 9696.272779541563, 1793.4261036468336, 1810.8189181081787, 1812.9031935678988, 1823.3344829137402, 1830.4966134313038, 53796.81977915436, 55833.44166558323, 56748.716256418455, 57687.711561442346, 57697.711511442176, 9857.260705447121, 10095.0, 10136.54385552652, 10162.0, 10310.587576497006, 13327.466901324033, 13328.933355333162, 13337.66655833612, 13355.866441335656, 13364.198148111145, 7324.194338622748, 7338.376238019721, 7372.152202496782, 7385.81535461607, 7517.624118794039, 7000.859982800315, 7096.325849044332, 7178.641067946582, 7266.0, 7271.745488907863, 3989.122393073519, 4115.279826030433, 4130.318497447887, 4218.894527636772, 4304.548022457597, 1797.8022417534062, 1810.728390741373, 1828.3783513605438, 1832.8350448459703, 1851.2046809318026, 854.0861278432142, 862.047437581476, 914.4147745442922, 917.9495127767904, 956.8803899512561, 15309.617259568377, 15321.846781532042, 15684.0, 16679.0826504541, 16866.91566542184, 900.6847603338779, 905.7192270396198, 932.9393589416802, 946.5172761891484, 962.2494454325637, 9078.319126065571, 9437.386569872937, 9540.666076687421, 9554.570044348022, 9638.518074096268, 381980.0, 508672.0, 516406.0, 562736.9620860724, 568514.0, 64804.67597662076, 66840.66579667167, 73426.0, 74886.25113748902, 76585.0, 1008.3344992305043, 1089.0742868561817, 1119.798436281461, 1147.822087576427, 1151.867535233459, 11972.76054478923, 13921.303934803422, 14176.291185440481, 14332.785008224677, 14962.775558366851, 30594.388112238077, 30944.0, 32058.35883282368, 32067.198320042186, 32220.516692250105, 37458.0, 37544.0, 37545.4368184472, 39834.0, 39934.20131597294, 6743.29195434492, 6998.895016574654, 7166.605836679033, 7313.268673132644, 7327.0, 8724.56377181151, 10732.83900741474, 10940.234183607072, 10953.780924381626, 11074.778504430027, 8584.0, 8736.0, 8769.210771030637, 8779.34154938395, 9047.366684332297, 9243.491607961627, 9551.856722149034, 9613.903860961302, 9684.661036863676, 9701.805963880543, 8992.0, 9202.769930751785, 9287.72136835896, 9336.626534938527, 9442.0, 7279.59962202084, 7394.408447324308, 7480.251974802476, 7546.811329716801, 7576.962115189389, 9127.178553930178, 9221.308401869752, 9466.905330946602, 9490.0, 9638.518074096408], "unit": "score", "name": "jquery.html", "value": 7935.547067256155}, {"lowerIsBetter": false, "replicates": [1340.443715857919, 1478.438193486475, 1504.0749938787642, 1660.5848537865534, 1808.8733788634802, 7155.5348902321375, 7796.220377962201, 7956.244156805109, 7962.044554653436, 7973.0, 7844.450888437812, 8019.478733882293, 8025.598720064003, 8035.959820200906, 8043.436959412844, 1933.9613207735838, 1970.2513045042936, 1971.5169783403087, 2340.414896275927, 2372.039324073753, 2073.0567591745794, 2081.0531208300185, 2302.9539409211807, 2351.2828587280874, 2355.234548771656, 2231.7768223177713, 2254.86470811751, 2263.649134384173, 2270.9318720438414, 2293.4381076636246, 2261.5363850410627, 2300.6318988961684, 2322.6051571232847, 2330.557194133109, 2334.941626459335, 2263.1060731011157, 2269.7730226977337, 2272.7727227277305, 2276.7723227677266, 2283.1209984156053, 8170.918290817075, 8230.465019773696, 8234.258916697467, 8235.29999950005, 8260.917390826075, 4883.291922671193, 4958.404991401019, 4985.551300382983, 4995.700257984533, 5016.523430274118, 3065.6321241450946, 3068.9386212275854, 3139.921501962446, 3159.3523327717994, 3165.7150856422804, 903.5978989349676, 918.715198288526, 925.3522534226069, 951.8714973478561, 959.3811991265665, 11464.140189485739, 11466.656000320003, 11496.0, 11540.307581545134, 11545.30728156305, 4533.795979180944, 4556.681032327705, 4582.88542786433, 4624.815007399734, 4627.699199552018, 9735.951320243354, 9742.9025709742, 9743.707688769347, 9746.171575416169, 9758.0, 4913.410390753133, 4931.309616653672, 4941.555260026615, 4953.801847926043, 4954.133026720309, 4437.179121862466, 4452.465704115527, 4452.977735111303, 4453.354263631755, 4464.799084041226, 3575.3385623659187, 3859.1509867829595, 3921.8039098045556, 3936.4685767421606, 3960.663343615767, 1184.4847491341295, 1222.6759908624222, 1227.846519185102, 1240.0389697984135, 1252.5678640868887, 1029.248648486609, 1067.9733006674896, 1218.4334284557724, 1319.960401187966, 1338.4646141543267, 7458.291462311072, 7520.285572870568, 7530.962345188239, 7543.698252069856, 7543.924560754323, 1056.7358160459885, 1082.1126676125502, 1088.1621151713136, 1089.455272363818, 1108.855848739675, 5913.526917846562, 6023.216981792339, 6028.125921741411, 6030.4572588467245, 6033.336333003366, 9401.0, 9589.856152157723, 9623.759406014766, 9679.467629280316, 9709.465979371062, 9531.428114313163, 9619.422834629944, 9626.66306679277, 9651.806963860683, 9686.515674216262, 7328.413726901835, 7600.0, 7637.968874202023, 7664.65509052094, 7672.65473053714, 7496.400287977058, 7525.134609519975, 7587.544747315179, 7625.771226863203, 7639.503432276884, 8941.642334306554, 8996.775080623036, 9117.680881169392, 9153.130452606993, 9194.586243619187, 9123.406978546373, 9355.672551460666, 9390.436573805593, 9407.952960235156, 9524.619015239312, 7300.707971681286, 7398.408127349691, 7402.518836275625, 7408.703651854081, 7408.9629551851895, 6803.693833777393, 6921.584704917721, 7719.768406947801, 7784.065912090586, 7858.921410786048, 7189.460790440842, 7192.065031545865, 7195.100612423447, 7345.045144131229, 7353.485256032241, 6886.552374095668, 7011.719531218694, 7067.0459487968465, 7076.363127318566, 7224.819379515554, 7115.359617634438, 7163.964180179066, 7166.140063192451, 7169.318914703095, 7173.031640728644, 6583.604983700993, 6589.505787065893, 6707.631080290435, 6861.073755043005, 6878.071460352789, 6690.19717633887, 6707.66461676924, 6741.02255173007, 6750.898736519054, 6757.425618822455], "unit": "score", "name": "mootools.html", "value": 4617.30450657895}, {"lowerIsBetter": false, "replicates": [334.4314665069382, 344.3251227593916, 348.42857713350105, 350.34135824649655, 353.48003584586274, 5665.518430933365, 5799.652020878745, 5818.098194779811, 5882.176495290657, 5904.114382842576, 5663.830085097454, 5815.47660710536, 5837.270341207349, 5845.883082338361, 5862.0, 4550.658700597452, 4554.4990051094355, 4559.45286565611, 4559.680822342438, 4562.133194693014, 4348.434703488558, 4436.578525040116, 4454.37638730578, 4498.8875278117985, 4545.795439205227, 4484.327350897359, 4492.348609451627, 4496.9775151124195, 4502.2571275739465, 4516.18708632446, 4500.122476117159, 4501.954980450187, 4503.3245013248115, 4504.054148628792, 4508.413906192207, 3991.0820511282277, 3997.8200980955635, 3998.8800335989968, 3999.960000400017, 4000.5599384067727, 5422.484863937959, 5512.200730894038, 5543.279373681436, 5575.080111781551, 5595.692236926968, 5144.151215049513, 5184.274201611777, 5191.247269145991, 5199.298094757197, 5203.947960520384, 5828.737706803204, 6170.475509581691, 6171.166892469549, 6172.722227499773, 6178.783742569033, 4159.126583417486, 4245.532991370947, 4319.892002699926, 4330.870073897788, 4341.717788343779, 6319.684015799192, 6409.230892292908, 6411.0383442483535, 6411.198600174932, 6414.93585064148, 4433.800478978454, 4436.733795972252, 4438.955610443854, 4447.533009034069, 4447.911041779146, 4369.344598310279, 4496.685232033792, 4502.5047244803045, 4507.842225522091, 4508.661850361236, 5140.537351638296, 5168.819091331786, 5174.404943431478, 5179.352580927384, 5181.689098654093, 6170.7223174957235, 6197.411245931629, 6215.471684906834, 6219.346968568235, 6231.875362492816, 1570.8350623184629, 1595.8085029796498, 1598.296749430247, 1598.5204438668352, 1598.85610295074, 1057.2335057083553, 1068.1348108032364, 1069.9251052426255, 1076.0638244726981, 1102.1238115698038, 5853.385394533598, 5882.794102206488, 5887.705614719247, 5894.410558944071, 5900.380460051719, 6307.148534947723, 6368.840778980562, 6371.617702937839, 6372.490200783926, 6376.234851817719, 5854.95076723152, 5876.6180198286975, 5885.735141918624, 5889.352171261158, 5894.67579283135, 3332.266901281763, 3436.295559410315, 3437.0, 3440.913977150591, 3440.9311813763584, 6695.0, 6699.296573859675, 6701.664916754143, 6703.061571380011, 6706.5640733352175, 6598.505112116611, 6599.241087274929, 6599.373059559334, 6612.107365505692, 6614.8346291343105, 6458.095866578588, 6667.499937504706, 6683.0, 6685.899711504331, 6691.665416729047, 6130.785422510369, 6193.81418557444, 6394.520410969289, 6439.935600643934, 6463.321351258238, 6170.074488826712, 6295.213098362705, 6328.493720502257, 6333.2716737575765, 6354.936450635434, 6671.39957403836, 6673.1992160941, 6676.766313179015, 6683.799486015428, 6691.933080669131, 4419.911601768011, 4447.888802779957, 4504.527024662363, 4506.211413002646, 4509.571590698878, 6429.196350456193, 6432.13166222554, 6439.291677915332, 6446.742130314735, 6447.9032814508755, 6240.251169859646, 6246.531510136667, 6257.7184026718, 6270.686465676789, 6278.811635650938, 6140.5701600887505, 6257.43683068526, 6260.436560709558, 6260.624362538262, 6273.874522509615, 6133.877322453615, 6140.723667434887, 6146.293176284785, 6150.815475535741, 6151.200343955257, 6266.060090986389, 6286.4342209201395, 6286.622802631857, 6286.6856657166045, 6286.779962701284, 5999.400059993965, 6133.478654314434, 6137.355577664281, 6147.108669242845, 6151.415615516519], "unit": "score", "name": "prototype.html", "value": 4700.34322791478}, {"lowerIsBetter": false, "replicates": [680.3434685528464, 693.5214701855722, 714.8141483214364, 832.8792325112859, 841.3353450773889, 13370.264635445059, 13458.528951486713, 13464.46142154315, 13513.0, 13578.253196074213, 12602.621921342352, 12645.304508252042, 12662.43019064142, 12665.55670551531, 12720.55478058268, 666.933306669334, 676.7225437570597, 796.6136423834436, 813.3615112136988, 819.19309480162, 810.4934415990007, 814.0800894988685, 814.3729328417115, 818.9344852411823, 822.268181318627, 705.6930235347614, 853.6457370191363, 860.1054902900976, 863.9697610583631, 864.3215076165211, 708.6138054760169, 843.5191940593865, 861.9439736417113, 864.6238886084542, 865.074370423647, 633.0441034038589, 635.5741653092439, 637.6843462486053, 638.1544453598954, 638.7189636559946, 13037.152585082034, 13086.083974121815, 13103.672408189776, 13110.27893465859, 13129.0, 12300.630981070582, 12399.504019839196, 12618.305993170372, 12699.0, 13153.671158221025, 10215.489225538768, 10449.164066874631, 10596.735081622945, 11029.227954043221, 11191.384473853936, 3605.152789094561, 3615.891523254307, 3636.781793092423, 3643.7267204959735, 3716.2753263113705, 44948.55051449476, 46347.30479042817, 47151.76424117892, 47180.528194717954, 47221.29168062482, 10019.899801002042, 10030.398176109456, 10154.847677284846, 10371.429571373495, 10411.427371494488, 17388.13059347053, 17506.474805755846, 17511.03689297101, 17573.384931527336, 17581.120943952752, 7069.752558660422, 7359.742409015766, 7714.768556943301, 7720.382369410434, 7862.174471680506, 4214.325707886724, 4220.345846393814, 4226.049138943713, 4293.592108749664, 4345.97827010863, 2974.2861713188677, 3000.159955212544, 3001.3997200559975, 3002.789804713649, 3008.6088808455197, 554.2462251338177, 571.9599628025999, 577.9393163717833, 579.2469789273927, 580.0052909260638, 598.3209057719432, 599.4185639929261, 616.3528295289927, 633.9841503962438, 645.686841881687, 8316.37627177952, 8387.454815437099, 8403.83192336162, 8523.786905327417, 8539.0, 573.263356586784, 590.9970450147807, 607.0348146447081, 635.2726128582839, 682.8429461223947, 3456.412409890325, 3532.9637695505944, 3603.0992251937014, 3626.9093272668392, 3733.6453036961443, 50004.249936250984, 50563.74718126386, 50741.492585073676, 50764.23853642198, 58804.7059764707, 47794.5220547797, 48297.517024830006, 48524.757376212896, 48605.5139448608, 48820.26769598459, 47589.76205118952, 47996.520034799905, 48739.5126048735, 48950.0, 49241.75379123153, 8527.18991695788, 8563.186497282748, 8852.55737213124, 8935.821283574422, 8997.0, 32930.34139317248, 33335.33329333448, 33936.490952635235, 34418.82790586031, 34436.48345274873, 43202.13595728005, 43398.34902476402, 43522.0, 43569.732270079236, 44709.32936006028, 10872.238943274211, 10966.232363734782, 11046.502907369348, 11295.604653837405, 11329.150313726339, 11378.54485820558, 11407.0, 11437.0, 11560.710982225175, 11809.468573914366, 10327.48362581883, 10508.327212220142, 10625.25623206368, 10905.127589792639, 10962.671119866416, 10658.644996183682, 10910.61812836547, 10971.835422468828, 10997.945010275218, 11073.72315692082, 9262.95368523153, 10747.516361763895, 10804.67585972422, 11165.665030049111, 11642.476088576204, 8705.3035757138, 8996.145366190201, 9183.678571249975, 9283.210927071275, 9289.953550232205, 8996.730098097067, 9121.177080425823, 9182.540872956191, 9211.815763684823, 9214.907850921405], "unit": "score", "name": "yui.html", "value": 6151.053519580664}], "name": "dromaeo_css", "value": 6765.155162633351}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 106.0, 109.0, 112.0, 111.0, 99.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [158.0, 125.0, 157.0, 164.0, 123.0, 149.0, 146.0, 124.0, 163.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 143.9}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 159.0, 163.0, 159.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 100.0, 95.0, 77.0, 73.0, 75.0, 100.0, 95.0, 70.0], "unit": "score", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 143.0, 95.0, 95.0, 95.0, 141.0, 96.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 57.0, 55.0, 56.0, 55.0, 57.0, 65.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [79.0, 82.0, 81.0, 82.0, 82.0, 81.0, 82.0, 81.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.5}, {"lowerIsBetter": true, "replicates": [121.0, 111.0, 125.0, 129.0, 112.0, 116.0, 115.0, 117.0, 115.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.4}, {"lowerIsBetter": true, "replicates": [147.0, 139.0, 143.0, 145.0, 143.0, 136.0, 144.0, 144.0, 145.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 70.0, 67.0, 67.0, 68.0, 68.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1489.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.59032952475576], "unit": "score", "name": "Richards", "value": 213.18877800000007}, {"lowerIsBetter": false, "replicates": [188.89308651303364], "unit": "score", "name": "DeltaBlue", "value": 350.02869200000004}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [762.1951219512196], "unit": "score", "name": "Earley", "value": 874.3994559999996}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [41600.0], "unit": "score", "name": "RegExp", "value": 21.898677884615388}, {"lowerIsBetter": false, "replicates": [574.9427917620137], "unit": "score", "name": "Splay", "value": 141.73758009950245}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19124.5291758473}]} 10:21:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "19124.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1489.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6765.15"}}} 10:21:40 INFO - Return code: 0 10:21:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:21:40 INFO - # TBPL SUCCESS # 10:21:40 INFO - Running post-action listener: _resource_record_post_action 10:21:40 INFO - Running post-run listener: _resource_record_post_run 10:21:41 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 495616; Write bytes: 323330048; Read time: 224; Write time: 200356 10:21:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 23244800; Read time: 0; Write time: 6592 10:21:41 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 495616; Write bytes: 299220992; Read time: 224; Write time: 193724 10:21:41 INFO - Running post-run listener: _upload_blobber_files 10:21:41 INFO - Blob upload gear active. 10:21:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:21:41 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:41 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:41 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:42 INFO - (blobuploader) - INFO - Open directory for files ... 10:21:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 10:21:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:21:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:43 INFO - (blobuploader) - INFO - Done attempting. 10:21:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:21:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:21:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:43 INFO - (blobuploader) - INFO - Done attempting. 10:21:43 INFO - (blobuploader) - INFO - Iteration through files over. 10:21:43 INFO - Return code: 0 10:21:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:21:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:21:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6cfea523d77415bcc4005874a50e0ea60a96176fd8d2e0d789539aecf51d1b718d14b90145aa8e31615e61f35da6b72ce637c4379b930c199ef0f99ae44fac3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48939ca1688eea613647525ed397dd05b64de1d2cee2e944b31a1d4215744b87ebf1596218381098407d75db9b11d2764eb0355c23615f5f7a910ebd70c0ccb9"} 10:21:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:21:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:21:43 INFO - Contents: 10:21:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6cfea523d77415bcc4005874a50e0ea60a96176fd8d2e0d789539aecf51d1b718d14b90145aa8e31615e61f35da6b72ce637c4379b930c199ef0f99ae44fac3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48939ca1688eea613647525ed397dd05b64de1d2cee2e944b31a1d4215744b87ebf1596218381098407d75db9b11d2764eb0355c23615f5f7a910ebd70c0ccb9"} 10:21:43 INFO - Running post-run listener: copy_logs_to_upload_dir 10:21:43 INFO - Copying logs to upload dir... 10:21:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:21:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1295.452279 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-01-15 10:21:43.826545) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 10:21:43.830053) ========= 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=0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6cfea523d77415bcc4005874a50e0ea60a96176fd8d2e0d789539aecf51d1b718d14b90145aa8e31615e61f35da6b72ce637c4379b930c199ef0f99ae44fac3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48939ca1688eea613647525ed397dd05b64de1d2cee2e944b31a1d4215744b87ebf1596218381098407d75db9b11d2764eb0355c23615f5f7a910ebd70c0ccb9"} 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.011436 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6cfea523d77415bcc4005874a50e0ea60a96176fd8d2e0d789539aecf51d1b718d14b90145aa8e31615e61f35da6b72ce637c4379b930c199ef0f99ae44fac3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48939ca1688eea613647525ed397dd05b64de1d2cee2e944b31a1d4215744b87ebf1596218381098407d75db9b11d2764eb0355c23615f5f7a910ebd70c0ccb9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 10:21:43.857115) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:21:43.857767) ========= 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=0274524eba3bdaad075c2247000001d4-1452876119.740165-795101922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:21:43.942000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 10:21:43.942739) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 10:21:43.943367) ========= ========= Total master_lag: 0.55 =========