builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1451520204.59 results: success (0) buildid: 20151230133836 builduid: 3ce91322b7e4426eb46210a66e3b973f revision: 839dd566125d53b477bcd3838c33ac824d06dced ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.586307) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.587092) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.587400) ========= 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=a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006351 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.614573) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.614881) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.631407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.631753) ========= 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=a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.680563) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.680844) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.681237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.681508) ========= 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=a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 16:03:24-- 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% 40.4M=0s 2015-12-30 16:03:25 (40.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170587 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.864657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.864972) ========= 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=a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016796 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.915255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:24.915610) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 839dd566125d53b477bcd3838c33ac824d06dced --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 839dd566125d53b477bcd3838c33ac824d06dced --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=a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 16:03:25,274 truncating revision to first 12 chars 2015-12-30 16:03:25,274 Setting DEBUG logging. 2015-12-30 16:03:25,274 attempt 1/10 2015-12-30 16:03:25,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/839dd566125d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 16:03:25,526 unpacking tar archive at: mozilla-aurora-839dd566125d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531765 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:25.461875) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:25.462159) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:25.474326) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:25.474574) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:25.474963) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-30 16:03:25.475260) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:03:25 INFO - MultiFileLogger online at 20151230 16:03:25 in /builds/slave/test-pgo 16:03:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:03:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:03:25 INFO - {'append_to_log': False, 16:03:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:03:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:03:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:03:25 INFO - 'branch': 'Mozilla-Aurora', 16:03:25 INFO - 'buildbot_json_path': 'buildprops.json', 16:03:25 INFO - 'config_files': ('talos/linux_config.py',), 16:03:25 INFO - 'default_actions': ('clobber', 16:03:25 INFO - 'read-buildbot-config', 16:03:25 INFO - 'download-and-extract', 16:03:25 INFO - 'populate-webroot', 16:03:25 INFO - 'create-virtualenv', 16:03:25 INFO - 'install', 16:03:25 INFO - 'run-tests'), 16:03:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:03:25 INFO - 'download_minidump_stackwalk': True, 16:03:25 INFO - 'download_symbols': 'ondemand', 16:03:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:03:25 INFO - 'tooltool.py': '/tools/tooltool.py', 16:03:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:03:25 INFO - '/tools/misc-python/virtualenv.py')}, 16:03:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:03:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:03:25 INFO - 'installer_path': 'installer.exe', 16:03:25 INFO - 'log_level': 'info', 16:03:25 INFO - 'log_name': 'talos', 16:03:25 INFO - 'log_to_console': True, 16:03:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:03:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:03:25 INFO - 'opt_config_files': (), 16:03:25 INFO - 'pip_index': False, 16:03:25 INFO - 'sps_profile': False, 16:03:25 INFO - 'sps_profile_interval': 0, 16:03:25 INFO - 'suite': 'dromaeojs', 16:03:25 INFO - 'system_bits': '32', 16:03:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:03:25 INFO - 'title': 'talos-linux64-ix-026', 16:03:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:03:25 INFO - 'use_talos_json': True, 16:03:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:03:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:03:25 INFO - 'work_dir': 'build'} 16:03:25 INFO - ##### 16:03:25 INFO - ##### Running clobber step. 16:03:25 INFO - ##### 16:03:25 INFO - Running pre-action listener: _resource_record_pre_action 16:03:25 INFO - Running main action method: clobber 16:03:25 INFO - rmtree: /builds/slave/test-pgo/build 16:03:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:03:26 INFO - Running post-action listener: _resource_record_post_action 16:03:26 INFO - ##### 16:03:26 INFO - ##### Running read-buildbot-config step. 16:03:26 INFO - ##### 16:03:26 INFO - Running pre-action listener: _resource_record_pre_action 16:03:26 INFO - Running main action method: read_buildbot_config 16:03:26 INFO - Using buildbot properties: 16:03:26 INFO - { 16:03:26 INFO - "properties": { 16:03:26 INFO - "buildnumber": 162, 16:03:26 INFO - "product": "firefox", 16:03:26 INFO - "script_repo_revision": "production", 16:03:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:03:26 INFO - "repository": "", 16:03:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:03:26 INFO - "buildid": "20151230133836", 16:03:26 INFO - "slavename": "talos-linux64-ix-026", 16:03:26 INFO - "pgo_build": "True", 16:03:26 INFO - "basedir": "/builds/slave/test-pgo", 16:03:26 INFO - "project": "", 16:03:26 INFO - "platform": "ubuntu64_hw", 16:03:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:03:26 INFO - "slavebuilddir": "test", 16:03:26 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:03:26 INFO - "branch": "mozilla-aurora", 16:03:26 INFO - "repo_path": "releases/mozilla-aurora", 16:03:26 INFO - "stage_platform": "linux64-pgo", 16:03:26 INFO - "builduid": "3ce91322b7e4426eb46210a66e3b973f", 16:03:26 INFO - "revision": "839dd566125d53b477bcd3838c33ac824d06dced" 16:03:26 INFO - }, 16:03:26 INFO - "sourcestamp": { 16:03:26 INFO - "repository": "", 16:03:26 INFO - "hasPatch": false, 16:03:26 INFO - "project": "", 16:03:26 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:03:26 INFO - "changes": [ 16:03:26 INFO - { 16:03:26 INFO - "category": null, 16:03:26 INFO - "files": [ 16:03:26 INFO - { 16:03:26 INFO - "url": null, 16:03:26 INFO - "name": "https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 16:03:26 INFO - } 16:03:26 INFO - ], 16:03:26 INFO - "repository": "", 16:03:26 INFO - "rev": "839dd566125d53b477bcd3838c33ac824d06dced", 16:03:26 INFO - "who": "dholbert@mozilla.com", 16:03:26 INFO - "when": 1451520185, 16:03:26 INFO - "number": 7404801, 16:03:26 INFO - "comments": "Bug 1204897: Attempt to work around randomorange in test_bug332655-1.html by using an unthemed widget. r=jfkthame a=testonly", 16:03:26 INFO - "project": "", 16:03:26 INFO - "at": "Wed 30 Dec 2015 16:03:05", 16:03:26 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:03:26 INFO - "revlink": "", 16:03:26 INFO - "properties": [ 16:03:26 INFO - [ 16:03:26 INFO - "buildid", 16:03:26 INFO - "20151230133836", 16:03:26 INFO - "Change" 16:03:26 INFO - ], 16:03:26 INFO - [ 16:03:26 INFO - "builduid", 16:03:26 INFO - "3ce91322b7e4426eb46210a66e3b973f", 16:03:26 INFO - "Change" 16:03:26 INFO - ], 16:03:26 INFO - [ 16:03:26 INFO - "pgo_build", 16:03:26 INFO - "True", 16:03:26 INFO - "Change" 16:03:26 INFO - ] 16:03:26 INFO - ], 16:03:26 INFO - "revision": "839dd566125d53b477bcd3838c33ac824d06dced" 16:03:26 INFO - } 16:03:26 INFO - ], 16:03:26 INFO - "revision": "839dd566125d53b477bcd3838c33ac824d06dced" 16:03:26 INFO - } 16:03:26 INFO - } 16:03:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 16:03:26 INFO - Running post-action listener: _resource_record_post_action 16:03:26 INFO - ##### 16:03:26 INFO - ##### Running download-and-extract step. 16:03:26 INFO - ##### 16:03:26 INFO - Running pre-action listener: _resource_record_pre_action 16:03:26 INFO - Running main action method: download_and_extract 16:03:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:03:26 INFO - https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:03:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/test_packages.json 16:03:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/test_packages.json 16:03:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:03:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:03:30 INFO - Downloaded 1302 bytes. 16:03:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:03:30 INFO - Using the following test package requirements: 16:03:30 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:03:30 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:03:30 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:03:30 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:03:30 INFO - u'jsshell-linux-x86_64.zip'], 16:03:30 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:03:30 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:03:30 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:03:30 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:03:30 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:03:30 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:03:30 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:03:30 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:03:30 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:03:30 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:03:30 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:03:30 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:03:30 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:03:30 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')]} 16:03:30 INFO - https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:03:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:03:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:03:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:03:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:03:31 INFO - Downloaded 23023515 bytes. 16:03:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:03:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:03:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:03:32 INFO - Return code: 0 16:03:32 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:03:32 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')]} 16:03:32 INFO - https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:03:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:03:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:03:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:03:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:03:33 INFO - Downloaded 23023515 bytes. 16:03:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:03:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:03:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:03:34 INFO - Return code: 0 16:03:34 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')]} 16:03:34 INFO - https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:03:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:03:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:03:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:03:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:03:36 INFO - Downloaded 11132038 bytes. 16:03:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:03:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:03:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:03:36 INFO - Return code: 0 16:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:03:36 INFO - https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:03:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:03:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:03:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:03:38 INFO - Downloaded 58079339 bytes. 16:03:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:03:38 INFO - mkdir: /builds/slave/test-pgo/properties 16:03:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:03:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:03:38 INFO - Contents: 16:03:38 INFO - build_url:https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:03:38 INFO - Running post-action listener: _resource_record_post_action 16:03:38 INFO - Running post-action listener: set_extra_try_arguments 16:03:38 INFO - ##### 16:03:38 INFO - ##### Running populate-webroot step. 16:03:38 INFO - ##### 16:03:38 INFO - Running pre-action listener: _resource_record_pre_action 16:03:38 INFO - Running main action method: populate_webroot 16:03:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:03:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:03:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:03:38 INFO - '--tppagecycles', 16:03:38 INFO - '7'], 16:03:38 INFO - 'tests': ['tsvgm']}}, 16:03:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:03:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:03:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:03:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:03:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:03:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:03:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:03:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:38 INFO - 'talos_options': ['--e10s'], 16:03:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:03:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:38 INFO - 'tests': ['damp', 'tps']}, 16:03:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:38 INFO - 'talos_options': ['--e10s'], 16:03:38 INFO - 'tests': ['damp', 'tps']}, 16:03:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:03:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:03:38 INFO - 'other': {'tests': ['a11yr', 16:03:38 INFO - 'ts_paint', 16:03:38 INFO - 'tpaint', 16:03:38 INFO - 'sessionrestore', 16:03:38 INFO - 'sessionrestore_no_auto_restore']}, 16:03:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:03:38 INFO - 'tests': ['a11yr', 16:03:38 INFO - 'ts_paint', 16:03:38 INFO - 'tpaint', 16:03:38 INFO - 'sessionrestore', 16:03:38 INFO - 'sessionrestore_no_auto_restore']}, 16:03:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:03:38 INFO - 'tests': ['a11yr', 16:03:38 INFO - 'ts_paint', 16:03:38 INFO - 'tpaint', 16:03:38 INFO - 'sessionrestore', 16:03:38 INFO - 'sessionrestore_no_auto_restore']}, 16:03:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:03:38 INFO - 'tests': ['a11yr', 16:03:38 INFO - 'ts_paint', 16:03:38 INFO - 'tpaint', 16:03:38 INFO - 'sessionrestore', 16:03:38 INFO - 'sessionrestore_no_auto_restore']}, 16:03:38 INFO - 'other_l64': {'tests': ['a11yr', 16:03:38 INFO - 'ts_paint', 16:03:38 INFO - 'tpaint', 16:03:38 INFO - 'sessionrestore', 16:03:38 INFO - 'sessionrestore_no_auto_restore']}, 16:03:38 INFO - 'other_nol64': {'tests': ['a11yr', 16:03:38 INFO - 'ts_paint', 16:03:38 INFO - 'tpaint', 16:03:38 INFO - 'sessionrestore', 16:03:38 INFO - 'sessionrestore_no_auto_restore']}, 16:03:38 INFO - 'svgr': {'tests': ['tsvgx', 16:03:38 INFO - 'tsvgr_opacity', 16:03:38 INFO - 'tart', 16:03:38 INFO - 'tscrollx', 16:03:38 INFO - 'cart']}, 16:03:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:03:38 INFO - 'tests': ['tsvgx', 16:03:38 INFO - 'tsvgr_opacity', 16:03:38 INFO - 'tart', 16:03:38 INFO - 'tscrollx', 16:03:38 INFO - 'cart']}, 16:03:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:38 INFO - 'tests': ['tp5o']}, 16:03:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:38 INFO - 'talos_options': ['--e10s'], 16:03:38 INFO - 'tests': ['tp5o']}, 16:03:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:38 INFO - 'talos_options': ['--xperf_path', 16:03:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:03:38 INFO - 'tests': ['tp5n']}, 16:03:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:38 INFO - 'talos_options': ['--e10s', 16:03:38 INFO - '--xperf_path', 16:03:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:03:38 INFO - 'tests': ['tp5n']}}, 16:03:38 INFO - 'talos.zip': {'path': '', 16:03:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:03:38 INFO - Running post-action listener: _resource_record_post_action 16:03:38 INFO - ##### 16:03:38 INFO - ##### Running create-virtualenv step. 16:03:38 INFO - ##### 16:03:38 INFO - Running pre-action listener: _resource_record_pre_action 16:03:38 INFO - Running main action method: create_virtualenv 16:03:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:03:38 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 16:03:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:03:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:03:38 INFO - Using real prefix '/usr' 16:03:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:03:39 INFO - Installing distribute.............................................................................................................................................................................................done. 16:03:41 INFO - Installing pip.................done. 16:03:41 INFO - Return code: 0 16:03:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:41 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 0x7f7f9e012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229350>, '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 0x222a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a6e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', '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 16:03:41 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 16:03:41 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 16:03:41 INFO - Using env: {'DISPLAY': ':0', 16:03:41 INFO - 'HOME': '/home/cltbld', 16:03:41 INFO - 'LANG': 'en_US.UTF-8', 16:03:41 INFO - 'LANGUAGE': 'en_US:en', 16:03:41 INFO - 'LOGNAME': 'cltbld', 16:03:41 INFO - 'MAIL': '/var/mail/cltbld', 16:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:41 INFO - 'MOZ_NO_REMOTE': '1', 16:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:41 INFO - 'NO_EM_RESTART': '1', 16:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:03:41 INFO - 'PWD': '/builds/slave/test-pgo', 16:03:41 INFO - 'SHELL': '/bin/bash', 16:03:41 INFO - 'SHLVL': '1', 16:03:41 INFO - 'TERM': 'linux', 16:03:41 INFO - 'TMOUT': '86400', 16:03:41 INFO - 'USER': 'cltbld', 16:03:41 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', 16:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:41 INFO - '_': '/tools/buildbot/bin/python'} 16:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:41 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 16:03:41 INFO - Cleaning up... 16:03:41 INFO - Return code: 0 16:03:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:41 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 0x7f7f9e012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229350>, '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 0x222a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a6e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', '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 16:03:41 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 16:03:41 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 16:03:41 INFO - Using env: {'DISPLAY': ':0', 16:03:41 INFO - 'HOME': '/home/cltbld', 16:03:41 INFO - 'LANG': 'en_US.UTF-8', 16:03:41 INFO - 'LANGUAGE': 'en_US:en', 16:03:41 INFO - 'LOGNAME': 'cltbld', 16:03:41 INFO - 'MAIL': '/var/mail/cltbld', 16:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:41 INFO - 'MOZ_NO_REMOTE': '1', 16:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:41 INFO - 'NO_EM_RESTART': '1', 16:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:03:41 INFO - 'PWD': '/builds/slave/test-pgo', 16:03:41 INFO - 'SHELL': '/bin/bash', 16:03:41 INFO - 'SHLVL': '1', 16:03:41 INFO - 'TERM': 'linux', 16:03:41 INFO - 'TMOUT': '86400', 16:03:41 INFO - 'USER': 'cltbld', 16:03:41 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', 16:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:41 INFO - '_': '/tools/buildbot/bin/python'} 16:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:41 INFO - Downloading/unpacking psutil>=0.7.1 16:03:41 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 16:03:41 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 16:03:41 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 16:03:41 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 16:03:41 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 16:03:41 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 16:03:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:03:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:03:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:03:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:03:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:03:43 INFO - Installing collected packages: psutil 16:03:43 INFO - Running setup.py install for psutil 16:03:43 INFO - building 'psutil._psutil_linux' extension 16:03:43 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 16:03:43 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 16:03:43 INFO - building 'psutil._psutil_posix' extension 16:03:43 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 16:03:43 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 16:03:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:03:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:03:43 INFO - Successfully installed psutil 16:03:43 INFO - Cleaning up... 16:03:43 INFO - Return code: 0 16:03:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:03:43 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')]} 16:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:43 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')]} 16:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:43 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 0x7f7f9e012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229350>, '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 0x222a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a6e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', '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 16:03:43 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 16:03:43 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 16:03:43 INFO - Using env: {'DISPLAY': ':0', 16:03:43 INFO - 'HOME': '/home/cltbld', 16:03:43 INFO - 'LANG': 'en_US.UTF-8', 16:03:43 INFO - 'LANGUAGE': 'en_US:en', 16:03:43 INFO - 'LOGNAME': 'cltbld', 16:03:43 INFO - 'MAIL': '/var/mail/cltbld', 16:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:43 INFO - 'MOZ_NO_REMOTE': '1', 16:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:43 INFO - 'NO_EM_RESTART': '1', 16:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:03:43 INFO - 'PWD': '/builds/slave/test-pgo', 16:03:43 INFO - 'SHELL': '/bin/bash', 16:03:43 INFO - 'SHLVL': '1', 16:03:43 INFO - 'TERM': 'linux', 16:03:43 INFO - 'TMOUT': '86400', 16:03:43 INFO - 'USER': 'cltbld', 16:03:43 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', 16:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:43 INFO - '_': '/tools/buildbot/bin/python'} 16:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:03:44 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 16:03:44 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 16:03:44 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 16:03:44 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 16:03:44 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 16:03:44 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 16:03:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:03:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:03:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:03:45 INFO - Installing collected packages: mozsystemmonitor 16:03:45 INFO - Running setup.py install for mozsystemmonitor 16:03:45 INFO - Successfully installed mozsystemmonitor 16:03:45 INFO - Cleaning up... 16:03:46 INFO - Return code: 0 16:03:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:03:46 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')]} 16:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:46 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')]} 16:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:46 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 0x7f7f9e012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229350>, '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 0x222a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a6e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', '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 16:03:46 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 16:03:46 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 16:03:46 INFO - Using env: {'DISPLAY': ':0', 16:03:46 INFO - 'HOME': '/home/cltbld', 16:03:46 INFO - 'LANG': 'en_US.UTF-8', 16:03:46 INFO - 'LANGUAGE': 'en_US:en', 16:03:46 INFO - 'LOGNAME': 'cltbld', 16:03:46 INFO - 'MAIL': '/var/mail/cltbld', 16:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:46 INFO - 'MOZ_NO_REMOTE': '1', 16:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:46 INFO - 'NO_EM_RESTART': '1', 16:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:03:46 INFO - 'PWD': '/builds/slave/test-pgo', 16:03:46 INFO - 'SHELL': '/bin/bash', 16:03:46 INFO - 'SHLVL': '1', 16:03:46 INFO - 'TERM': 'linux', 16:03:46 INFO - 'TMOUT': '86400', 16:03:46 INFO - 'USER': 'cltbld', 16:03:46 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', 16:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:46 INFO - '_': '/tools/buildbot/bin/python'} 16:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:46 INFO - Downloading/unpacking blobuploader==1.2.4 16:03:46 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 16:03:46 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 16:03:46 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 16:03:46 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 16:03:46 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 16:03:46 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 16:03:47 INFO - Downloading blobuploader-1.2.4.tar.gz 16:03:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:03:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:03:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:03:47 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 16:03:47 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 16:03:47 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 16:03:47 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 16:03:47 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 16:03:47 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 16:03:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:03:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:03:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:03:48 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 16:03:48 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 16:03:48 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 16:03:48 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 16:03:48 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 16:03:48 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 16:03:48 INFO - Downloading docopt-0.6.1.tar.gz 16:03:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:03:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:03:48 INFO - Installing collected packages: blobuploader, requests, docopt 16:03:48 INFO - Running setup.py install for blobuploader 16:03:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:03:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:03:48 INFO - Running setup.py install for requests 16:03:49 INFO - Running setup.py install for docopt 16:03:49 INFO - Successfully installed blobuploader requests docopt 16:03:49 INFO - Cleaning up... 16:03:49 INFO - Return code: 0 16:03:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:49 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 0x7f7f9e012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229350>, '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 0x222a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a6e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', '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 16:03:49 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 16:03:49 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 16:03:49 INFO - Using env: {'DISPLAY': ':0', 16:03:49 INFO - 'HOME': '/home/cltbld', 16:03:49 INFO - 'LANG': 'en_US.UTF-8', 16:03:49 INFO - 'LANGUAGE': 'en_US:en', 16:03:49 INFO - 'LOGNAME': 'cltbld', 16:03:49 INFO - 'MAIL': '/var/mail/cltbld', 16:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:49 INFO - 'MOZ_NO_REMOTE': '1', 16:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:49 INFO - 'NO_EM_RESTART': '1', 16:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:03:49 INFO - 'PWD': '/builds/slave/test-pgo', 16:03:49 INFO - 'SHELL': '/bin/bash', 16:03:49 INFO - 'SHLVL': '1', 16:03:49 INFO - 'TERM': 'linux', 16:03:49 INFO - 'TMOUT': '86400', 16:03:49 INFO - 'USER': 'cltbld', 16:03:49 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', 16:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:49 INFO - '_': '/tools/buildbot/bin/python'} 16:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:03:49 INFO - Running setup.py (path:/tmp/pip-MbixXz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:03:49 INFO - Running setup.py (path:/tmp/pip-WExg8q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:03:49 INFO - Running setup.py (path:/tmp/pip-wq1XnG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:03:49 INFO - Running setup.py (path:/tmp/pip-QRP907-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:03:49 INFO - Running setup.py (path:/tmp/pip-SqB7Ag-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:03:49 INFO - Running setup.py (path:/tmp/pip-mNtNXr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:03:49 INFO - Running setup.py (path:/tmp/pip-g6FRkG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:03:49 INFO - Running setup.py (path:/tmp/pip-jf02Gj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:03:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:03:50 INFO - Running setup.py (path:/tmp/pip-XrJx65-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:03:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:03:50 INFO - Running setup.py (path:/tmp/pip-YXM_BS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:03:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:03:50 INFO - Running setup.py (path:/tmp/pip-yaA0vA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:03:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:03:50 INFO - Running setup.py (path:/tmp/pip-5nKBQn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:03:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:03:50 INFO - Running setup.py (path:/tmp/pip-rtwZll-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:03:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:03:50 INFO - Running setup.py (path:/tmp/pip-y2qJc_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:03:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:03:50 INFO - Running setup.py (path:/tmp/pip-yLJxVS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:03:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:03:50 INFO - Running setup.py (path:/tmp/pip-b1dPVY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:03:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:03:50 INFO - Running setup.py (path:/tmp/pip-lguZ9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:03:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:03:50 INFO - Running setup.py install for manifestparser 16:03:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:03:50 INFO - Running setup.py install for mozcrash 16:03:50 INFO - Running setup.py install for mozdebug 16:03:50 INFO - Running setup.py install for mozdevice 16:03:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:03:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:03:51 INFO - Running setup.py install for mozfile 16:03:51 INFO - Running setup.py install for mozhttpd 16:03:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:03:51 INFO - Running setup.py install for mozinfo 16:03:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:03:51 INFO - Running setup.py install for mozInstall 16:03:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:03:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:03:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:03:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:03:51 INFO - Running setup.py install for mozleak 16:03:51 INFO - Running setup.py install for mozlog 16:03:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:03:51 INFO - Running setup.py install for moznetwork 16:03:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:03:51 INFO - Running setup.py install for mozprocess 16:03:51 INFO - Running setup.py install for mozprofile 16:03:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:03:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:03:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:03:52 INFO - Running setup.py install for mozrunner 16:03:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:03:52 INFO - Running setup.py install for mozscreenshot 16:03:52 INFO - Running setup.py install for moztest 16:03:52 INFO - Running setup.py install for mozversion 16:03:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:03:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:03:52 INFO - Cleaning up... 16:03:52 INFO - Return code: 0 16:03:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f7f9e012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229350>, '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 0x222a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a6e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', '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 16:03:52 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 16:03:52 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 16:03:52 INFO - Using env: {'DISPLAY': ':0', 16:03:52 INFO - 'HOME': '/home/cltbld', 16:03:52 INFO - 'LANG': 'en_US.UTF-8', 16:03:52 INFO - 'LANGUAGE': 'en_US:en', 16:03:52 INFO - 'LOGNAME': 'cltbld', 16:03:52 INFO - 'MAIL': '/var/mail/cltbld', 16:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:52 INFO - 'MOZ_NO_REMOTE': '1', 16:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:52 INFO - 'NO_EM_RESTART': '1', 16:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:03:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:03:52 INFO - 'SHELL': '/bin/bash', 16:03:52 INFO - 'SHLVL': '1', 16:03:52 INFO - 'TERM': 'linux', 16:03:52 INFO - 'TMOUT': '86400', 16:03:52 INFO - 'USER': 'cltbld', 16:03:52 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', 16:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:52 INFO - '_': '/tools/buildbot/bin/python'} 16:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:03:52 INFO - Running setup.py (path:/tmp/pip-VGGYUQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:03:52 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)) 16:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:03:52 INFO - Running setup.py (path:/tmp/pip-eJaZ0B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:03:52 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)) 16:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:03:52 INFO - Running setup.py (path:/tmp/pip-Dp9ks9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:03:52 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)) 16:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:03:52 INFO - Running setup.py (path:/tmp/pip-EiqQOm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:03:52 INFO - Running setup.py (path:/tmp/pip-ly3iOv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:03:53 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)) 16:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:03:53 INFO - Running setup.py (path:/tmp/pip-4ZzMuS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:03:53 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)) 16:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:03:53 INFO - Running setup.py (path:/tmp/pip-5zUOZ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:03:53 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)) 16:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:03:53 INFO - Running setup.py (path:/tmp/pip-sx2N2o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:03:53 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)) 16:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:03:53 INFO - Running setup.py (path:/tmp/pip-m1yYWb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:03:53 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)) 16:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:03:53 INFO - Running setup.py (path:/tmp/pip-LKrGQ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:03:53 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)) 16:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:03:53 INFO - Running setup.py (path:/tmp/pip-pCeYKl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:03:53 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)) 16:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:03:53 INFO - Running setup.py (path:/tmp/pip-5g4FMm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:03:53 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)) 16:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:03:53 INFO - Running setup.py (path:/tmp/pip-PEc89_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 16:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:03:53 INFO - Running setup.py (path:/tmp/pip-LFin1I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:03:53 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)) 16:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:03:53 INFO - Running setup.py (path:/tmp/pip-NTCTfP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:03:53 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)) 16:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:03:53 INFO - Running setup.py (path:/tmp/pip-ey1cOa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:03:53 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)) 16:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:03:53 INFO - Running setup.py (path:/tmp/pip-EdXgbz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:03:53 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)) 16:03:53 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)) 16:03:53 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)) 16:03:53 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)) 16:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:03:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:03:53 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 16:03:53 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 16:03:53 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 16:03:53 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 16:03:53 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 16:03:53 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 16:03:55 INFO - Downloading blessings-1.5.1.tar.gz 16:03:55 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 16:03:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:03:55 INFO - Installing collected packages: blessings 16:03:55 INFO - Running setup.py install for blessings 16:03:55 INFO - Successfully installed blessings 16:03:55 INFO - Cleaning up... 16:03:55 INFO - Return code: 0 16:03:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:03:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:03:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:03:56 INFO - Reading from file tmpfile_stdout 16:03:56 INFO - Current package versions: 16:03:56 INFO - argparse == 1.2.1 16:03:56 INFO - blessings == 1.5.1 16:03:56 INFO - blobuploader == 1.2.4 16:03:56 INFO - docopt == 0.6.1 16:03:56 INFO - manifestparser == 1.1 16:03:56 INFO - mozInstall == 1.12 16:03:56 INFO - mozcrash == 0.16 16:03:56 INFO - mozdebug == 0.1 16:03:56 INFO - mozdevice == 0.47 16:03:56 INFO - mozfile == 1.2 16:03:56 INFO - mozhttpd == 0.7 16:03:56 INFO - mozinfo == 0.9 16:03:56 INFO - mozleak == 0.1 16:03:56 INFO - mozlog == 3.1 16:03:56 INFO - moznetwork == 0.27 16:03:56 INFO - mozprocess == 0.22 16:03:56 INFO - mozprofile == 0.27 16:03:56 INFO - mozrunner == 6.11 16:03:56 INFO - mozscreenshot == 0.1 16:03:56 INFO - mozsystemmonitor == 0.0 16:03:56 INFO - moztest == 0.7 16:03:56 INFO - mozversion == 1.4 16:03:56 INFO - psutil == 3.1.1 16:03:56 INFO - requests == 1.2.3 16:03:56 INFO - wsgiref == 0.1.2 16:03:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:03: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')]} 16:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03: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')]} 16:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03: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', '-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 0x7f7f9e012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229350>, '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 0x222a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a6e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', '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 16:03:56 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 16:03:56 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 16:03:56 INFO - Using env: {'DISPLAY': ':0', 16:03:56 INFO - 'HOME': '/home/cltbld', 16:03:56 INFO - 'LANG': 'en_US.UTF-8', 16:03:56 INFO - 'LANGUAGE': 'en_US:en', 16:03:56 INFO - 'LOGNAME': 'cltbld', 16:03:56 INFO - 'MAIL': '/var/mail/cltbld', 16:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:56 INFO - 'MOZ_NO_REMOTE': '1', 16:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:56 INFO - 'NO_EM_RESTART': '1', 16:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:03:56 INFO - 'PWD': '/builds/slave/test-pgo', 16:03:56 INFO - 'SHELL': '/bin/bash', 16:03:56 INFO - 'SHLVL': '1', 16:03:56 INFO - 'TERM': 'linux', 16:03:56 INFO - 'TMOUT': '86400', 16:03:56 INFO - 'USER': 'cltbld', 16:03:56 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', 16:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:56 INFO - '_': '/tools/buildbot/bin/python'} 16:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:56 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 1)) 16:03:56 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 2)) 16:03:56 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 3)) 16:03:56 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 4)) 16:03:56 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 5)) 16:03:56 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 6)) 16:03:56 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 7)) 16:03:56 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 8)) 16:03:56 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:03:56 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 3)) 16:03:56 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:03:56 INFO - Cleaning up... 16:03:56 INFO - Return code: 0 16:03:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:03: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')]} 16:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03: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')]} 16:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f9e012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229350>, '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 0x222a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a6e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', '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 16:03: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', 'jsonschema'] in /builds/slave/test-pgo/build 16:03: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 jsonschema 16:03:56 INFO - Using env: {'DISPLAY': ':0', 16:03:56 INFO - 'HOME': '/home/cltbld', 16:03:56 INFO - 'LANG': 'en_US.UTF-8', 16:03:56 INFO - 'LANGUAGE': 'en_US:en', 16:03:56 INFO - 'LOGNAME': 'cltbld', 16:03:56 INFO - 'MAIL': '/var/mail/cltbld', 16:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:56 INFO - 'MOZ_NO_REMOTE': '1', 16:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:56 INFO - 'NO_EM_RESTART': '1', 16:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:03:56 INFO - 'PWD': '/builds/slave/test-pgo', 16:03:56 INFO - 'SHELL': '/bin/bash', 16:03:56 INFO - 'SHLVL': '1', 16:03:56 INFO - 'TERM': 'linux', 16:03:56 INFO - 'TMOUT': '86400', 16:03:56 INFO - 'USER': 'cltbld', 16:03:56 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', 16:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:56 INFO - '_': '/tools/buildbot/bin/python'} 16:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:56 INFO - Downloading/unpacking jsonschema 16:03: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 16:03: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 16:03: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 16:03: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 16:03: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 16:03: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 16:03:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:03:58 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 16:03:58 INFO - Downloading/unpacking functools32 (from jsonschema) 16:03: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 16:03: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 16:03: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 16:03: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 16:03: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 16:03: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 16:03:58 INFO - Downloading functools32-3.2.3-2.tar.gz 16:03:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:03:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:03:58 INFO - warning: no files found matching '*.txt' 16:03:58 INFO - no previously-included directories found matching 'build' 16:03:58 INFO - no previously-included directories found matching 'dist' 16:03:58 INFO - no previously-included directories found matching '.git*' 16:03:58 INFO - Installing collected packages: jsonschema, functools32 16:03:58 INFO - Running setup.py install for functools32 16:03:58 INFO - warning: no files found matching '*.txt' 16:03:58 INFO - no previously-included directories found matching 'build' 16:03:58 INFO - no previously-included directories found matching 'dist' 16:03:58 INFO - no previously-included directories found matching '.git*' 16:03:58 INFO - Successfully installed jsonschema functools32 16:03:58 INFO - Cleaning up... 16:03:58 INFO - Return code: 0 16:03:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:03:58 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')]} 16:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:58 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')]} 16:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:58 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 0x7f7f9e012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229350>, '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 0x222a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a6e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', '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 16:03:58 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 16:03:58 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 16:03:58 INFO - Using env: {'DISPLAY': ':0', 16:03:58 INFO - 'HOME': '/home/cltbld', 16:03:58 INFO - 'LANG': 'en_US.UTF-8', 16:03:58 INFO - 'LANGUAGE': 'en_US:en', 16:03:58 INFO - 'LOGNAME': 'cltbld', 16:03:58 INFO - 'MAIL': '/var/mail/cltbld', 16:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:58 INFO - 'MOZ_NO_REMOTE': '1', 16:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:58 INFO - 'NO_EM_RESTART': '1', 16:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:03:58 INFO - 'PWD': '/builds/slave/test-pgo', 16:03:58 INFO - 'SHELL': '/bin/bash', 16:03:58 INFO - 'SHLVL': '1', 16:03:58 INFO - 'TERM': 'linux', 16:03:58 INFO - 'TMOUT': '86400', 16:03:58 INFO - 'USER': 'cltbld', 16:03:58 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', 16:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:58 INFO - '_': '/tools/buildbot/bin/python'} 16:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:58 INFO - Downloading/unpacking flake8 16:03: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 16:03: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 16:03: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 16:03: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 16:03: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 16:03: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 16:04:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:04:00 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 16:04:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:04:00 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 16:04:00 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 16:04:00 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 16:04:00 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 16:04:00 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 16:04:00 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 16:04:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:04:00 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 16:04:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:04:00 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 16:04:00 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 16:04:00 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 16:04:00 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 16:04:00 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 16:04:00 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 16:04:00 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 16:04:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:04:00 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 16:04:00 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 16:04:00 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 16:04:00 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 16:04:00 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 16:04:00 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 16:04:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:04:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:04:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:04:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:04:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:04:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:04:01 INFO - no previously-included directories found matching 'docs/_build' 16:04:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:04:01 INFO - Running setup.py install for pep8 16:04:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:04:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:04:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:04:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:04:01 INFO - no previously-included directories found matching 'docs/_build' 16:04:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:04:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:04:01 INFO - Cleaning up... 16:04:01 INFO - Return code: 0 16:04:01 INFO - Running post-action listener: _resource_record_post_action 16:04:01 INFO - Running post-action listener: _start_resource_monitoring 16:04:01 INFO - Starting resource monitoring. 16:04:01 INFO - ##### 16:04:01 INFO - ##### Running install step. 16:04:01 INFO - ##### 16:04:01 INFO - Running pre-action listener: _resource_record_pre_action 16:04:01 INFO - Running main action method: install 16:04:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:04:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:04:01 INFO - Reading from file tmpfile_stdout 16:04:01 INFO - Detecting whether we're running mozinstall >=1.0... 16:04:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:04:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:04:01 INFO - Reading from file tmpfile_stdout 16:04:01 INFO - Output received: 16:04:01 INFO - Usage: mozinstall [options] installer 16:04:01 INFO - Options: 16:04:01 INFO - -h, --help show this help message and exit 16:04:01 INFO - -d DEST, --destination=DEST 16:04:01 INFO - Directory to install application into. [default: 16:04:01 INFO - "/builds/slave/test-pgo"] 16:04:01 INFO - --app=APP Application being installed. [default: firefox] 16:04:01 INFO - mkdir: /builds/slave/test-pgo/build/application 16:04:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:04:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:04:16 INFO - Reading from file tmpfile_stdout 16:04:16 INFO - Output received: 16:04:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:04:16 INFO - Running post-action listener: _resource_record_post_action 16:04:16 INFO - ##### 16:04:16 INFO - ##### Running run-tests step. 16:04:16 INFO - ##### 16:04:16 INFO - Running pre-action listener: _resource_record_pre_action 16:04:16 INFO - Running main action method: run_tests 16:04:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:04:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:04:16 INFO - Python 2.7.3 16:04:16 INFO - Return code: 0 16:04:16 INFO - grabbing minidump binary from tooltool 16:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:16 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 0x2229350>, '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 0x222a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:04:16 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 16:04:16 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 16:04:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:04:16 INFO - Return code: 0 16:04:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:04:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:04:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:04:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:04:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:04:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:04:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:04:17 INFO - Return code: 0 16:04:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:04:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost 16:04:17 INFO - Using env: {'DISPLAY': ':0', 16:04:17 INFO - 'HOME': '/home/cltbld', 16:04:17 INFO - 'LANG': 'en_US.UTF-8', 16:04:17 INFO - 'LANGUAGE': 'en_US:en', 16:04:17 INFO - 'LOGNAME': 'cltbld', 16:04:17 INFO - 'MAIL': '/var/mail/cltbld', 16:04:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:04:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:17 INFO - 'MOZ_NO_REMOTE': '1', 16:04:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:04:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:17 INFO - 'NO_EM_RESTART': '1', 16:04:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:04:17 INFO - 'PWD': '/builds/slave/test-pgo', 16:04:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:04:17 INFO - 'SHELL': '/bin/bash', 16:04:17 INFO - 'SHLVL': '1', 16:04:17 INFO - 'TERM': 'linux', 16:04:17 INFO - 'TMOUT': '86400', 16:04:17 INFO - 'USER': 'cltbld', 16:04:17 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716', 16:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:17 INFO - '_': '/tools/buildbot/bin/python'} 16:04:17 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] with output_timeout 3600 16:04:17 INFO - mozversion INFO | application_buildid: 20151230133836 16:04:17 INFO - mozversion INFO | application_changeset: 839dd566125d53b477bcd3838c33ac824d06dced 16:04:17 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 16:04:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:04:17 INFO - mozversion INFO | application_name: Firefox 16:04:17 INFO - mozversion INFO | application_remotingname: firefox-dev 16:04:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:04:17 INFO - mozversion INFO | application_vendor: Mozilla 16:04:17 INFO - mozversion INFO | application_version: 45.0a2 16:04:17 INFO - mozversion INFO | platform_buildid: 20151230133836 16:04:17 INFO - mozversion INFO | platform_changeset: 839dd566125d53b477bcd3838c33ac824d06dced 16:04:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:04:17 INFO - mozversion INFO | platform_version: 45.0a2 16:04:17 INFO - 2015-12-30 16:04:17,467 DEBUG : using testdate: 1451520257 16:04:17 INFO - 2015-12-30 16:04:17,467 DEBUG : actual date: 1451520257 16:04:17 INFO - 2015-12-30 16:04:17,481 INFO : starting webserver on 'localhost:38486' 16:04:17 INFO - 2015-12-30 16:04:17,483 INFO : Starting test suite talos-linux64-ix-026 16:04:17 INFO - 2015-12-30 16:04:17,483 INFO : Starting test dromaeo_css 16:04:17 INFO - 2015-12-30 16:04:17,483 DEBUG : operating with platform_type : linux_ 16:04:17 INFO - 2015-12-30 16:04:17,484 INFO : Initialising browser for dromaeo_css test... 16:04:17 INFO - 2015-12-30 16:04:17,500 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKh3U2S/profile http://localhost:38486/getInfo.html 16:04:21 INFO - 2015-12-30 16:04:21,671 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:04:21 INFO - 2015-12-30 16:04:21,671 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:04:21 INFO - 2015-12-30 16:04:21,671 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:04:21 INFO - 2015-12-30 16:04:21,671 DEBUG : BROWSER_OUTPUT: __metrics 16:04:21 INFO - 2015-12-30 16:04:21,800 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:04:22 INFO - 2015-12-30 16:04:22,770 INFO : Browser initialized. 16:04:22 INFO - 2015-12-30 16:04:22,770 INFO : Running cycle 1/1 for dromaeo_css test... 16:04:22 INFO - 2015-12-30 16:04:22,771 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKh3U2S/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:04:34 INFO - 2015-12-30 16:04:34,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 136445952 16:04:34 INFO - 2015-12-30 16:04:34,601 DEBUG : BROWSER_OUTPUT: 16:05:25 INFO - 2015-12-30 16:05:25,465 DEBUG : BROWSER_OUTPUT: 1451520325464 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] 16:07:34 INFO - 2015-12-30 16:07:34,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38486/tests/dromaeo/cssquery-ext.html) 16:07:35 INFO - 2015-12-30 16:07:35,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 240762880 16:07:35 INFO - 2015-12-30 16:07:35,166 DEBUG : BROWSER_OUTPUT: 16:10:37 INFO - 2015-12-30 16:10:37,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/dromaeo/cssquery-ext.html (next: http://localhost:38486/tests/dromaeo/cssquery-jquery.html) 16:10:37 INFO - 2015-12-30 16:10:37,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 219377664 16:10:37 INFO - 2015-12-30 16:10:37,976 DEBUG : BROWSER_OUTPUT: 16:13:39 INFO - 2015-12-30 16:13:39,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38486/tests/dromaeo/cssquery-mootools.html) 16:13:40 INFO - 2015-12-30 16:13:40,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 207052800 16:13:40 INFO - 2015-12-30 16:13:40,403 DEBUG : BROWSER_OUTPUT: 16:16:42 INFO - 2015-12-30 16:16:42,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38486/tests/dromaeo/cssquery-prototype.html) 16:16:42 INFO - 2015-12-30 16:16:42,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 200445952 16:16:42 INFO - 2015-12-30 16:16:42,744 DEBUG : BROWSER_OUTPUT: 16:19:45 INFO - 2015-12-30 16:19:45,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38486/tests/dromaeo/cssquery-yui.html) 16:19:45 INFO - 2015-12-30 16:19:45,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 203763712 16:19:45 INFO - 2015-12-30 16:19:45,720 DEBUG : BROWSER_OUTPUT: 16:22:47 INFO - 2015-12-30 16:22:47,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/dromaeo/cssquery-yui.html (next: http://localhost:38486/tests/dromaeo/cssquery-dojo.html) 16:22:48 INFO - 2015-12-30 16:22:48,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 246222848 16:22:48 INFO - 2015-12-30 16:22:48,219 DEBUG : BROWSER_OUTPUT: 16:22:48 INFO - 2015-12-30 16:22:48,219 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:22:48 INFO - 2015-12-30 16:22:48,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:22:48 INFO - 2015-12-30 16:22:48,220 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:22:48 INFO - 2015-12-30 16:22:48,221 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:22:48 INFO - 2015-12-30 16:22:48,222 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3258.3809076275506;3297.29108241728;3334.033130392186;3337.5828021497314;3356.043527594636;5475.67145971242;5500.889982200353;5507.063799154143;5509.889802203958;5510.614257002001;5506.64206826556;5523.502884740373;5523.6685798852095;5534.889302213964;5549.306336707911;4953.900921981558;5029.195328747401;5036.571891389236;5042.798288068473;5136.280920671109;4935.259711043336;4998.375203099613;5058.418281897573;5061.291419201315;5062.392512898439;5011.974940125294;5086.491350864902;5089.134847075988;5089.618278629099;5109.693418394908;5038.823641172559;5131.3329267195395;5139.871503212412;5150;5174.560162386202;4819.759012049419;4872.561469467765;4896.853094407174;5027.1705168647495;5044.39467263927;5346.224797404393;5348.786048558053;5349.796295833446;5352.036633405985;5356.517913387775;5887.941120588782;5892.616979896293;5939.1388248704125;5943.970280148615;5952.494038006775;5715.485606295453;5743.138529220609;5810.418958104198;5814.651120932757;5971.283445986466;5522.723863806794;5630.183623374629;5638.9154162688;5650.378458369576;5654.519365853907;6111.877762444815;6133.938660613426;6137.96931015342;6138.541671868612;6143.170671959318;5625.859353516113;5721.399253078367;5772.3938986406665;5854.941450585525;5895.64626122434;5882.941170588239;5884.558658100659;5888.263967004124;5907.172995780508;6006.189164462829;5735.627184233012;5780.624259423124;5846.94153058464;5847;5864.941350586525;5789.623674461231;5864.589478736533;5905.46850783423;5936.970315148396;5938.376470470625;4534.523874993079;4535.433070866142;4536.183486972311;4541.137183935108;4553.726776393427;3981.3828856527284;4059.086705491241;4079.7756123412905;4101.364288535282;4130.215259100822;5442.537384322298;5494.642848214853;5507.03626865297;5518.034343989866;5538.833834984957;5984.910226346608;5985.281766187998;5985.40145985398;5987.341392446828;5989.520838332923;5326.760295786699;5426.538744206708;5586.636868603528;5702.344230413555;5712.200291959129;4942.851714448572;4947.876303092451;4948.950510494921;4956.330895329156;5047.772850221749;6005.669688167192;6007.189029481052;6022.849428764316;6030.216071910623;6036.3058248302;5703.08750599902;5744.511716504144;5875.853103672443;5893.410658934073;5915.497182739343;6001.219841420588;6140.539459540463;6147.385261473817;6147.569670123227;6167;5929;5933.1396947443245;5946.226990491208;5946.910796338145;5947;5758.2514273144225;5802.593818432838;5820.70896455184;5924.674142922181;5966.701664916824;5708.486236238592;5711.885762284648;5715.428457154251;5726.627769194989;5756.827295181151;5623.0721930880945;5696.772129114955;5699.316082070178;5704.258446401941;5705.315362156568;5667.829965101054;5698.857528561819;5753.1370294456165;5756.769729210952;5781.046127388934;5690.601657883908;5696.401877802771;5710.828675139753;5721.427857214246;5778;5537.058700020925;5560.5551555876245;5565.499105080562;5568.777248909998;5651.689157096399 16:22:48 INFO - 2015-12-30 16:22:48,223 DEBUG : BROWSER_OUTPUT: |1;ext.html;574.5087949802919;607.9088136779483;619.1115748900328;632.0487666062575;633.5628416392685;39535.80232098843;40404.393934091015;40426.79786601063;40495.79752101239;40499;42965.570344296546;43487;43581;43611.78194109033;43719.78140109303;8099.716509922154;8203.220694034057;8203.876941845878;8937.731868043953;9196.816063678722;10914.781704365909;11100.722481937975;11129.220954533186;11138.108951283877;11150.776984460306;10849.83725244118;10951.069159121484;10961.616343427982;10970.286931349478;10973.177011724112;8279.54462504562;8454.619542120558;8459.619317130744;10767.407792571405;10883.727906802314;10640.946795265974;10735.83896241557;10737.677869663923;10780.73048173794;10790.298630588986;42737;43267.567324326985;43380.132397352194;43381.349279760514;43426.34860477095;3616.8191590420374;3729.9440508392127;3730.4963829883163;3782.9054273643105;4193.391958166079;31002.224944376347;31064;31536.211594710087;31653;31751.36497270065;3872.7730066828394;3939.702302565942;3965;3986.202759448093;4008.198360327946;283807;284176;284876;286056;286057.5697121522;59080.11379829306;59385.40614593799;64167;64532;73400;66289.66855165693;66454;66705;66766;66815.66592167105;17026.31894724222;17203.311867525408;17248.827511724972;17250.309987600605;17266.136693165543;13904.374303156383;14064.789028164585;14065.789013164811;14078.436862525385;14086.366113524711;22011.449713756963;22147.446313842283;22377.88811055967;22399.88800055989;22418.88790556037;8358.45670031446;8456.408051436463;8463.830723385498;8502.44734092282;8608.053114157437;975.7560609847538;1019.6686077024997;1136.9943150284196;1143.8112711402525;1149.3965668024186;29772.404551909272;30144.397112057635;30711.8464407681;30784.230394239876;31014.22464438362;1081.405227125078;1132.8867113288604;1202.1644956754972;1222.3460448659923;1251.6933351328983;13777;15756.448524301595;16179.514614561582;16635.584110397336;17051.658966820592;407469;408989;410409;410737;411082;58227.12659310114;58371;59063.40936590665;65711.67144164344;67023.3297667017;1449.7535418978798;1460.9196494192709;1470.8970372074066;1481.5777503411475;1490.1431676785892;29391.85304073466;30379.392412151192;31069.533956991116;33392.833035834665;34636;53469.46530534645;54162.45837541574;54194;54233;54258.72870635622;307565;310089.8991010061;310596;310827;311284;44502.55497444984;45101.54898450973;46594.301085483065;47359;47491.76254118846;42979.38583879389;46217.30674039825;47168.528314716415;47221.527784721715;47251.76374118107;38985.94077176099;39532.60467395289;39693.60306396899;39923;40589.39115913204;38726.419103712906;39461.64576011071;39559;40134;40164.59835401725;38390;38762.6123738759;38931.610683892795;39175.41236881506;39215.607843922335;33966.49050264298;35381.29237415186;37805;39525.95095530415;40233.39649905195;26493.867530662224;26893.327666808487;26995.460090798468;27115.72884271132;27137 16:22:48 INFO - 2015-12-30 16:22:48,223 DEBUG : BROWSER_OUTPUT: |2;jquery.html;389.9239648268587;391.9039835240367;393.25085711719174;395.75858726177034;399.2095650611787;14881.25593720315;16892.324307027735;17393.217305221264;18697.345592904236;18712.90643546782;17355.132243387812;17826.554336141602;17854.196561154746;18408.263669453238;18839.623207535842;5031.622628302874;5127.154019586782;5129.3844738631415;5138.820141295056;5145.0481660892665;3879.243547508237;3961.5642279349395;5105.259737338084;5425.077736784756;5518.2826232589705;5450.018996580614;5483.095289277265;5483.972580137094;5504.22940788288;5504.889902201973;5443.455654434564;6099.57302988791;6100.023996160593;6104.206453161083;6105.297890742577;5458.235846981386;5471.398146203955;5473.124300111963;5475.370332411784;5495.477929596682;19721.21115155392;19740;19980.60038799216;19985.200591976303;20404.693929591067;2161.189553917281;2169.1648715244587;2185.573813106445;2194.890255487235;2264.1509433962265;9071.59177836999;9341.346105772598;9596.18432433244;9783.217342612574;9957.651482198089;1916.9520761980923;1921.7597800274966;1924.8845069295887;1947.5325921778813;1958.6572349838864;38672.806635966925;38750;38964.02589935246;48643.27035094441;53997.73001135008;11042.834357484644;11052.502637381338;11061.502232399562;11064.557417703201;11153.888461115448;14654.633634159018;14726.484573039892;14743.336549855283;14753.704925901637;14769.113853168845;8132.878006829902;8139.715109971123;8148.348132149533;8169.877451838227;8184.549849758201;7700.576468294185;7783.649735761905;7801.336886364723;7853.685852565947;7863.174366691415;4843.007183527439;4914.459409464956;4927;4961.479044700327;4964.503549645006;1705.0187903807887;1942.951426214356;1961.225316000172;1974.7136665183755;2013.3456626596414;419.92231437184216;429.6734481793859;459.7195710616521;999.9350042247377;1038.0138868075358;10654.147668186526;10956.28784129029;11195.2723073;17824;18917.621647567248;1011.8431643095332;1021.279997601689;1058.867641544807;1066.1524088349781;1088.9654827913514;9956;10296.485175741183;10298.948505257576;10304.793904121876;10389.636362727419;581748;592934;622534;651964;652913;84345.57827210825;85620.57189714136;86648;88969.55515222382;89330;1175.641429364035;1200.3135594489581;1203.0315595945349;1223.253815172744;1245.9875401246052;16440.177991100638;16546.917265413595;16604.00375977397;16690.082045487616;16794.58013549622;34968.30063398769;35609.28781424305;35804;36739;37984.43023354707;48215.75892120517;48844.755776222315;50174.74912625414;51542.484575153765;52773.472265276854;9722.465264410524;9766.414015159113;10077.949610251902;10086.848697269694;10094.949525252327;11331.433428328715;11415.885841141482;11535.884641153481;19116;19206.519837003627;14938.327775250356;15670.608234794221;15983.44057957966;16000.279987400827;16214.51356459308;14812.851871481147;15013.399464021753;15235.466758663393;15752.763708544151;15824.525264242091;7846.568438735924;9555.041216550451;15773.842261577696;16118.194090295205;16165.515034548982;9405.388649737744;9633.662821801483;9734.561944712363;9740.415575065519;9761.121499065119;10859;11332.866713328602;14962.925185374004;15055.02142360743;15469.458568950033 16:22:48 INFO - 2015-12-30 16:22:48,224 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1545.350952599908;1546.056905287775;1655.710250706126;1794.129847024193;1831.2217307644248;6980.267071957441;7826.139124696286;7935.761927142195;7936.325412339944;7938.6824527018925;7842.215778422155;7986.960065199666;7988.800279993003;7993.1607181246;7997.680092796296;1996.2414282572602;2028.6044221376837;2029.9898500507477;2268.6370180771037;2298.5173113646156;2282.5777231212196;2323.2333330001143;2323.581755284048;2325.395397196724;2326.26722582386;2268.5009297954507;2289.1301305503885;2316.339843144704;2319.3621754017613;2321.6169332060276;2303.0672577606015;2317.756635553268;2337.5909215887236;2360.5042940982416;2360.7285162206394;2288.7139107611547;2289.8740569268684;2319.489712263299;2321.466062805564;2323.604987152188;7909.446338756289;8004.759857204235;8005.119436861941;8006.879896801553;8016.879746803803;4755.405574303212;4792.664513484057;4816.373871396731;4828.637852161102;4830.178869592178;2942.4262268857583;3025.379797141603;3062.6631070582216;3078.81527108372;3082.1370016395445;965.8744363232735;973.5542719062187;974.57605941415;1021.0504231065106;1034.6327053895834;10623.84064239037;10691.518881650421;10706.41114738689;10712.41081740504;10723.83914241287;4142.834286628501;4155.480564929384;4221.838994276537;4230.111676547959;4233.724807887477;8886.11138886119;8927.33045021613;8929;8941.195292423714;8942.329325300629;4763.7141771493125;4778.880527986758;4784.30627559002;4824.903501929942;4826.396700412449;4401.22978478765;4410.691251612357;4449.243628583149;4460.286354183315;4463.174312752087;3353.5975682918206;3363.630000699921;3384.881529146517;3389.983050084734;3398.9972957977457;1113.3932007056173;1135.8523391958993;1140.122105978392;1141.6289705845468;1143.8284257361297;1265.8923991460829;1440.287057906343;1445.2412483446276;1457.7813328000884;1496.2892626002563;7459.142198647117;7521.135069467081;7597.772066838003;7601.581912994839;7602;610.2707264818499;610.2829175718601;612.3050337866465;629.515273239603;779.8341479488088;5961.850953726105;6059;6110.908336374958;6133.172021777003;6139.171211886338;9434.952825235967;9598.088181622734;9690.176335011462;9710.75723106914;9730.659426920023;9174.128457796498;9515.23878089751;9576.952115239379;9632;9655.758606034906;7501.737439189711;7560.8487830244185;7574;7623.580703061274;7633.122190948001;7292.744753933587;7365.189829118685;7415.666295016629;7429.44279179053;7431.29402706742;8490.533020683923;8552.615132318937;8655.999999999749;8679;8692;8720.476771393736;8768;8847.336449766422;8870.068642792414;9010.098990100938;6909.861802763816;6911.447084233148;6950.374466298057;6979.371856532734;6979.441644668516;6768.492363072691;6883.518153729191;7520.323170914644;7682.577458239851;7791.220877912164;7151.177614574391;7291.890621640786;7296.817579560341;7309.086364204474;7364.742234021784;7155.177154627285;7218.711251550089;7223.1693355264815;7275.636218189175;7312.96343518279;7126.608036558039;7164.247753985965;7164.641767911688;7194.028806111108;7209;6619.404253617197;6656;6657.5672581284;6658.900116498159;6660.866782664222;6864.141982252218;6885.724571017103;6889.517733758589;6894.310568943066;6901.447884169154 16:22:48 INFO - 2015-12-30 16:22:48,226 DEBUG : BROWSER_OUTPUT: |4;prototype.html;345.35246412975664;353.31104346524285;353.67815288087843;354.6028448138086;357;5948.940510594893;6095.116208149816;6133.478654314383;6199.411055949683;6230.688465576725;5908.438698323653;5984.072468767348;6008.879822403549;6009.969950150243;6074.058520929263;4710.175719249135;4736.810527578893;4738.535961300122;4740.573348398643;4744.383230180089;4543.227651299287;4611.239145540999;4656.97671511642;4703;4745.786439610209;4655.13879932212;4660.16117098922;4705.176594096037;4709.293605959117;4711.505291944348;4681.765911704419;4685.648576356787;4699.835505757316;4709.740964246965;4730.219513780222;4152.647025002879;4155.23128221277;4155.23128221277;4157.10622216225;4163.02168990287;5697.6296540724725;5781.450762177628;5790.913136302959;5802.883942321172;5807.2160258365;5513.365962914276;5520.089185284423;5523;5527.778888844441;5529.060059789846;6197.752089916398;6515.3484651534945;6515.641639709814;6523.869522609569;6527.510436717265;4506.211413002711;4522.5025247222775;4634.374359461497;4637.768111594441;4638.420197475316;6770.966145169243;6806.5235433520165;6807.285235050298;6809.727610895558;6809.761658341934;4741.502142275081;4745.762711864393;4745.786439610226;4748.738819364969;4750.453697824725;4703.882402939886;4802.903941921142;4810.759462026885;4813.109574728686;4833.299171620166;5509.586780991442;5514.283143191359;5524.364698059774;5528.806491772769;5529.668219906818;6556.606603603799;6574.539782215199;6575.44108750752;6575.967120164464;6576;1675.6648670265995;1704.2330951072067;1704.250129942821;1704.880658353928;1706.8378504042096;1082.426314053553;1098.8901109888948;1103.3490240757992;1111.8776934537195;1111.9777604447866;6275.6862156891975;6329.240491141092;6329.873402531924;6334.144890439732;6338.904916426257;6704.061431399608;6732.124823772976;6735;6739.865202695919;6741.898871516931;6195.287541932646;6300;6336.52476064297;6341.302456729756;6342.651154186564;3588.7129029678085;3642.7996460194413;3643.5809881863397;3650.324689932371;3651.561812582507;6910.30896910315;6920.9653951730925;6922.857728474745;6926.238113807477;6930.272321406281;6793.31549734456;6860.451163906875;6860.6912688929115;6873.037774711544;6873.312668733087;6835.726570937107;6840.144981877265;6887.380135787803;6901.309869013058;6902.551334163364;6537.1174891389055;6704.631245281556;6717.395434410926;6721.764738234138;6738.292479289604;6708.161479815023;6739.59562426256;6751.729930802713;6753.493487988322;6759.357861003196;7020.6489675514995;7026.754063607749;7032.824179395556;7039.331263529956;7040.0847889774;4581.793819278074;4622.098690755271;4651.116287905287;4654.418197725285;4667.789949452351;6784.253732089565;6811.965940170466;6813.4889883257965;6819.215790184192;6820.045193672989;6645.235797883112;6646.83382915431;6650.83372915681;6654.201495820533;6657.2677005528385;6466.159399278064;6584.407403333723;6597.80206593803;6608.900866486911;6625.933740662725;6520.902186467301;6526.804195874131;6531.444827189742;6533.18335208099;6534.8366290843105;6656.900146497709;6658.900116498159;6664.233613134357;6668.266490685924;6669.1330127083165;6339.683015849281;6457.903131452938;6459.192600924885;6462.547621666438;6462.612243265419 16:22:48 INFO - 2015-12-30 16:22:48,226 DEBUG : BROWSER_OUTPUT: |5;yui.html;876.6756300168936;890.5586864259374;938.3009657804936;941.2375975459873;962.3311798300175;14051.5081972131;14586.70826583469;14597.124172549655;14605.78091328631;14614;14584.270786460687;14597.708045839077;14624.926875365634;14693.118412895206;14694.926525367386;777.50239846498;786.952782833029;908.8863892013499;917.5183028909843;939.7603611079165;936.8501039833628;937.6905621145006;943.6131186213654;946.3139224062569;946.4936259101382;809.4091313341264;984.0602224875227;994.1947022911465;994.9354191015616;995.2137811129236;803.0283357137841;968.389914353956;980.1766516126488;980.5440470181329;983.5229913491951;723.0528008309132;728.6393235348484;728.7995801154672;730.2989130434789;730.8867125595541;14956.177410242432;15302.846971530253;15324.540263792103;15335.616609584738;15358.462453814063;12576.163782598092;12654.177478463962;13108.410121544553;13292.3353832308;13898.58304250874;11003.504842282116;11166.441677916153;11283.37941413222;11384.658460246206;11592.304461732323;3816.274907767543;3834.616538346171;3858.903527411809;3879.86420475282;3935.291647503448;48168;48389;48415;48576;48690.513094868955;10671.83992240117;10865.565377384815;10906;10942.45287735626;10970.396628185366;20267.59464810725;20307.898460507604;20340.084696188707;20369.18523259053;20395.694064589043;8162.3878209134555;8208.712695055645;8243.216894395024;8284.792880178044;8326.417150799507;4727.503612120747;4743.075100355398;4758.904821903542;4766.23740201573;4803.375561177095;3370.4775759757276;3385.0860267728067;3387.237871478947;3390.983045084808;3392.355452464024;587.3157771196594;594.3462191589304;595.5414330965133;599.430540986065;620.0482259731381;670.4066900792833;673.6295037729229;674.4772801079105;722.9855402891912;737.1706829816457;8858.202761751474;9367.484788336571;9499.24006079512;9759;9802.46086465237;562.7097712310856;577.7342422485704;608.1516284782704;624.9218847644045;699.1889408286363;4185.853495127656;4353.564643535685;4401.361802538614;4448.065906159743;4450.35469856869;60939.39060609426;61302.08046879301;61662;62058.68970655118;62325;55813.16280255799;56512.71743641255;56563.43436565664;56576;56680.14979775307;50933;51120;51401.7429912848;51849.48150518446;51980.960380792174;8730.083341249077;8810.603522841358;8883.42257753244;8948.328875334506;9048.050049233614;36148.4577731329;36253.81873090723;37146.25707485889;37263.813680931424;37548.812255938545;44986.3252051226;45186.548134518234;47074;47992.5200748002;48467.75766121147;10492.317999330018;10659.840102398626;10990.725231869268;11208.943955280172;11261.549538018387;11236.157288203254;11339.773204536028;11379.829302560303;12552.686182845502;13313.800292995806;11543.480543375736;11601.825972610586;12018.459169337226;12316.815247771112;12862.485500579873;11879.643610691694;11882.597035570076;12076.577319793765;12259.69350766238;12395.194312369667;12148.39258037077;12307.646173914376;12628.431720572413;12698.682532936751;12848.42182101789;10383.636572719919;10626.256162068581;10878.782424351626;11172.664820055412;11306.717332066764;9980.201583873419;10468.528916198637;10550.89449105499;10561.524731386953;10614.787704245717 16:22:48 INFO - 2015-12-30 16:22:48,226 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:22:48 INFO - 2015-12-30 16:22:48,226 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:22:48 INFO - 2015-12-30 16:22:48,226 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,799 16:22:48 INFO - 2015-12-30 16:22:48,226 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:22:48 INFO - 2015-12-30 16:22:48,226 DEBUG : BROWSER_OUTPUT: __startTimestamp1451521368218__endTimestamp 16:22:48 INFO - 2015-12-30 16:22:48,226 DEBUG : BROWSER_OUTPUT: 16:22:48 INFO - 2015-12-30 16:22:48,226 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:22:48 INFO - 2015-12-30 16:22:48,226 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:22:48 INFO - 2015-12-30 16:22:48,226 DEBUG : BROWSER_OUTPUT: 16:22:48 INFO - 2015-12-30 16:22:48,227 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5472.38 Median:5696.40 stddev:602.08 (10.6%) stddev-sans-first:578.33 16:22:48 INFO - 2015-12-30 16:22:48,228 DEBUG : BROWSER_OUTPUT: Values: 3258.4 3297.3 3334.0 3337.6 3356.0 5475.7 5500.9 5507.1 5509.9 5510.6 5506.6 5523.5 5523.7 5534.9 5549.3 4953.9 5029.2 5036.6 5042.8 5136.3 4935.3 4998.4 5058.4 5061.3 5062.4 5012.0 5086.5 5089.1 5089.6 5109.7 5038.8 5131.3 5139.9 5150.0 5174.6 4819.8 4872.6 4896.9 5027.2 5044.4 5346.2 5348.8 5349.8 5352.0 5356.5 5887.9 5892.6 5939.1 5944.0 5952.5 5715.5 5743.1 5810.4 5814.7 5971.3 5522.7 5630.2 5638.9 5650.4 5654.5 6111.9 6133.9 6138.0 6138.5 6143.2 5625.9 5721.4 5772.4 5854.9 5895.6 5882.9 5884.6 5888.3 5907.2 6006.2 5735.6 5780.6 5846.9 5847.0 5864.9 5789.6 5864.6 5905.5 5937.0 5938.4 4534.5 4535.4 4536.2 4541.1 4553.7 3981.4 4059.1 4079.8 4101.4 4130.2 5442.5 5494.6 5507.0 5518.0 5538.8 5984.9 5985.3 5985.4 5987.3 5989.5 5326.8 5426.5 5586.6 5702.3 5712.2 4942.9 4947.9 4949.0 4956.3 5047.8 6005.7 6007.2 6022.8 6030.2 6036.3 5703.1 5744.5 5875.9 5893.4 5915.5 6001.2 6140.5 6147.4 6147.6 6167.0 5929.0 5933.1 5946.2 5946.9 5947.0 5758.3 5802.6 5820.7 5924.7 5966.7 5708.5 5711.9 5715.4 5726.6 5756.8 5623.1 5696.8 5699.3 5704.3 5705.3 5667.8 5698.9 5753.1 5756.8 5781.0 5690.6 5696.4 5710.8 5721.4 5778.0 5537.1 5560.6 5565.5 5568.8 5651.7 16:22:48 INFO - 2015-12-30 16:22:48,228 DEBUG : BROWSER_OUTPUT: 16:22:48 INFO - 2015-12-30 16:22:48,228 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52430.26 Median:38744.52 stddev:88886.92 (229.4%) stddev-sans-first:89051.00 16:22:48 INFO - 2015-12-30 16:22:48,228 DEBUG : BROWSER_OUTPUT: Values: 574.5 607.9 619.1 632.0 633.6 39535.8 40404.4 40426.8 40495.8 40499.0 42965.6 43487.0 43581.0 43611.8 43719.8 8099.7 8203.2 8203.9 8937.7 9196.8 10914.8 11100.7 11129.2 11138.1 11150.8 10849.8 10951.1 10961.6 10970.3 10973.2 8279.5 8454.6 8459.6 10767.4 10883.7 10640.9 10735.8 10737.7 10780.7 10790.3 42737.0 43267.6 43380.1 43381.3 43426.3 3616.8 3729.9 3730.5 3782.9 4193.4 31002.2 31064.0 31536.2 31653.0 31751.4 3872.8 3939.7 3965.0 3986.2 4008.2 283807.0 284176.0 284876.0 286056.0 286057.6 59080.1 59385.4 64167.0 64532.0 73400.0 66289.7 66454.0 66705.0 66766.0 66815.7 17026.3 17203.3 17248.8 17250.3 17266.1 13904.4 14064.8 14065.8 14078.4 14086.4 22011.4 22147.4 22377.9 22399.9 22418.9 8358.5 8456.4 8463.8 8502.4 8608.1 975.8 1019.7 1137.0 1143.8 1149.4 29772.4 30144.4 30711.8 30784.2 31014.2 1081.4 1132.9 1202.2 1222.3 1251.7 13777.0 15756.4 16179.5 16635.6 17051.7 407469.0 408989.0 410409.0 410737.0 411082.0 58227.1 58371.0 59063.4 65711.7 67023.3 1449.8 1460.9 1470.9 1481.6 1490.1 29391.9 30379.4 31069.5 33392.8 34636.0 53469.5 54162.5 54194.0 54233.0 54258.7 307565.0 310089.9 310596.0 310827.0 311284.0 44502.6 45101.5 46594.3 47359.0 47491.8 42979.4 46217.3 47168.5 47221.5 47251.8 38985.9 39532.6 39693.6 39923.0 40589.4 38726.4 39461.6 39559.0 40134.0 40164.6 38390.0 38762.6 38931.6 39175.4 39215.6 33966.5 35381.3 37805.0 39526.0 40233.4 26493.9 26893.3 26995.5 27115.7 27137.0 16:22:48 INFO - 2015-12-30 16:22:48,228 DEBUG : BROWSER_OUTPUT: 16:22:48 INFO - 2015-12-30 16:22:48,228 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31058.86 Median:18616.23 stddev:101395.33 (544.7%) stddev-sans-first:101653.62 16:22:48 INFO - 2015-12-30 16:22:48,229 DEBUG : BROWSER_OUTPUT: Values: 389.9 391.9 393.3 395.8 399.2 14881.3 16892.3 17393.2 18697.3 18712.9 17355.1 17826.6 17854.2 18408.3 18839.6 5031.6 5127.2 5129.4 5138.8 5145.0 3879.2 3961.6 5105.3 5425.1 5518.3 5450.0 5483.1 5484.0 5504.2 5504.9 5443.5 6099.6 6100.0 6104.2 6105.3 5458.2 5471.4 5473.1 5475.4 5495.5 19721.2 19740.0 19980.6 19985.2 20404.7 2161.2 2169.2 2185.6 2194.9 2264.2 9071.6 9341.3 9596.2 9783.2 9957.7 1917.0 1921.8 1924.9 1947.5 1958.7 38672.8 38750.0 38964.0 48643.3 53997.7 11042.8 11052.5 11061.5 11064.6 11153.9 14654.6 14726.5 14743.3 14753.7 14769.1 8132.9 8139.7 8148.3 8169.9 8184.5 7700.6 7783.6 7801.3 7853.7 7863.2 4843.0 4914.5 4927.0 4961.5 4964.5 1705.0 1943.0 1961.2 1974.7 2013.3 419.9 429.7 459.7 999.9 1038.0 10654.1 10956.3 11195.3 17824.0 18917.6 1011.8 1021.3 1058.9 1066.2 1089.0 9956.0 10296.5 10298.9 10304.8 10389.6 581748.0 592934.0 622534.0 651964.0 652913.0 84345.6 85620.6 86648.0 88969.6 89330.0 1175.6 1200.3 1203.0 1223.3 1246.0 16440.2 16546.9 16604.0 16690.1 16794.6 34968.3 35609.3 35804.0 36739.0 37984.4 48215.8 48844.8 50174.7 51542.5 52773.5 9722.5 9766.4 10077.9 10086.8 10094.9 11331.4 11415.9 11535.9 19116.0 19206.5 14938.3 15670.6 15983.4 16000.3 16214.5 14812.9 15013.4 15235.5 15752.8 15824.5 7846.6 9555.0 15773.8 16118.2 16165.5 9405.4 9633.7 9734.6 9740.4 9761.1 10859.0 11332.9 14962.9 15055.0 15469.5 16:22:48 INFO - 2015-12-30 16:22:48,229 DEBUG : BROWSER_OUTPUT: 16:22:48 INFO - 2015-12-30 16:22:48,229 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5553.07 Median:6714.68 stddev:2899.08 (43.2%) stddev-sans-first:2891.57 16:22:48 INFO - 2015-12-30 16:22:48,230 DEBUG : BROWSER_OUTPUT: Values: 1545.4 1546.1 1655.7 1794.1 1831.2 6980.3 7826.1 7935.8 7936.3 7938.7 7842.2 7987.0 7988.8 7993.2 7997.7 1996.2 2028.6 2030.0 2268.6 2298.5 2282.6 2323.2 2323.6 2325.4 2326.3 2268.5 2289.1 2316.3 2319.4 2321.6 2303.1 2317.8 2337.6 2360.5 2360.7 2288.7 2289.9 2319.5 2321.5 2323.6 7909.4 8004.8 8005.1 8006.9 8016.9 4755.4 4792.7 4816.4 4828.6 4830.2 2942.4 3025.4 3062.7 3078.8 3082.1 965.9 973.6 974.6 1021.1 1034.6 10623.8 10691.5 10706.4 10712.4 10723.8 4142.8 4155.5 4221.8 4230.1 4233.7 8886.1 8927.3 8929.0 8941.2 8942.3 4763.7 4778.9 4784.3 4824.9 4826.4 4401.2 4410.7 4449.2 4460.3 4463.2 3353.6 3363.6 3384.9 3390.0 3399.0 1113.4 1135.9 1140.1 1141.6 1143.8 1265.9 1440.3 1445.2 1457.8 1496.3 7459.1 7521.1 7597.8 7601.6 7602.0 610.3 610.3 612.3 629.5 779.8 5961.9 6059.0 6110.9 6133.2 6139.2 9435.0 9598.1 9690.2 9710.8 9730.7 9174.1 9515.2 9577.0 9632.0 9655.8 7501.7 7560.8 7574.0 7623.6 7633.1 7292.7 7365.2 7415.7 7429.4 7431.3 8490.5 8552.6 8656.0 8679.0 8692.0 8720.5 8768.0 8847.3 8870.1 9010.1 6909.9 6911.4 6950.4 6979.4 6979.4 6768.5 6883.5 7520.3 7682.6 7791.2 7151.2 7291.9 7296.8 7309.1 7364.7 7155.2 7218.7 7223.2 7275.6 7313.0 7126.6 7164.2 7164.6 7194.0 7209.0 6619.4 6656.0 6657.6 6658.9 6660.9 6864.1 6885.7 6889.5 6894.3 6901.4 16:22:48 INFO - 2015-12-30 16:22:48,230 DEBUG : BROWSER_OUTPUT: 16:22:48 INFO - 2015-12-30 16:22:48,230 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5482.76 Median:6215.05 stddev:1643.39 (26.4%) stddev-sans-first:1602.12 16:22:48 INFO - 2015-12-30 16:22:48,230 DEBUG : BROWSER_OUTPUT: Values: 345.4 353.3 353.7 354.6 357.0 5948.9 6095.1 6133.5 6199.4 6230.7 5908.4 5984.1 6008.9 6010.0 6074.1 4710.2 4736.8 4738.5 4740.6 4744.4 4543.2 4611.2 4657.0 4703.0 4745.8 4655.1 4660.2 4705.2 4709.3 4711.5 4681.8 4685.6 4699.8 4709.7 4730.2 4152.6 4155.2 4155.2 4157.1 4163.0 5697.6 5781.5 5790.9 5802.9 5807.2 5513.4 5520.1 5523.0 5527.8 5529.1 6197.8 6515.3 6515.6 6523.9 6527.5 4506.2 4522.5 4634.4 4637.8 4638.4 6771.0 6806.5 6807.3 6809.7 6809.8 4741.5 4745.8 4745.8 4748.7 4750.5 4703.9 4802.9 4810.8 4813.1 4833.3 5509.6 5514.3 5524.4 5528.8 5529.7 6556.6 6574.5 6575.4 6576.0 6576.0 1675.7 1704.2 1704.3 1704.9 1706.8 1082.4 1098.9 1103.3 1111.9 1112.0 6275.7 6329.2 6329.9 6334.1 6338.9 6704.1 6732.1 6735.0 6739.9 6741.9 6195.3 6300.0 6336.5 6341.3 6342.7 3588.7 3642.8 3643.6 3650.3 3651.6 6910.3 6921.0 6922.9 6926.2 6930.3 6793.3 6860.5 6860.7 6873.0 6873.3 6835.7 6840.1 6887.4 6901.3 6902.6 6537.1 6704.6 6717.4 6721.8 6738.3 6708.2 6739.6 6751.7 6753.5 6759.4 7020.6 7026.8 7032.8 7039.3 7040.1 4581.8 4622.1 4651.1 4654.4 4667.8 6784.3 6812.0 6813.5 6819.2 6820.0 6645.2 6646.8 6650.8 6654.2 6657.3 6466.2 6584.4 6597.8 6608.9 6625.9 6520.9 6526.8 6531.4 6533.2 6534.8 6656.9 6658.9 6664.2 6668.3 6669.1 6339.7 6457.9 6459.2 6462.5 6462.6 16:22:48 INFO - 2015-12-30 16:22:48,230 DEBUG : BROWSER_OUTPUT: 16:22:48 INFO - 2015-12-30 16:22:48,230 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14797.51 Median:46130.27 stddev:17031.08 (36.9%) stddev-sans-first:17046.77 16:22:48 INFO - 2015-12-30 16:22:48,230 DEBUG : BROWSER_OUTPUT: Values: 876.7 890.6 938.3 941.2 962.3 14051.5 14586.7 14597.1 14605.8 14614.0 14584.3 14597.7 14624.9 14693.1 14694.9 777.5 787.0 908.9 917.5 939.8 936.9 937.7 943.6 946.3 946.5 809.4 984.1 994.2 994.9 995.2 803.0 968.4 980.2 980.5 983.5 723.1 728.6 728.8 730.3 730.9 14956.2 15302.8 15324.5 15335.6 15358.5 12576.2 12654.2 13108.4 13292.3 13898.6 11003.5 11166.4 11283.4 11384.7 11592.3 3816.3 3834.6 3858.9 3879.9 3935.3 48168.0 48389.0 48415.0 48576.0 48690.5 10671.8 10865.6 10906.0 10942.5 10970.4 20267.6 20307.9 20340.1 20369.2 20395.7 8162.4 8208.7 8243.2 8284.8 8326.4 4727.5 4743.1 4758.9 4766.2 4803.4 3370.5 3385.1 3387.2 3391.0 3392.4 587.3 594.3 595.5 599.4 620.0 670.4 673.6 674.5 723.0 737.2 8858.2 9367.5 9499.2 9759.0 9802.5 562.7 577.7 608.2 624.9 699.2 4185.9 4353.6 4401.4 4448.1 4450.4 60939.4 61302.1 61662.0 62058.7 62325.0 55813.2 56512.7 56563.4 56576.0 56680.1 50933.0 51120.0 51401.7 51849.5 51981.0 8730.1 8810.6 8883.4 8948.3 9048.1 36148.5 36253.8 37146.3 37263.8 37548.8 44986.3 45186.5 47074.0 47992.5 48467.8 10492.3 10659.8 10990.7 11208.9 11261.5 11236.2 11339.8 11379.8 12552.7 13313.8 11543.5 11601.8 12018.5 12316.8 12862.5 11879.6 11882.6 12076.6 12259.7 12395.2 12148.4 12307.6 12628.4 12698.7 12848.4 10383.6 10626.3 10878.8 11172.7 11306.7 9980.2 10468.5 10550.9 10561.5 10614.8 16:22:48 INFO - 2015-12-30 16:22:48,230 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:22:48 INFO - 2015-12-30 16:22:48,231 DEBUG : BROWSER_OUTPUT: 16:22:48 INFO - 2015-12-30 16:22:48,921 INFO : Browser exited with error code: 0 16:22:48 INFO - 2015-12-30 16:22:48,938 INFO : Completed test dromaeo_css (00:18:31) 16:22:48 INFO - 2015-12-30 16:22:48,938 INFO : Starting test kraken 16:22:48 INFO - 2015-12-30 16:22:48,938 DEBUG : operating with platform_type : linux_ 16:22:48 INFO - 2015-12-30 16:22:48,938 INFO : Initialising browser for kraken test... 16:22:48 INFO - 2015-12-30 16:22:48,944 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn9en80/profile http://localhost:38486/getInfo.html 16:22:52 INFO - 2015-12-30 16:22:52,764 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:22:52 INFO - 2015-12-30 16:22:52,764 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:22:52 INFO - 2015-12-30 16:22:52,764 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:22:52 INFO - 2015-12-30 16:22:52,764 DEBUG : BROWSER_OUTPUT: __metrics 16:22:52 INFO - 2015-12-30 16:22:52,913 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:22:54 INFO - 2015-12-30 16:22:54,012 INFO : Browser initialized. 16:22:54 INFO - 2015-12-30 16:22:54,013 INFO : Running cycle 1/1 for kraken test... 16:22:54 INFO - 2015-12-30 16:22:54,013 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn9en80/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:23:05 INFO - 2015-12-30 16:23:05,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 136069120 16:23:05 INFO - 2015-12-30 16:23:05,799 DEBUG : BROWSER_OUTPUT: 16:23:08 INFO - 2015-12-30 16:23:08,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38486/tests/kraken/driver.html?testName=audio-beat-detection) 16:23:08 INFO - 2015-12-30 16:23:08,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 166277120 16:23:08 INFO - 2015-12-30 16:23:08,820 DEBUG : BROWSER_OUTPUT: 16:23:11 INFO - 2015-12-30 16:23:11,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38486/tests/kraken/driver.html?testName=audio-dft) 16:23:11 INFO - 2015-12-30 16:23:11,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 166195200 16:23:11 INFO - 2015-12-30 16:23:11,930 DEBUG : BROWSER_OUTPUT: 16:23:14 INFO - 2015-12-30 16:23:14,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38486/tests/kraken/driver.html?testName=audio-fft) 16:23:15 INFO - 2015-12-30 16:23:15,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 162471936 16:23:15 INFO - 2015-12-30 16:23:15,287 DEBUG : BROWSER_OUTPUT: 16:23:17 INFO - 2015-12-30 16:23:17,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38486/tests/kraken/driver.html?testName=audio-oscillator) 16:23:17 INFO - 2015-12-30 16:23:17,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 163594240 16:23:17 INFO - 2015-12-30 16:23:17,826 DEBUG : BROWSER_OUTPUT: 16:23:20 INFO - 2015-12-30 16:23:20,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38486/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:23:20 INFO - 2015-12-30 16:23:20,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 161722368 16:23:20 INFO - 2015-12-30 16:23:20,606 DEBUG : BROWSER_OUTPUT: 16:23:23 INFO - 2015-12-30 16:23:23,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38486/tests/kraken/driver.html?testName=imaging-darkroom) 16:23:24 INFO - 2015-12-30 16:23:24,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 161951744 16:23:24 INFO - 2015-12-30 16:23:24,040 DEBUG : BROWSER_OUTPUT: 16:23:27 INFO - 2015-12-30 16:23:27,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38486/tests/kraken/driver.html?testName=imaging-desaturate) 16:23:27 INFO - 2015-12-30 16:23:27,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 160649216 16:23:27 INFO - 2015-12-30 16:23:27,976 DEBUG : BROWSER_OUTPUT: 16:23:30 INFO - 2015-12-30 16:23:30,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38486/tests/kraken/driver.html?testName=json-parse-financial) 16:23:31 INFO - 2015-12-30 16:23:31,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 162263040 16:23:31 INFO - 2015-12-30 16:23:31,323 DEBUG : BROWSER_OUTPUT: 16:23:32 INFO - 2015-12-30 16:23:32,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38486/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:23:33 INFO - 2015-12-30 16:23:33,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 166526976 16:23:33 INFO - 2015-12-30 16:23:33,418 DEBUG : BROWSER_OUTPUT: 16:23:35 INFO - 2015-12-30 16:23:35,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38486/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:23:35 INFO - 2015-12-30 16:23:35,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 164155392 16:23:35 INFO - 2015-12-30 16:23:35,770 DEBUG : BROWSER_OUTPUT: 16:23:37 INFO - 2015-12-30 16:23:37,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38486/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:23:38 INFO - 2015-12-30 16:23:38,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 180805632 16:23:38 INFO - 2015-12-30 16:23:38,342 DEBUG : BROWSER_OUTPUT: 16:23:40 INFO - 2015-12-30 16:23:40,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38486/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:23:41 INFO - 2015-12-30 16:23:41,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 181682176 16:23:41 INFO - 2015-12-30 16:23:41,327 DEBUG : BROWSER_OUTPUT: 16:23:43 INFO - 2015-12-30 16:23:43,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38486/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:23:44 INFO - 2015-12-30 16:23:44,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 182718464 16:23:44 INFO - 2015-12-30 16:23:44,412 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38486/tests/kraken/driver.html?testName=ai-astar) 16:23:46 INFO - 2015-12-30 16:23:46,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 238510080 16:23:46 INFO - 2015-12-30 16:23:46,323 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,324 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:23:46 INFO - 2015-12-30 16:23:46,325 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:23:46 INFO - 2015-12-30 16:23:46,325 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:23:46 INFO - 2015-12-30 16:23:46,325 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:23:46 INFO - 2015-12-30 16:23:46,325 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;104;109;111;112;101;111;111;111 16:23:46 INFO - 2015-12-30 16:23:46,326 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;124;146;160;124;151;149;122;159;122 16:23:46 INFO - 2015-12-30 16:23:46,326 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;161;161;160;160;161;162;161;161 16:23:46 INFO - 2015-12-30 16:23:46,326 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;70;165;77;70;70;73;151;70 16:23:46 INFO - 2015-12-30 16:23:46,326 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;139;92;98;92;149;92;93;132 16:23:46 INFO - 2015-12-30 16:23:46,326 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;110;109;109;109;109 16:23:46 INFO - 2015-12-30 16:23:46,326 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;145;145;145;146;145;146;145;146 16:23:46 INFO - 2015-12-30 16:23:46,326 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;95;95;96;96;95;96 16:23:46 INFO - 2015-12-30 16:23:46,326 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;58;58;57;56;57;58;58;55;55 16:23:46 INFO - 2015-12-30 16:23:46,327 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;64;64;64;64;65;63;64;64 16:23:46 INFO - 2015-12-30 16:23:46,327 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;80;81;82;81;81;79;81;80;93 16:23:46 INFO - 2015-12-30 16:23:46,327 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;128;117;111;112;128;126;118;122;118 16:23:46 INFO - 2015-12-30 16:23:46,327 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;134;147;152;148;137;146;146;146;135 16:23:46 INFO - 2015-12-30 16:23:46,327 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;65;65;65;66;65;66;66;66 16:23:46 INFO - 2015-12-30 16:23:46,327 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:23:46 INFO - 2015-12-30 16:23:46,328 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:23:46 INFO - 2015-12-30 16:23:46,329 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,902 16:23:46 INFO - 2015-12-30 16:23:46,329 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:23:46 INFO - 2015-12-30 16:23:46,329 DEBUG : BROWSER_OUTPUT: __startTimestamp1451521426324__endTimestamp 16:23:46 INFO - 2015-12-30 16:23:46,329 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,329 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:23:46 INFO - 2015-12-30 16:23:46,329 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:23:46 INFO - 2015-12-30 16:23:46,329 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,330 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:3.58 (3.2%) stddev-sans-first:3.79 16:23:46 INFO - 2015-12-30 16:23:46,330 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 104.0 109.0 111.0 112.0 101.0 111.0 111.0 111.0 16:23:46 INFO - 2015-12-30 16:23:46,330 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,330 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.50 Median:148.50 stddev:15.71 (10.6%) stddev-sans-first:16.42 16:23:46 INFO - 2015-12-30 16:23:46,330 DEBUG : BROWSER_OUTPUT: Values: 148.0 124.0 146.0 160.0 124.0 151.0 149.0 122.0 159.0 122.0 16:23:46 INFO - 2015-12-30 16:23:46,330 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,330 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 16:23:46 INFO - 2015-12-30 16:23:46,331 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 161.0 161.0 160.0 160.0 161.0 162.0 161.0 161.0 16:23:46 INFO - 2015-12-30 16:23:46,331 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,331 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.90 Median:70.50 stddev:36.63 (52.0%) stddev-sans-first:38.34 16:23:46 INFO - 2015-12-30 16:23:46,331 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 70.0 165.0 77.0 70.0 70.0 73.0 151.0 70.0 16:23:46 INFO - 2015-12-30 16:23:46,331 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,331 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:92.50 stddev:22.92 (24.8%) stddev-sans-first:23.79 16:23:46 INFO - 2015-12-30 16:23:46,331 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 139.0 92.0 98.0 92.0 149.0 92.0 93.0 132.0 16:23:46 INFO - 2015-12-30 16:23:46,332 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,332 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:23:46 INFO - 2015-12-30 16:23:46,332 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 16:23:46 INFO - 2015-12-30 16:23:46,332 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,332 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 16:23:46 INFO - 2015-12-30 16:23:46,332 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 16:23:46 INFO - 2015-12-30 16:23:46,332 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,332 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:23:46 INFO - 2015-12-30 16:23:46,332 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 16:23:46 INFO - 2015-12-30 16:23:46,333 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,333 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.50 stddev:1.20 (2.1%) stddev-sans-first:1.27 16:23:46 INFO - 2015-12-30 16:23:46,333 DEBUG : BROWSER_OUTPUT: Values: 57.0 58.0 58.0 57.0 56.0 57.0 58.0 58.0 55.0 55.0 16:23:46 INFO - 2015-12-30 16:23:46,333 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,333 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 16:23:46 INFO - 2015-12-30 16:23:46,333 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 64.0 64.0 64.0 64.0 65.0 63.0 64.0 64.0 16:23:46 INFO - 2015-12-30 16:23:46,333 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,333 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:81.00 stddev:4.28 (5.3%) stddev-sans-first:4.21 16:23:46 INFO - 2015-12-30 16:23:46,333 DEBUG : BROWSER_OUTPUT: Values: 87.0 80.0 81.0 82.0 81.0 81.0 79.0 81.0 80.0 93.0 16:23:46 INFO - 2015-12-30 16:23:46,334 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,334 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:120.00 stddev:6.13 (5.1%) stddev-sans-first:6.42 16:23:46 INFO - 2015-12-30 16:23:46,334 DEBUG : BROWSER_OUTPUT: Values: 117.0 128.0 117.0 111.0 112.0 128.0 126.0 118.0 122.0 118.0 16:23:46 INFO - 2015-12-30 16:23:46,334 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,334 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:146.00 stddev:6.14 (4.2%) stddev-sans-first:6.41 16:23:46 INFO - 2015-12-30 16:23:46,334 DEBUG : BROWSER_OUTPUT: Values: 140.0 134.0 147.0 152.0 148.0 137.0 146.0 146.0 146.0 135.0 16:23:46 INFO - 2015-12-30 16:23:46,334 DEBUG : BROWSER_OUTPUT: 16:23:46 INFO - 2015-12-30 16:23:46,334 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 16:23:46 INFO - 2015-12-30 16:23:46,334 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 65.0 65.0 65.0 66.0 65.0 66.0 66.0 66.0 16:23:46 INFO - 2015-12-30 16:23:46,334 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:23:46 INFO - 2015-12-30 16:23:46,335 DEBUG : BROWSER_OUTPUT: 16:23:47 INFO - 2015-12-30 16:23:47,141 INFO : Browser exited with error code: 0 16:23:47 INFO - 2015-12-30 16:23:47,195 INFO : Completed test kraken (00:00:58) 16:23:47 INFO - 2015-12-30 16:23:47,195 INFO : Starting test v8_7 16:23:47 INFO - 2015-12-30 16:23:47,195 DEBUG : operating with platform_type : linux_ 16:23:47 INFO - 2015-12-30 16:23:47,195 INFO : Initialising browser for v8_7 test... 16:23:47 INFO - 2015-12-30 16:23:47,202 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHG4GMH/profile http://localhost:38486/getInfo.html 16:23:51 INFO - 2015-12-30 16:23:51,350 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:23:51 INFO - 2015-12-30 16:23:51,350 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:23:51 INFO - 2015-12-30 16:23:51,350 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:23:51 INFO - 2015-12-30 16:23:51,350 DEBUG : BROWSER_OUTPUT: __metrics 16:23:51 INFO - 2015-12-30 16:23:51,499 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:23:52 INFO - 2015-12-30 16:23:52,270 INFO : Browser initialized. 16:23:52 INFO - 2015-12-30 16:23:52,271 INFO : Running cycle 1/1 for v8_7 test... 16:23:52 INFO - 2015-12-30 16:23:52,271 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHG4GMH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:24:04 INFO - 2015-12-30 16:24:04,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 136085504 16:24:04 INFO - 2015-12-30 16:24:04,077 DEBUG : BROWSER_OUTPUT: 16:24:25 INFO - 2015-12-30 16:24:25,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38486/tests/v8_7/run.html (next: http://localhost:38486/tests/v8_7/run.html) 16:24:25 INFO - 2015-12-30 16:24:25,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 431718400 16:24:25 INFO - 2015-12-30 16:24:25,701 DEBUG : BROWSER_OUTPUT: 16:24:25 INFO - 2015-12-30 16:24:25,702 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:24:25 INFO - 2015-12-30 16:24:25,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:24:25 INFO - 2015-12-30 16:24:25,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:24:25 INFO - 2015-12-30 16:24:25,703 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:24:25 INFO - 2015-12-30 16:24:25,703 DEBUG : BROWSER_OUTPUT: |0;Richards;167.19612104999163 16:24:25 INFO - 2015-12-30 16:24:25,703 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.61111111111111 16:24:25 INFO - 2015-12-30 16:24:25,703 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 16:24:25 INFO - 2015-12-30 16:24:25,703 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5229.166666666667 16:24:25 INFO - 2015-12-30 16:24:25,703 DEBUG : BROWSER_OUTPUT: |4;RayTrace;960.6147934678194 16:24:25 INFO - 2015-12-30 16:24:25,704 DEBUG : BROWSER_OUTPUT: |5;Earley;556.1735261401557 16:24:25 INFO - 2015-12-30 16:24:25,704 DEBUG : BROWSER_OUTPUT: |6;Boyer;11109.89010989011 16:24:25 INFO - 2015-12-30 16:24:25,704 DEBUG : BROWSER_OUTPUT: |7;RegExp;24707.317073170732 16:24:25 INFO - 2015-12-30 16:24:25,704 DEBUG : BROWSER_OUTPUT: |8;Splay;511.2474437627812 16:24:25 INFO - 2015-12-30 16:24:25,704 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 16:24:25 INFO - 2015-12-30 16:24:25,704 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:24:25 INFO - 2015-12-30 16:24:25,704 DEBUG : BROWSER_OUTPUT: __startTimestamp1451521465702__endTimestamp 16:24:25 INFO - 2015-12-30 16:24:25,705 DEBUG : BROWSER_OUTPUT: 16:24:25 INFO - 2015-12-30 16:24:25,705 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:24:25 INFO - 2015-12-30 16:24:25,705 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:24:25 INFO - 2015-12-30 16:24:25,705 DEBUG : BROWSER_OUTPUT: 16:24:25 INFO - 2015-12-30 16:24:25,705 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.20 Median:167.20 stddev:0.00 (0.0%) 16:24:25 INFO - 2015-12-30 16:24:25,707 DEBUG : BROWSER_OUTPUT: Values: 167.2 16:24:25 INFO - 2015-12-30 16:24:25,707 DEBUG : BROWSER_OUTPUT: 16:24:25 INFO - 2015-12-30 16:24:25,707 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.61 Median:173.61 stddev:0.00 (0.0%) 16:24:25 INFO - 2015-12-30 16:24:25,707 DEBUG : BROWSER_OUTPUT: Values: 173.6 16:24:25 INFO - 2015-12-30 16:24:25,707 DEBUG : BROWSER_OUTPUT: 16:24:25 INFO - 2015-12-30 16:24:25,707 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 16:24:25 INFO - 2015-12-30 16:24:25,708 DEBUG : BROWSER_OUTPUT: Values: 279.3 16:24:25 INFO - 2015-12-30 16:24:25,708 DEBUG : BROWSER_OUTPUT: 16:24:25 INFO - 2015-12-30 16:24:25,708 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 16:24:25 INFO - 2015-12-30 16:24:25,708 DEBUG : BROWSER_OUTPUT: Values: 5229.2 16:24:25 INFO - 2015-12-30 16:24:25,708 DEBUG : BROWSER_OUTPUT: 16:24:25 INFO - 2015-12-30 16:24:25,708 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:960.61 Median:960.61 stddev:0.00 (0.0%) 16:24:25 INFO - 2015-12-30 16:24:25,708 DEBUG : BROWSER_OUTPUT: Values: 960.6 16:24:25 INFO - 2015-12-30 16:24:25,709 DEBUG : BROWSER_OUTPUT: 16:24:25 INFO - 2015-12-30 16:24:25,709 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:556.17 Median:556.17 stddev:0.00 (0.0%) 16:24:25 INFO - 2015-12-30 16:24:25,709 DEBUG : BROWSER_OUTPUT: Values: 556.2 16:24:25 INFO - 2015-12-30 16:24:25,709 DEBUG : BROWSER_OUTPUT: 16:24:25 INFO - 2015-12-30 16:24:25,709 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11109.89 Median:11109.89 stddev:0.00 (0.0%) 16:24:25 INFO - 2015-12-30 16:24:25,709 DEBUG : BROWSER_OUTPUT: Values: 11109.9 16:24:25 INFO - 2015-12-30 16:24:25,709 DEBUG : BROWSER_OUTPUT: 16:24:25 INFO - 2015-12-30 16:24:25,709 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24707.32 Median:24707.32 stddev:0.00 (0.0%) 16:24:25 INFO - 2015-12-30 16:24:25,709 DEBUG : BROWSER_OUTPUT: Values: 24707.3 16:24:25 INFO - 2015-12-30 16:24:25,709 DEBUG : BROWSER_OUTPUT: 16:24:25 INFO - 2015-12-30 16:24:25,709 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:511.25 Median:511.25 stddev:0.00 (0.0%) 16:24:25 INFO - 2015-12-30 16:24:25,709 DEBUG : BROWSER_OUTPUT: Values: 511.2 16:24:25 INFO - 2015-12-30 16:24:25,710 DEBUG : BROWSER_OUTPUT: 16:24:25 INFO - 2015-12-30 16:24:25,710 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 16:24:25 INFO - 2015-12-30 16:24:25,710 DEBUG : BROWSER_OUTPUT: Values: 4835.7 16:24:25 INFO - 2015-12-30 16:24:25,710 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:24:25 INFO - 2015-12-30 16:24:25,710 DEBUG : BROWSER_OUTPUT: 16:24:26 INFO - 2015-12-30 16:24:26,513 INFO : Browser exited with error code: 0 16:24:26 INFO - 2015-12-30 16:24:26,528 INFO : Completed test v8_7 (00:00:39) 16:24:26 INFO - 2015-12-30 16:24:26,734 INFO : Completed test suite (00:20:09) 16:24:26 INFO - 2015-12-30 16:24:26,734 DEBUG : Working with test: dromaeo_css 16:24:26 INFO - 2015-12-30 16:24:26,734 DEBUG : Generating results file: dromaeo_css 16:24:26 INFO - 2015-12-30 16:24:26,735 DEBUG : Working with test: kraken 16:24:26 INFO - 2015-12-30 16:24:26,735 DEBUG : Generating results file: kraken 16:24:26 INFO - 2015-12-30 16:24:26,736 INFO : javascript benchmark 16:24:26 INFO - 2015-12-30 16:24:26,736 DEBUG : Working with test: v8_7 16:24:26 INFO - 2015-12-30 16:24:26,736 DEBUG : Generating results file: v8_7 16:24:26 INFO - 2015-12-30 16:24:26,736 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:24:26 INFO - 2015-12-30 16:24:26,789 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 16:24:26 INFO - 2015-12-30 16:24:26,789 DEBUG : process_Request line: dromaeo_css 7316.37 graph.html#tests=[[72,52,35]] 16:24:26 INFO - 2015-12-30 16:24:26,789 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:24:26 INFO - 2015-12-30 16:24:26,818 DEBUG : process_Request line: kraken 1488.40 graph.html#tests=[[232,52,35]] 16:24:26 INFO - 2015-12-30 16:24:26,818 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:24:26 INFO - 2015-12-30 16:24:26,857 DEBUG : process_Request line: v8_7 22948.96 graph.html#tests=[[230,52,35]] 16:24:26 INFO - 2015-12-30 16:24:26,858 INFO : javascript benchmark 16:24:26 INFO - 2015-12-30 16:24:26,861 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3258.3809076275506, 3297.29108241728, 3334.033130392186, 3337.5828021497314, 3356.043527594636, 5475.67145971242, 5500.889982200353, 5507.063799154143, 5509.889802203958, 5510.614257002001, 5506.64206826556, 5523.502884740373, 5523.6685798852095, 5534.889302213964, 5549.306336707911, 4953.900921981558, 5029.195328747401, 5036.571891389236, 5042.798288068473, 5136.280920671109, 4935.259711043336, 4998.375203099613, 5058.418281897573, 5061.291419201315, 5062.392512898439, 5011.974940125294, 5086.491350864902, 5089.134847075988, 5089.618278629099, 5109.693418394908, 5038.823641172559, 5131.3329267195395, 5139.871503212412, 5150.0, 5174.560162386202, 4819.759012049419, 4872.561469467765, 4896.853094407174, 5027.1705168647495, 5044.39467263927, 5346.224797404393, 5348.786048558053, 5349.796295833446, 5352.036633405985, 5356.517913387775, 5887.941120588782, 5892.616979896293, 5939.1388248704125, 5943.970280148615, 5952.494038006775, 5715.485606295453, 5743.138529220609, 5810.418958104198, 5814.651120932757, 5971.283445986466, 5522.723863806794, 5630.183623374629, 5638.9154162688, 5650.378458369576, 5654.519365853907, 6111.877762444815, 6133.938660613426, 6137.96931015342, 6138.541671868612, 6143.170671959318, 5625.859353516113, 5721.399253078367, 5772.3938986406665, 5854.941450585525, 5895.64626122434, 5882.941170588239, 5884.558658100659, 5888.263967004124, 5907.172995780508, 6006.189164462829, 5735.627184233012, 5780.624259423124, 5846.94153058464, 5847.0, 5864.941350586525, 5789.623674461231, 5864.589478736533, 5905.46850783423, 5936.970315148396, 5938.376470470625, 4534.523874993079, 4535.433070866142, 4536.183486972311, 4541.137183935108, 4553.726776393427, 3981.3828856527284, 4059.086705491241, 4079.7756123412905, 4101.364288535282, 4130.215259100822, 5442.537384322298, 5494.642848214853, 5507.03626865297, 5518.034343989866, 5538.833834984957, 5984.910226346608, 5985.281766187998, 5985.40145985398, 5987.341392446828, 5989.520838332923, 5326.760295786699, 5426.538744206708, 5586.636868603528, 5702.344230413555, 5712.200291959129, 4942.851714448572, 4947.876303092451, 4948.950510494921, 4956.330895329156, 5047.772850221749, 6005.669688167192, 6007.189029481052, 6022.849428764316, 6030.216071910623, 6036.3058248302, 5703.08750599902, 5744.511716504144, 5875.853103672443, 5893.410658934073, 5915.497182739343, 6001.219841420588, 6140.539459540463, 6147.385261473817, 6147.569670123227, 6167.0, 5929.0, 5933.1396947443245, 5946.226990491208, 5946.910796338145, 5947.0, 5758.2514273144225, 5802.593818432838, 5820.70896455184, 5924.674142922181, 5966.701664916824, 5708.486236238592, 5711.885762284648, 5715.428457154251, 5726.627769194989, 5756.827295181151, 5623.0721930880945, 5696.772129114955, 5699.316082070178, 5704.258446401941, 5705.315362156568, 5667.829965101054, 5698.857528561819, 5753.1370294456165, 5756.769729210952, 5781.046127388934, 5690.601657883908, 5696.401877802771, 5710.828675139753, 5721.427857214246, 5778.0, 5537.058700020925, 5560.5551555876245, 5565.499105080562, 5568.777248909998, 5651.689157096399], "unit": "ms", "name": "dojo.html", "value": 5433.826203109337}, {"lowerIsBetter": false, "replicates": [574.5087949802919, 607.9088136779483, 619.1115748900328, 632.0487666062575, 633.5628416392685, 39535.80232098843, 40404.393934091015, 40426.79786601063, 40495.79752101239, 40499.0, 42965.570344296546, 43487.0, 43581.0, 43611.78194109033, 43719.78140109303, 8099.716509922154, 8203.220694034057, 8203.876941845878, 8937.731868043953, 9196.816063678722, 10914.781704365909, 11100.722481937975, 11129.220954533186, 11138.108951283877, 11150.776984460306, 10849.83725244118, 10951.069159121484, 10961.616343427982, 10970.286931349478, 10973.177011724112, 8279.54462504562, 8454.619542120558, 8459.619317130744, 10767.407792571405, 10883.727906802314, 10640.946795265974, 10735.83896241557, 10737.677869663923, 10780.73048173794, 10790.298630588986, 42737.0, 43267.567324326985, 43380.132397352194, 43381.349279760514, 43426.34860477095, 3616.8191590420374, 3729.9440508392127, 3730.4963829883163, 3782.9054273643105, 4193.391958166079, 31002.224944376347, 31064.0, 31536.211594710087, 31653.0, 31751.36497270065, 3872.7730066828394, 3939.702302565942, 3965.0, 3986.202759448093, 4008.198360327946, 283807.0, 284176.0, 284876.0, 286056.0, 286057.5697121522, 59080.11379829306, 59385.40614593799, 64167.0, 64532.0, 73400.0, 66289.66855165693, 66454.0, 66705.0, 66766.0, 66815.66592167105, 17026.31894724222, 17203.311867525408, 17248.827511724972, 17250.309987600605, 17266.136693165543, 13904.374303156383, 14064.789028164585, 14065.789013164811, 14078.436862525385, 14086.366113524711, 22011.449713756963, 22147.446313842283, 22377.88811055967, 22399.88800055989, 22418.88790556037, 8358.45670031446, 8456.408051436463, 8463.830723385498, 8502.44734092282, 8608.053114157437, 975.7560609847538, 1019.6686077024997, 1136.9943150284196, 1143.8112711402525, 1149.3965668024186, 29772.404551909272, 30144.397112057635, 30711.8464407681, 30784.230394239876, 31014.22464438362, 1081.405227125078, 1132.8867113288604, 1202.1644956754972, 1222.3460448659923, 1251.6933351328983, 13777.0, 15756.448524301595, 16179.514614561582, 16635.584110397336, 17051.658966820592, 407469.0, 408989.0, 410409.0, 410737.0, 411082.0, 58227.12659310114, 58371.0, 59063.40936590665, 65711.67144164344, 67023.3297667017, 1449.7535418978798, 1460.9196494192709, 1470.8970372074066, 1481.5777503411475, 1490.1431676785892, 29391.85304073466, 30379.392412151192, 31069.533956991116, 33392.833035834665, 34636.0, 53469.46530534645, 54162.45837541574, 54194.0, 54233.0, 54258.72870635622, 307565.0, 310089.8991010061, 310596.0, 310827.0, 311284.0, 44502.55497444984, 45101.54898450973, 46594.301085483065, 47359.0, 47491.76254118846, 42979.38583879389, 46217.30674039825, 47168.528314716415, 47221.527784721715, 47251.76374118107, 38985.94077176099, 39532.60467395289, 39693.60306396899, 39923.0, 40589.39115913204, 38726.419103712906, 39461.64576011071, 39559.0, 40134.0, 40164.59835401725, 38390.0, 38762.6123738759, 38931.610683892795, 39175.41236881506, 39215.607843922335, 33966.49050264298, 35381.29237415186, 37805.0, 39525.95095530415, 40233.39649905195, 26493.867530662224, 26893.327666808487, 26995.460090798468, 27115.72884271132, 27137.0], "unit": "ms", "name": "ext.html", "value": 20617.223040513127}, {"lowerIsBetter": false, "replicates": [389.9239648268587, 391.9039835240367, 393.25085711719174, 395.75858726177034, 399.2095650611787, 14881.25593720315, 16892.324307027735, 17393.217305221264, 18697.345592904236, 18712.90643546782, 17355.132243387812, 17826.554336141602, 17854.196561154746, 18408.263669453238, 18839.623207535842, 5031.622628302874, 5127.154019586782, 5129.3844738631415, 5138.820141295056, 5145.0481660892665, 3879.243547508237, 3961.5642279349395, 5105.259737338084, 5425.077736784756, 5518.2826232589705, 5450.018996580614, 5483.095289277265, 5483.972580137094, 5504.22940788288, 5504.889902201973, 5443.455654434564, 6099.57302988791, 6100.023996160593, 6104.206453161083, 6105.297890742577, 5458.235846981386, 5471.398146203955, 5473.124300111963, 5475.370332411784, 5495.477929596682, 19721.21115155392, 19740.0, 19980.60038799216, 19985.200591976303, 20404.693929591067, 2161.189553917281, 2169.1648715244587, 2185.573813106445, 2194.890255487235, 2264.1509433962265, 9071.59177836999, 9341.346105772598, 9596.18432433244, 9783.217342612574, 9957.651482198089, 1916.9520761980923, 1921.7597800274966, 1924.8845069295887, 1947.5325921778813, 1958.6572349838864, 38672.806635966925, 38750.0, 38964.02589935246, 48643.27035094441, 53997.73001135008, 11042.834357484644, 11052.502637381338, 11061.502232399562, 11064.557417703201, 11153.888461115448, 14654.633634159018, 14726.484573039892, 14743.336549855283, 14753.704925901637, 14769.113853168845, 8132.878006829902, 8139.715109971123, 8148.348132149533, 8169.877451838227, 8184.549849758201, 7700.576468294185, 7783.649735761905, 7801.336886364723, 7853.685852565947, 7863.174366691415, 4843.007183527439, 4914.459409464956, 4927.0, 4961.479044700327, 4964.503549645006, 1705.0187903807887, 1942.951426214356, 1961.225316000172, 1974.7136665183755, 2013.3456626596414, 419.92231437184216, 429.6734481793859, 459.7195710616521, 999.9350042247377, 1038.0138868075358, 10654.147668186526, 10956.28784129029, 11195.2723073, 17824.0, 18917.621647567248, 1011.8431643095332, 1021.279997601689, 1058.867641544807, 1066.1524088349781, 1088.9654827913514, 9956.0, 10296.485175741183, 10298.948505257576, 10304.793904121876, 10389.636362727419, 581748.0, 592934.0, 622534.0, 651964.0, 652913.0, 84345.57827210825, 85620.57189714136, 86648.0, 88969.55515222382, 89330.0, 1175.641429364035, 1200.3135594489581, 1203.0315595945349, 1223.253815172744, 1245.9875401246052, 16440.177991100638, 16546.917265413595, 16604.00375977397, 16690.082045487616, 16794.58013549622, 34968.30063398769, 35609.28781424305, 35804.0, 36739.0, 37984.43023354707, 48215.75892120517, 48844.755776222315, 50174.74912625414, 51542.484575153765, 52773.472265276854, 9722.465264410524, 9766.414015159113, 10077.949610251902, 10086.848697269694, 10094.949525252327, 11331.433428328715, 11415.885841141482, 11535.884641153481, 19116.0, 19206.519837003627, 14938.327775250356, 15670.608234794221, 15983.44057957966, 16000.279987400827, 16214.51356459308, 14812.851871481147, 15013.399464021753, 15235.466758663393, 15752.763708544151, 15824.525264242091, 7846.568438735924, 9555.041216550451, 15773.842261577696, 16118.194090295205, 16165.515034548982, 9405.388649737744, 9633.662821801483, 9734.561944712363, 9740.415575065519, 9761.121499065119, 10859.0, 11332.866713328602, 14962.925185374004, 15055.02142360743, 15469.458568950033], "unit": "ms", "name": "jquery.html", "value": 8997.61723310329}, {"lowerIsBetter": false, "replicates": [1545.350952599908, 1546.056905287775, 1655.710250706126, 1794.129847024193, 1831.2217307644248, 6980.267071957441, 7826.139124696286, 7935.761927142195, 7936.325412339944, 7938.6824527018925, 7842.215778422155, 7986.960065199666, 7988.800279993003, 7993.1607181246, 7997.680092796296, 1996.2414282572602, 2028.6044221376837, 2029.9898500507477, 2268.6370180771037, 2298.5173113646156, 2282.5777231212196, 2323.2333330001143, 2323.581755284048, 2325.395397196724, 2326.26722582386, 2268.5009297954507, 2289.1301305503885, 2316.339843144704, 2319.3621754017613, 2321.6169332060276, 2303.0672577606015, 2317.756635553268, 2337.5909215887236, 2360.5042940982416, 2360.7285162206394, 2288.7139107611547, 2289.8740569268684, 2319.489712263299, 2321.466062805564, 2323.604987152188, 7909.446338756289, 8004.759857204235, 8005.119436861941, 8006.879896801553, 8016.879746803803, 4755.405574303212, 4792.664513484057, 4816.373871396731, 4828.637852161102, 4830.178869592178, 2942.4262268857583, 3025.379797141603, 3062.6631070582216, 3078.81527108372, 3082.1370016395445, 965.8744363232735, 973.5542719062187, 974.57605941415, 1021.0504231065106, 1034.6327053895834, 10623.84064239037, 10691.518881650421, 10706.41114738689, 10712.41081740504, 10723.83914241287, 4142.834286628501, 4155.480564929384, 4221.838994276537, 4230.111676547959, 4233.724807887477, 8886.11138886119, 8927.33045021613, 8929.0, 8941.195292423714, 8942.329325300629, 4763.7141771493125, 4778.880527986758, 4784.30627559002, 4824.903501929942, 4826.396700412449, 4401.22978478765, 4410.691251612357, 4449.243628583149, 4460.286354183315, 4463.174312752087, 3353.5975682918206, 3363.630000699921, 3384.881529146517, 3389.983050084734, 3398.9972957977457, 1113.3932007056173, 1135.8523391958993, 1140.122105978392, 1141.6289705845468, 1143.8284257361297, 1265.8923991460829, 1440.287057906343, 1445.2412483446276, 1457.7813328000884, 1496.2892626002563, 7459.142198647117, 7521.135069467081, 7597.772066838003, 7601.581912994839, 7602.0, 610.2707264818499, 610.2829175718601, 612.3050337866465, 629.515273239603, 779.8341479488088, 5961.850953726105, 6059.0, 6110.908336374958, 6133.172021777003, 6139.171211886338, 9434.952825235967, 9598.088181622734, 9690.176335011462, 9710.75723106914, 9730.659426920023, 9174.128457796498, 9515.23878089751, 9576.952115239379, 9632.0, 9655.758606034906, 7501.737439189711, 7560.8487830244185, 7574.0, 7623.580703061274, 7633.122190948001, 7292.744753933587, 7365.189829118685, 7415.666295016629, 7429.44279179053, 7431.29402706742, 8490.533020683923, 8552.615132318937, 8655.999999999749, 8679.0, 8692.0, 8720.476771393736, 8768.0, 8847.336449766422, 8870.068642792414, 9010.098990100938, 6909.861802763816, 6911.447084233148, 6950.374466298057, 6979.371856532734, 6979.441644668516, 6768.492363072691, 6883.518153729191, 7520.323170914644, 7682.577458239851, 7791.220877912164, 7151.177614574391, 7291.890621640786, 7296.817579560341, 7309.086364204474, 7364.742234021784, 7155.177154627285, 7218.711251550089, 7223.1693355264815, 7275.636218189175, 7312.96343518279, 7126.608036558039, 7164.247753985965, 7164.641767911688, 7194.028806111108, 7209.0, 6619.404253617197, 6656.0, 6657.5672581284, 6658.900116498159, 6660.866782664222, 6864.141982252218, 6885.724571017103, 6889.517733758589, 6894.310568943066, 6901.447884169154], "unit": "ms", "name": "mootools.html", "value": 4507.653677895521}, {"lowerIsBetter": false, "replicates": [345.35246412975664, 353.31104346524285, 353.67815288087843, 354.6028448138086, 357.0, 5948.940510594893, 6095.116208149816, 6133.478654314383, 6199.411055949683, 6230.688465576725, 5908.438698323653, 5984.072468767348, 6008.879822403549, 6009.969950150243, 6074.058520929263, 4710.175719249135, 4736.810527578893, 4738.535961300122, 4740.573348398643, 4744.383230180089, 4543.227651299287, 4611.239145540999, 4656.97671511642, 4703.0, 4745.786439610209, 4655.13879932212, 4660.16117098922, 4705.176594096037, 4709.293605959117, 4711.505291944348, 4681.765911704419, 4685.648576356787, 4699.835505757316, 4709.740964246965, 4730.219513780222, 4152.647025002879, 4155.23128221277, 4155.23128221277, 4157.10622216225, 4163.02168990287, 5697.6296540724725, 5781.450762177628, 5790.913136302959, 5802.883942321172, 5807.2160258365, 5513.365962914276, 5520.089185284423, 5523.0, 5527.778888844441, 5529.060059789846, 6197.752089916398, 6515.3484651534945, 6515.641639709814, 6523.869522609569, 6527.510436717265, 4506.211413002711, 4522.5025247222775, 4634.374359461497, 4637.768111594441, 4638.420197475316, 6770.966145169243, 6806.5235433520165, 6807.285235050298, 6809.727610895558, 6809.761658341934, 4741.502142275081, 4745.762711864393, 4745.786439610226, 4748.738819364969, 4750.453697824725, 4703.882402939886, 4802.903941921142, 4810.759462026885, 4813.109574728686, 4833.299171620166, 5509.586780991442, 5514.283143191359, 5524.364698059774, 5528.806491772769, 5529.668219906818, 6556.606603603799, 6574.539782215199, 6575.44108750752, 6575.967120164464, 6576.0, 1675.6648670265995, 1704.2330951072067, 1704.250129942821, 1704.880658353928, 1706.8378504042096, 1082.426314053553, 1098.8901109888948, 1103.3490240757992, 1111.8776934537195, 1111.9777604447866, 6275.6862156891975, 6329.240491141092, 6329.873402531924, 6334.144890439732, 6338.904916426257, 6704.061431399608, 6732.124823772976, 6735.0, 6739.865202695919, 6741.898871516931, 6195.287541932646, 6300.0, 6336.52476064297, 6341.302456729756, 6342.651154186564, 3588.7129029678085, 3642.7996460194413, 3643.5809881863397, 3650.324689932371, 3651.561812582507, 6910.30896910315, 6920.9653951730925, 6922.857728474745, 6926.238113807477, 6930.272321406281, 6793.31549734456, 6860.451163906875, 6860.6912688929115, 6873.037774711544, 6873.312668733087, 6835.726570937107, 6840.144981877265, 6887.380135787803, 6901.309869013058, 6902.551334163364, 6537.1174891389055, 6704.631245281556, 6717.395434410926, 6721.764738234138, 6738.292479289604, 6708.161479815023, 6739.59562426256, 6751.729930802713, 6753.493487988322, 6759.357861003196, 7020.6489675514995, 7026.754063607749, 7032.824179395556, 7039.331263529956, 7040.0847889774, 4581.793819278074, 4622.098690755271, 4651.116287905287, 4654.418197725285, 4667.789949452351, 6784.253732089565, 6811.965940170466, 6813.4889883257965, 6819.215790184192, 6820.045193672989, 6645.235797883112, 6646.83382915431, 6650.83372915681, 6654.201495820533, 6657.2677005528385, 6466.159399278064, 6584.407403333723, 6597.80206593803, 6608.900866486911, 6625.933740662725, 6520.902186467301, 6526.804195874131, 6531.444827189742, 6533.18335208099, 6534.8366290843105, 6656.900146497709, 6658.900116498159, 6664.233613134357, 6668.266490685924, 6669.1330127083165, 6339.683015849281, 6457.903131452938, 6459.192600924885, 6462.547621666438, 6462.612243265419], "unit": "ms", "name": "prototype.html", "value": 4950.000612625066}, {"lowerIsBetter": false, "replicates": [876.6756300168936, 890.5586864259374, 938.3009657804936, 941.2375975459873, 962.3311798300175, 14051.5081972131, 14586.70826583469, 14597.124172549655, 14605.78091328631, 14614.0, 14584.270786460687, 14597.708045839077, 14624.926875365634, 14693.118412895206, 14694.926525367386, 777.50239846498, 786.952782833029, 908.8863892013499, 917.5183028909843, 939.7603611079165, 936.8501039833628, 937.6905621145006, 943.6131186213654, 946.3139224062569, 946.4936259101382, 809.4091313341264, 984.0602224875227, 994.1947022911465, 994.9354191015616, 995.2137811129236, 803.0283357137841, 968.389914353956, 980.1766516126488, 980.5440470181329, 983.5229913491951, 723.0528008309132, 728.6393235348484, 728.7995801154672, 730.2989130434789, 730.8867125595541, 14956.177410242432, 15302.846971530253, 15324.540263792103, 15335.616609584738, 15358.462453814063, 12576.163782598092, 12654.177478463962, 13108.410121544553, 13292.3353832308, 13898.58304250874, 11003.504842282116, 11166.441677916153, 11283.37941413222, 11384.658460246206, 11592.304461732323, 3816.274907767543, 3834.616538346171, 3858.903527411809, 3879.86420475282, 3935.291647503448, 48168.0, 48389.0, 48415.0, 48576.0, 48690.513094868955, 10671.83992240117, 10865.565377384815, 10906.0, 10942.45287735626, 10970.396628185366, 20267.59464810725, 20307.898460507604, 20340.084696188707, 20369.18523259053, 20395.694064589043, 8162.3878209134555, 8208.712695055645, 8243.216894395024, 8284.792880178044, 8326.417150799507, 4727.503612120747, 4743.075100355398, 4758.904821903542, 4766.23740201573, 4803.375561177095, 3370.4775759757276, 3385.0860267728067, 3387.237871478947, 3390.983045084808, 3392.355452464024, 587.3157771196594, 594.3462191589304, 595.5414330965133, 599.430540986065, 620.0482259731381, 670.4066900792833, 673.6295037729229, 674.4772801079105, 722.9855402891912, 737.1706829816457, 8858.202761751474, 9367.484788336571, 9499.24006079512, 9759.0, 9802.46086465237, 562.7097712310856, 577.7342422485704, 608.1516284782704, 624.9218847644045, 699.1889408286363, 4185.853495127656, 4353.564643535685, 4401.361802538614, 4448.065906159743, 4450.35469856869, 60939.39060609426, 61302.08046879301, 61662.0, 62058.68970655118, 62325.0, 55813.16280255799, 56512.71743641255, 56563.43436565664, 56576.0, 56680.14979775307, 50933.0, 51120.0, 51401.7429912848, 51849.48150518446, 51980.960380792174, 8730.083341249077, 8810.603522841358, 8883.42257753244, 8948.328875334506, 9048.050049233614, 36148.4577731329, 36253.81873090723, 37146.25707485889, 37263.813680931424, 37548.812255938545, 44986.3252051226, 45186.548134518234, 47074.0, 47992.5200748002, 48467.75766121147, 10492.317999330018, 10659.840102398626, 10990.725231869268, 11208.943955280172, 11261.549538018387, 11236.157288203254, 11339.773204536028, 11379.829302560303, 12552.686182845502, 13313.800292995806, 11543.480543375736, 11601.825972610586, 12018.459169337226, 12316.815247771112, 12862.485500579873, 11879.643610691694, 11882.597035570076, 12076.577319793765, 12259.69350766238, 12395.194312369667, 12148.39258037077, 12307.646173914376, 12628.431720572413, 12698.682532936751, 12848.42182101789, 10383.636572719919, 10626.256162068581, 10878.782424351626, 11172.664820055412, 11306.717332066764, 9980.201583873419, 10468.528916198637, 10550.89449105499, 10561.524731386953, 10614.787704245717], "unit": "ms", "name": "yui.html", "value": 6818.895090878846}], "name": "dromaeo_css", "value": 7316.370368304307}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 104.0, 109.0, 111.0, 112.0, 101.0, 111.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [148.0, 124.0, 146.0, 160.0, 124.0, 151.0, 149.0, 122.0, 159.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.5}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 160.0, 161.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 70.0, 165.0, 77.0, 70.0, 70.0, 73.0, 151.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 139.0, 92.0, 98.0, 92.0, 149.0, 92.0, 93.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 58.0, 57.0, 56.0, 57.0, 58.0, 58.0, 55.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 63.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [87.0, 80.0, 81.0, 82.0, 81.0, 81.0, 79.0, 81.0, 80.0, 93.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [117.0, 128.0, 117.0, 111.0, 112.0, 128.0, 126.0, 118.0, 122.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.7}, {"lowerIsBetter": true, "replicates": [140.0, 134.0, 147.0, 152.0, 148.0, 137.0, 146.0, 146.0, 146.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1488.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.19612104999163], "unit": "score", "name": "Richards", "value": 211.14126199999998}, {"lowerIsBetter": false, "replicates": [173.61111111111111], "unit": "score", "name": "DeltaBlue", "value": 380.8396800000001}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [960.6147934678194], "unit": "score", "name": "RayTrace", "value": 770.3285489999998}, {"lowerIsBetter": false, "replicates": [556.1735261401557], "unit": "score", "name": "Earley", "value": 1198.3004740000003}, {"lowerIsBetter": false, "replicates": [11109.89010989011], "unit": "score", "name": "Boyer", "value": 59.98826211671617}, {"lowerIsBetter": false, "replicates": [24707.317073170732], "unit": "score", "name": "RegExp", "value": 36.871061204343526}, {"lowerIsBetter": false, "replicates": [511.2474437627812], "unit": "score", "name": "Splay", "value": 159.39639600000004}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 22948.96469541556}]} 16:24:26 INFO - RETURN: dromaeo_css: 7316.37 16:24:26 INFO - RETURN: kraken: 1488.40 16:24:26 INFO - RETURN: v8_7: 22948.96 16:24:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "22948.96"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1488.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7316.37"}}} 16:24:26 INFO - Return code: 0 16:24:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:24:26 INFO - # TBPL SUCCESS # 16:24:26 INFO - Running post-action listener: _resource_record_post_action 16:24:26 INFO - Running post-run listener: _resource_record_post_run 16:24:28 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 8192; Write bytes: 515702784; Read time: 188; Write time: 774644 16:24:28 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 254087168; Read time: 0; Write time: 508132 16:24:28 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 8192; Write bytes: 261615616; Read time: 188; Write time: 266512 16:24:28 INFO - Running post-run listener: _upload_blobber_files 16:24:28 INFO - Blob upload gear active. 16:24:28 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:24:28 INFO - Copying logs to upload dir... 16:24:28 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.293008 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-30 16:24:27.796318) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-30 16:24:27.799528) ========= 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=a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009936 build_url: 'https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-30 16:24:27.851490) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:24:27.851854) ========= 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=a65b340e283ce644d68cb24e000001c9-1451520076.352728-1875649716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:24:27.902308) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 16:24:27.902680) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 16:24:27.903120) ========= ========= Total master_lag: 0.24 =========