builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1456398988.36 results: success (0) buildid: 20160225004014 builduid: 1e32cc36888047de81ca7b1b2e2666d3 revision: a6621cd9929e1b7337f85a8b8a237918c15436ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.360626) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.361083) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.361401) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008584 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.383793) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.384067) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.397315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.397616) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004714 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.446657) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.447028) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.447439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.447756) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-25 03:16:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.2M=0s 2016-02-25 03:16:28 (84.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101490 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.561892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.562205) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020760 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.613366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:28.613986) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a6621cd9929e1b7337f85a8b8a237918c15436ed --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 a6621cd9929e1b7337f85a8b8a237918c15436ed --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=aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-25 03:16:28,953 truncating revision to first 12 chars 2016-02-25 03:16:28,953 Setting DEBUG logging. 2016-02-25 03:16:28,953 attempt 1/10 2016-02-25 03:16:28,953 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a6621cd9929e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 03:16:29,443 unpacking tar archive at: mozilla-aurora-a6621cd9929e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.788361 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:29.416167) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:29.416532) ========= echo a6621cd9929e1b7337f85a8b8a237918c15436ed in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a6621cd9929e1b7337f85a8b8a237918c15436ed'] 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=aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a6621cd9929e1b7337f85a8b8a237918c15436ed program finished with exit code 0 elapsedTime=0.003289 script_repo_revision: 'a6621cd9929e1b7337f85a8b8a237918c15436ed' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:29.464338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:29.464654) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 03:16:29.474628) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-25 03:16:29.474959) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:16:29 INFO - MultiFileLogger online at 20160225 03:16:29 in /builds/slave/test-pgo 03:16:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:16:29 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:16:29 INFO - {'append_to_log': False, 03:16:29 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:16:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:16:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:16:29 INFO - 'branch': 'Mozilla-Aurora', 03:16:29 INFO - 'buildbot_json_path': 'buildprops.json', 03:16:29 INFO - 'config_files': ('talos/linux_config.py',), 03:16:29 INFO - 'default_actions': ('clobber', 03:16:29 INFO - 'read-buildbot-config', 03:16:29 INFO - 'download-and-extract', 03:16:29 INFO - 'populate-webroot', 03:16:29 INFO - 'create-virtualenv', 03:16:29 INFO - 'install', 03:16:29 INFO - 'run-tests'), 03:16:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:16:29 INFO - 'download_minidump_stackwalk': True, 03:16:29 INFO - 'download_symbols': 'ondemand', 03:16:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:16:29 INFO - 'tooltool.py': '/tools/tooltool.py', 03:16:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:16:29 INFO - '/tools/misc-python/virtualenv.py')}, 03:16:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:16:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:16:29 INFO - 'installer_path': 'installer.exe', 03:16:29 INFO - 'log_level': 'info', 03:16:29 INFO - 'log_name': 'talos', 03:16:29 INFO - 'log_to_console': True, 03:16:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:16:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:16:29 INFO - 'opt_config_files': (), 03:16:29 INFO - 'pip_index': False, 03:16:29 INFO - 'sps_profile': False, 03:16:29 INFO - 'sps_profile_interval': 0, 03:16:29 INFO - 'suite': 'dromaeojs-e10s', 03:16:29 INFO - 'system_bits': '32', 03:16:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:16:29 INFO - 'title': 'talos-linux64-ix-037', 03:16:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:16:29 INFO - 'use_talos_json': True, 03:16:29 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:16:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:16:29 INFO - 'work_dir': 'build'} 03:16:29 INFO - ##### 03:16:29 INFO - ##### Running clobber step. 03:16:29 INFO - ##### 03:16:29 INFO - Running pre-action listener: _resource_record_pre_action 03:16:29 INFO - Running main action method: clobber 03:16:29 INFO - rmtree: /builds/slave/test-pgo/build 03:16:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:16:30 INFO - Running post-action listener: _resource_record_post_action 03:16:30 INFO - ##### 03:16:30 INFO - ##### Running read-buildbot-config step. 03:16:30 INFO - ##### 03:16:30 INFO - Running pre-action listener: _resource_record_pre_action 03:16:30 INFO - Running main action method: read_buildbot_config 03:16:30 INFO - Using buildbot properties: 03:16:30 INFO - { 03:16:30 INFO - "project": "", 03:16:30 INFO - "product": "firefox", 03:16:30 INFO - "script_repo_revision": "production", 03:16:30 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:16:30 INFO - "repository": "", 03:16:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:16:30 INFO - "buildid": "20160225004014", 03:16:30 INFO - "stage_platform": "linux64-pgo", 03:16:30 INFO - "basedir": "/builds/slave/test-pgo", 03:16:30 INFO - "nightly_build": "True", 03:16:30 INFO - "buildnumber": 156, 03:16:30 INFO - "slavename": "talos-linux64-ix-037", 03:16:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:16:30 INFO - "platform": "ubuntu64_hw", 03:16:30 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:16:30 INFO - "branch": "mozilla-aurora", 03:16:30 INFO - "repo_path": "releases/mozilla-aurora", 03:16:30 INFO - "revision": "a6621cd9929e1b7337f85a8b8a237918c15436ed", 03:16:30 INFO - "pgo_build": "True", 03:16:30 INFO - "builduid": "1e32cc36888047de81ca7b1b2e2666d3", 03:16:30 INFO - "slavebuilddir": "test" 03:16:30 INFO - } 03:16:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 03:16:30 INFO - Running post-action listener: _resource_record_post_action 03:16:30 INFO - ##### 03:16:30 INFO - ##### Running download-and-extract step. 03:16:30 INFO - ##### 03:16:30 INFO - Running pre-action listener: _resource_record_pre_action 03:16:30 INFO - Running main action method: download_and_extract 03:16:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:16: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')]} 03:16:30 INFO - https://queue.taskcluster.net/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:16:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/test_packages.json 03:16:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/test_packages.json 03:16:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:16:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:16:30 INFO - Downloaded 1448 bytes. 03:16:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:16:30 INFO - Using the following test package requirements: 03:16:30 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:30 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:30 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:16:30 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:30 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:16:30 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:30 INFO - u'jsshell-linux-x86_64.zip'], 03:16:30 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:30 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:16:30 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:30 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:30 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:16:30 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:30 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:16:30 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:30 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:16:30 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:30 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:30 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:16:30 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:16: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')]} 03:16:30 INFO - https://queue.taskcluster.net/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:16:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:16:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:16:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:16:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:16:31 INFO - Downloaded 23079615 bytes. 03:16:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:16:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:16:33 INFO - Return code: 0 03:16:33 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:33 INFO - https://queue.taskcluster.net/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:16:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:16:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:16:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:16:34 INFO - Downloaded 23079615 bytes. 03:16:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:16:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:16:35 INFO - Return code: 0 03:16:35 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')]} 03:16:35 INFO - https://queue.taskcluster.net/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:16:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:16:36 INFO - Downloaded 10706649 bytes. 03:16:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:16:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 03:16:36 INFO - Return code: 0 03:16: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')]} 03:16:36 INFO - https://queue.taskcluster.net/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:16:38 INFO - Downloaded 59952540 bytes. 03:16:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:16:38 INFO - mkdir: /builds/slave/test-pgo/properties 03:16:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:16:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:16:38 INFO - Contents: 03:16:38 INFO - build_url:https://queue.taskcluster.net/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:16:38 INFO - Running post-action listener: _resource_record_post_action 03:16:38 INFO - Running post-action listener: set_extra_try_arguments 03:16:38 INFO - ##### 03:16:38 INFO - ##### Running populate-webroot step. 03:16:38 INFO - ##### 03:16:38 INFO - Running pre-action listener: _resource_record_pre_action 03:16:38 INFO - Running main action method: populate_webroot 03:16:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:16:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:16:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:16:38 INFO - '--tppagecycles', 03:16:38 INFO - '7'], 03:16:38 INFO - 'tests': ['tsvgm']}}, 03:16:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:16:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:16:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:16:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:16:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:16:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:16:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'talos_options': ['--e10s'], 03:16:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'tests': ['damp', 'tps']}, 03:16:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'talos_options': ['--e10s'], 03:16:38 INFO - 'tests': ['damp', 'tps']}, 03:16:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:16:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:16:38 INFO - 'other': {'tests': ['a11yr', 03:16:38 INFO - 'ts_paint', 03:16:38 INFO - 'tpaint', 03:16:38 INFO - 'sessionrestore', 03:16:38 INFO - 'sessionrestore_no_auto_restore']}, 03:16:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:16:38 INFO - 'tests': ['a11yr', 03:16:38 INFO - 'ts_paint', 03:16:38 INFO - 'tpaint', 03:16:38 INFO - 'sessionrestore', 03:16:38 INFO - 'sessionrestore_no_auto_restore']}, 03:16:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:16:38 INFO - 'tests': ['a11yr', 03:16:38 INFO - 'ts_paint', 03:16:38 INFO - 'tpaint', 03:16:38 INFO - 'sessionrestore', 03:16:38 INFO - 'sessionrestore_no_auto_restore']}, 03:16:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:16:38 INFO - 'tests': ['a11yr', 03:16:38 INFO - 'ts_paint', 03:16:38 INFO - 'tpaint', 03:16:38 INFO - 'sessionrestore', 03:16:38 INFO - 'sessionrestore_no_auto_restore']}, 03:16:38 INFO - 'other_l64': {'tests': ['a11yr', 03:16:38 INFO - 'ts_paint', 03:16:38 INFO - 'tpaint', 03:16:38 INFO - 'sessionrestore', 03:16:38 INFO - 'sessionrestore_no_auto_restore']}, 03:16:38 INFO - 'other_nol64': {'tests': ['a11yr', 03:16:38 INFO - 'ts_paint', 03:16:38 INFO - 'tpaint', 03:16:38 INFO - 'sessionrestore', 03:16:38 INFO - 'sessionrestore_no_auto_restore']}, 03:16:38 INFO - 'svgr': {'tests': ['tsvgx', 03:16:38 INFO - 'tsvgr_opacity', 03:16:38 INFO - 'tart', 03:16:38 INFO - 'tscrollx', 03:16:38 INFO - 'cart']}, 03:16:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:16:38 INFO - 'tests': ['tsvgx', 03:16:38 INFO - 'tsvgr_opacity', 03:16:38 INFO - 'tart', 03:16:38 INFO - 'tscrollx', 03:16:38 INFO - 'cart']}, 03:16:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'tests': ['tp5o']}, 03:16:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'talos_options': ['--e10s'], 03:16:38 INFO - 'tests': ['tp5o']}, 03:16:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'talos_options': ['--xperf_path', 03:16:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:38 INFO - 'tests': ['tp5n']}, 03:16:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'talos_options': ['--e10s', 03:16:38 INFO - '--xperf_path', 03:16:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:38 INFO - 'tests': ['tp5n']}}, 03:16:38 INFO - 'talos.zip': {'path': '', 03:16:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:16:38 INFO - Running post-action listener: _resource_record_post_action 03:16:38 INFO - ##### 03:16:38 INFO - ##### Running create-virtualenv step. 03:16:38 INFO - ##### 03:16:38 INFO - Running pre-action listener: _resource_record_pre_action 03:16:38 INFO - Running main action method: create_virtualenv 03:16:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:16: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 03:16:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:16:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:16:38 INFO - Using real prefix '/usr' 03:16:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:16:39 INFO - Installing distribute.............................................................................................................................................................................................done. 03:16:41 INFO - Installing pip.................done. 03:16:41 INFO - Return code: 0 03:16:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:16: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')]} 03:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fab8e3bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a7f0>, '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 0x2af62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6760>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', '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 03:16:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:16:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:16:41 INFO - Using env: {'DISPLAY': ':0', 03:16:41 INFO - 'HOME': '/home/cltbld', 03:16:41 INFO - 'LANG': 'en_US.UTF-8', 03:16:41 INFO - 'LANGUAGE': 'en_US:en', 03:16:41 INFO - 'LOGNAME': 'cltbld', 03:16:41 INFO - 'MAIL': '/var/mail/cltbld', 03:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:41 INFO - 'MOZ_NO_REMOTE': '1', 03:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:41 INFO - 'NO_EM_RESTART': '1', 03:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:41 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:41 INFO - 'SHELL': '/bin/bash', 03:16:41 INFO - 'SHLVL': '1', 03:16:41 INFO - 'TERM': 'linux', 03:16:41 INFO - 'TMOUT': '86400', 03:16:41 INFO - 'USER': 'cltbld', 03:16:41 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', 03:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:41 INFO - '_': '/tools/buildbot/bin/python'} 03:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16: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 03:16:41 INFO - Cleaning up... 03:16:41 INFO - Return code: 0 03:16:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:16: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')]} 03:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fab8e3bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a7f0>, '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 0x2af62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6760>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', '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 03:16:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:16:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:16:41 INFO - Using env: {'DISPLAY': ':0', 03:16:41 INFO - 'HOME': '/home/cltbld', 03:16:41 INFO - 'LANG': 'en_US.UTF-8', 03:16:41 INFO - 'LANGUAGE': 'en_US:en', 03:16:41 INFO - 'LOGNAME': 'cltbld', 03:16:41 INFO - 'MAIL': '/var/mail/cltbld', 03:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:41 INFO - 'MOZ_NO_REMOTE': '1', 03:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:41 INFO - 'NO_EM_RESTART': '1', 03:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:41 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:41 INFO - 'SHELL': '/bin/bash', 03:16:41 INFO - 'SHLVL': '1', 03:16:41 INFO - 'TERM': 'linux', 03:16:41 INFO - 'TMOUT': '86400', 03:16:41 INFO - 'USER': 'cltbld', 03:16:41 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', 03:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:41 INFO - '_': '/tools/buildbot/bin/python'} 03:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:41 INFO - Downloading/unpacking psutil>=0.7.1 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:16:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:43 INFO - Installing collected packages: psutil 03:16:43 INFO - Running setup.py install for psutil 03:16:43 INFO - building 'psutil._psutil_linux' extension 03:16: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 03:16:44 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 03:16:44 INFO - building 'psutil._psutil_posix' extension 03:16:44 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 03:16:44 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 03:16:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:44 INFO - Successfully installed psutil 03:16:44 INFO - Cleaning up... 03:16:44 INFO - Return code: 0 03:16:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:16:44 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')]} 03:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:44 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')]} 03:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fab8e3bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a7f0>, '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 0x2af62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6760>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', '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 03:16:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:16:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:16:44 INFO - Using env: {'DISPLAY': ':0', 03:16:44 INFO - 'HOME': '/home/cltbld', 03:16:44 INFO - 'LANG': 'en_US.UTF-8', 03:16:44 INFO - 'LANGUAGE': 'en_US:en', 03:16:44 INFO - 'LOGNAME': 'cltbld', 03:16:44 INFO - 'MAIL': '/var/mail/cltbld', 03:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:44 INFO - 'MOZ_NO_REMOTE': '1', 03:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:44 INFO - 'NO_EM_RESTART': '1', 03:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:44 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:44 INFO - 'SHELL': '/bin/bash', 03:16:44 INFO - 'SHLVL': '1', 03:16:44 INFO - 'TERM': 'linux', 03:16:44 INFO - 'TMOUT': '86400', 03:16:44 INFO - 'USER': 'cltbld', 03:16:44 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', 03:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:44 INFO - '_': '/tools/buildbot/bin/python'} 03:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:16:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:16:46 INFO - Installing collected packages: mozsystemmonitor 03:16:46 INFO - Running setup.py install for mozsystemmonitor 03:16:46 INFO - Successfully installed mozsystemmonitor 03:16:46 INFO - Cleaning up... 03:16:46 INFO - Return code: 0 03:16:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:16: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')]} 03:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fab8e3bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a7f0>, '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 0x2af62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6760>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', '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 03:16:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:16:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:16:46 INFO - Using env: {'DISPLAY': ':0', 03:16:46 INFO - 'HOME': '/home/cltbld', 03:16:46 INFO - 'LANG': 'en_US.UTF-8', 03:16:46 INFO - 'LANGUAGE': 'en_US:en', 03:16:46 INFO - 'LOGNAME': 'cltbld', 03:16:46 INFO - 'MAIL': '/var/mail/cltbld', 03:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:46 INFO - 'MOZ_NO_REMOTE': '1', 03:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:46 INFO - 'NO_EM_RESTART': '1', 03:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:46 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:46 INFO - 'SHELL': '/bin/bash', 03:16:46 INFO - 'SHLVL': '1', 03:16:46 INFO - 'TERM': 'linux', 03:16:46 INFO - 'TMOUT': '86400', 03:16:46 INFO - 'USER': 'cltbld', 03:16:46 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', 03:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:46 INFO - '_': '/tools/buildbot/bin/python'} 03:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:46 INFO - Downloading/unpacking blobuploader==1.2.4 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:48 INFO - Downloading blobuploader-1.2.4.tar.gz 03:16:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:16:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:16:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16:49 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 03:16:49 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 03:16:49 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 03:16:49 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 03:16:49 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 03:16:49 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 03:16:49 INFO - Downloading docopt-0.6.1.tar.gz 03:16:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:49 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:49 INFO - Running setup.py install for blobuploader 03:16:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:16:49 INFO - Running setup.py install for requests 03:16:49 INFO - Running setup.py install for docopt 03:16:49 INFO - Successfully installed blobuploader requests docopt 03:16:49 INFO - Cleaning up... 03:16:50 INFO - Return code: 0 03:16:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fab8e3bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a7f0>, '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 0x2af62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6760>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', '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 03:16:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 03:16:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 03:16:50 INFO - Using env: {'DISPLAY': ':0', 03:16:50 INFO - 'HOME': '/home/cltbld', 03:16:50 INFO - 'LANG': 'en_US.UTF-8', 03:16:50 INFO - 'LANGUAGE': 'en_US:en', 03:16:50 INFO - 'LOGNAME': 'cltbld', 03:16:50 INFO - 'MAIL': '/var/mail/cltbld', 03:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:50 INFO - 'MOZ_NO_REMOTE': '1', 03:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:50 INFO - 'NO_EM_RESTART': '1', 03:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:50 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:50 INFO - 'SHELL': '/bin/bash', 03:16:50 INFO - 'SHLVL': '1', 03:16:50 INFO - 'TERM': 'linux', 03:16:50 INFO - 'TMOUT': '86400', 03:16:50 INFO - 'USER': 'cltbld', 03:16:50 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', 03:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:50 INFO - '_': '/tools/buildbot/bin/python'} 03:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:16:50 INFO - Running setup.py (path:/tmp/pip-ZKbIMs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:16:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:16:50 INFO - Running setup.py (path:/tmp/pip-glf7QX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:16:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:16:50 INFO - Running setup.py (path:/tmp/pip-mQxrp0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:16:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:16:50 INFO - Running setup.py (path:/tmp/pip-3Lrine-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:16:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:16:50 INFO - Running setup.py (path:/tmp/pip-a2JyY9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:16:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:16:50 INFO - Running setup.py (path:/tmp/pip-wRzvEL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:16:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:16:50 INFO - Running setup.py (path:/tmp/pip-cZqc_0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:16:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:16:50 INFO - Running setup.py (path:/tmp/pip-UEmZiL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:16:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:16:50 INFO - Running setup.py (path:/tmp/pip-v82PGJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:16:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:16:50 INFO - Running setup.py (path:/tmp/pip-QaIcgf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:16:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:16:50 INFO - Running setup.py (path:/tmp/pip-O9zWCm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:16:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:16:51 INFO - Running setup.py (path:/tmp/pip-IfdV9_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:16:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:16:51 INFO - Running setup.py (path:/tmp/pip-4GSYwv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:16:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:16:51 INFO - Running setup.py (path:/tmp/pip-CFE40J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:16:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:16:51 INFO - Running setup.py (path:/tmp/pip-MP6cis-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:16:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:16:51 INFO - Running setup.py (path:/tmp/pip-Ypc1Fr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:16:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:16:51 INFO - Running setup.py (path:/tmp/pip-fl32Iy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:16:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:51 INFO - Running setup.py install for manifestparser 03:16:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:16:51 INFO - Running setup.py install for mozcrash 03:16:51 INFO - Running setup.py install for mozdebug 03:16:51 INFO - Running setup.py install for mozdevice 03:16:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:16:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:16:51 INFO - Running setup.py install for mozfile 03:16:51 INFO - Running setup.py install for mozhttpd 03:16:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:16:52 INFO - Running setup.py install for mozinfo 03:16:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:16:52 INFO - Running setup.py install for mozInstall 03:16:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:16:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:16:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:16:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:16:52 INFO - Running setup.py install for mozleak 03:16:52 INFO - Running setup.py install for mozlog 03:16:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:16:52 INFO - Running setup.py install for moznetwork 03:16:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:16:52 INFO - Running setup.py install for mozprocess 03:16:52 INFO - Running setup.py install for mozprofile 03:16:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:16:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:16:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:16:52 INFO - Running setup.py install for mozrunner 03:16:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:16:52 INFO - Running setup.py install for mozscreenshot 03:16:53 INFO - Running setup.py install for moztest 03:16:53 INFO - Running setup.py install for mozversion 03:16:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:16:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:53 INFO - Cleaning up... 03:16:53 INFO - Return code: 0 03:16:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fab8e3bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a7f0>, '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 0x2af62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6760>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', '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 03:16:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:16:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:16:53 INFO - Using env: {'DISPLAY': ':0', 03:16:53 INFO - 'HOME': '/home/cltbld', 03:16:53 INFO - 'LANG': 'en_US.UTF-8', 03:16:53 INFO - 'LANGUAGE': 'en_US:en', 03:16:53 INFO - 'LOGNAME': 'cltbld', 03:16:53 INFO - 'MAIL': '/var/mail/cltbld', 03:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:53 INFO - 'MOZ_NO_REMOTE': '1', 03:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:53 INFO - 'NO_EM_RESTART': '1', 03:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:53 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:53 INFO - 'SHELL': '/bin/bash', 03:16:53 INFO - 'SHLVL': '1', 03:16:53 INFO - 'TERM': 'linux', 03:16:53 INFO - 'TMOUT': '86400', 03:16:53 INFO - 'USER': 'cltbld', 03:16:53 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', 03:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:53 INFO - '_': '/tools/buildbot/bin/python'} 03:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:16:53 INFO - Running setup.py (path:/tmp/pip-CPoKQW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:16:53 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)) 03:16:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:16:53 INFO - Running setup.py (path:/tmp/pip-tOpb1E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:16:53 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)) 03:16:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:16:53 INFO - Running setup.py (path:/tmp/pip-4ebCbn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:16:53 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)) 03:16:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:16:53 INFO - Running setup.py (path:/tmp/pip-SV7A6C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:16:53 INFO - Running setup.py (path:/tmp/pip-kanQeh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:16: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)) 03:16:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:16:53 INFO - Running setup.py (path:/tmp/pip-pwmues-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:16: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)) 03:16:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:16:53 INFO - Running setup.py (path:/tmp/pip-7B1bq0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:16: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)) 03:16:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:16:53 INFO - Running setup.py (path:/tmp/pip-IMci_E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:16:54 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)) 03:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:16:54 INFO - Running setup.py (path:/tmp/pip-Pq44N9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:16:54 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)) 03:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:16:54 INFO - Running setup.py (path:/tmp/pip-wVbHQp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:16:54 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)) 03:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:16:54 INFO - Running setup.py (path:/tmp/pip-_tPOE1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:16:54 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)) 03:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:16:54 INFO - Running setup.py (path:/tmp/pip-Fch6C5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:16:54 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)) 03:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:16:54 INFO - Running setup.py (path:/tmp/pip-EvLBcK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:16:54 INFO - Running setup.py (path:/tmp/pip-R1Li2Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:16:54 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)) 03:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:16:54 INFO - Running setup.py (path:/tmp/pip-a5N7wF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:16:54 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)) 03:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:16:54 INFO - Running setup.py (path:/tmp/pip-B40Emg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:16:54 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)) 03:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:16:54 INFO - Running setup.py (path:/tmp/pip-dW7QjV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:16:54 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)) 03:16:54 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)) 03:16:54 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)) 03:16:54 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)) 03:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:56 INFO - Downloading blessings-1.6.tar.gz 03:16:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:56 INFO - Installing collected packages: blessings 03:16:56 INFO - Running setup.py install for blessings 03:16:56 INFO - Successfully installed blessings 03:16:56 INFO - Cleaning up... 03:16:56 INFO - Return code: 0 03:16:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:16:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:16:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:16:56 INFO - Reading from file tmpfile_stdout 03:16:56 INFO - Current package versions: 03:16:56 INFO - argparse == 1.2.1 03:16:56 INFO - blessings == 1.6 03:16:56 INFO - blobuploader == 1.2.4 03:16:56 INFO - docopt == 0.6.1 03:16:56 INFO - manifestparser == 1.1 03:16:56 INFO - mozInstall == 1.12 03:16:56 INFO - mozcrash == 0.16 03:16:56 INFO - mozdebug == 0.1 03:16:56 INFO - mozdevice == 0.48 03:16:56 INFO - mozfile == 1.2 03:16:56 INFO - mozhttpd == 0.7 03:16:56 INFO - mozinfo == 0.9 03:16:56 INFO - mozleak == 0.1 03:16:56 INFO - mozlog == 3.1 03:16:56 INFO - moznetwork == 0.27 03:16:56 INFO - mozprocess == 0.22 03:16:56 INFO - mozprofile == 0.28 03:16:56 INFO - mozrunner == 6.11 03:16:56 INFO - mozscreenshot == 0.1 03:16:56 INFO - mozsystemmonitor == 0.0 03:16:56 INFO - moztest == 0.7 03:16:56 INFO - mozversion == 1.4 03:16:56 INFO - psutil == 3.1.1 03:16:56 INFO - requests == 1.2.3 03:16:56 INFO - wsgiref == 0.1.2 03:16:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:16: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')]} 03:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fab8e3bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a7f0>, '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 0x2af62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6760>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', '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 03:16:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:16:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:16:56 INFO - Using env: {'DISPLAY': ':0', 03:16:56 INFO - 'HOME': '/home/cltbld', 03:16:56 INFO - 'LANG': 'en_US.UTF-8', 03:16:56 INFO - 'LANGUAGE': 'en_US:en', 03:16:56 INFO - 'LOGNAME': 'cltbld', 03:16:56 INFO - 'MAIL': '/var/mail/cltbld', 03:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:56 INFO - 'MOZ_NO_REMOTE': '1', 03:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:56 INFO - 'NO_EM_RESTART': '1', 03:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:56 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:57 INFO - 'SHELL': '/bin/bash', 03:16:57 INFO - 'SHLVL': '1', 03:16:57 INFO - 'TERM': 'linux', 03:16:57 INFO - 'TMOUT': '86400', 03:16:57 INFO - 'USER': 'cltbld', 03:16:57 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', 03:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:57 INFO - '_': '/tools/buildbot/bin/python'} 03:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 03:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:16:57 INFO - Cleaning up... 03:16:57 INFO - Return code: 0 03:16:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fab8e3bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a7f0>, '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 0x2af62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6760>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', '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 03:16:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:16:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:16:57 INFO - Using env: {'DISPLAY': ':0', 03:16:57 INFO - 'HOME': '/home/cltbld', 03:16:57 INFO - 'LANG': 'en_US.UTF-8', 03:16:57 INFO - 'LANGUAGE': 'en_US:en', 03:16:57 INFO - 'LOGNAME': 'cltbld', 03:16:57 INFO - 'MAIL': '/var/mail/cltbld', 03:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:57 INFO - 'MOZ_NO_REMOTE': '1', 03:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:57 INFO - 'NO_EM_RESTART': '1', 03:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:57 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:57 INFO - 'SHELL': '/bin/bash', 03:16:57 INFO - 'SHLVL': '1', 03:16:57 INFO - 'TERM': 'linux', 03:16:57 INFO - 'TMOUT': '86400', 03:16:57 INFO - 'USER': 'cltbld', 03:16:57 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', 03:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:57 INFO - '_': '/tools/buildbot/bin/python'} 03:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:57 INFO - Downloading/unpacking jsonschema 03:16:57 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 03:16:57 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 03:16:57 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 03:16:57 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 03:16:57 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 03:16:57 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 03:16:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:16:59 INFO - Downloading/unpacking functools32 (from jsonschema) 03:16:59 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 03:16:59 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 03:16:59 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 03:16:59 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 03:16:59 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 03:16:59 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 03:16:59 INFO - Downloading functools32-3.2.3-2.tar.gz 03:16:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:16:59 INFO - warning: no files found matching '*.txt' 03:16:59 INFO - no previously-included directories found matching 'build' 03:16:59 INFO - no previously-included directories found matching 'dist' 03:16:59 INFO - no previously-included directories found matching '.git*' 03:16:59 INFO - Installing collected packages: jsonschema, functools32 03:16:59 INFO - Running setup.py install for functools32 03:16:59 INFO - warning: no files found matching '*.txt' 03:16:59 INFO - no previously-included directories found matching 'build' 03:16:59 INFO - no previously-included directories found matching 'dist' 03:16:59 INFO - no previously-included directories found matching '.git*' 03:16:59 INFO - Successfully installed jsonschema functools32 03:16:59 INFO - Cleaning up... 03:16:59 INFO - Return code: 0 03:16:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fab8e3bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a7f0>, '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 0x2af62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6760>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', '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 03:16:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:16:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:16:59 INFO - Using env: {'DISPLAY': ':0', 03:16:59 INFO - 'HOME': '/home/cltbld', 03:16:59 INFO - 'LANG': 'en_US.UTF-8', 03:16:59 INFO - 'LANGUAGE': 'en_US:en', 03:16:59 INFO - 'LOGNAME': 'cltbld', 03:16:59 INFO - 'MAIL': '/var/mail/cltbld', 03:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:59 INFO - 'MOZ_NO_REMOTE': '1', 03:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:59 INFO - 'NO_EM_RESTART': '1', 03:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:59 INFO - 'SHELL': '/bin/bash', 03:16:59 INFO - 'SHLVL': '1', 03:16:59 INFO - 'TERM': 'linux', 03:16:59 INFO - 'TMOUT': '86400', 03:16:59 INFO - 'USER': 'cltbld', 03:16:59 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', 03:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:59 INFO - '_': '/tools/buildbot/bin/python'} 03:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:59 INFO - Downloading/unpacking flake8 03:16:59 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 03:16:59 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 03:16:59 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 03:16:59 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 03:16:59 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 03:16:59 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 03:17:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:17:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:17:01 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 03:17:01 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 03:17:01 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 03:17:01 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 03:17:01 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 03:17:01 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 03:17:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:17:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:17:01 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 03:17:01 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 03:17:01 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 03:17:01 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 03:17:01 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 03:17:01 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 03:17:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:17:02 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 03:17:02 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 03:17:02 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 03:17:02 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 03:17:02 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 03:17:02 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 03:17:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:17:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:17:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:17:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:17:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:17:02 INFO - no previously-included directories found matching 'docs/_build' 03:17:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:17:02 INFO - Running setup.py install for pep8 03:17:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:17:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:17:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:17:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:17:02 INFO - no previously-included directories found matching 'docs/_build' 03:17:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:17:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:17:02 INFO - Cleaning up... 03:17:02 INFO - Return code: 0 03:17:02 INFO - Running post-action listener: _resource_record_post_action 03:17:02 INFO - Running post-action listener: _start_resource_monitoring 03:17:02 INFO - Starting resource monitoring. 03:17:02 INFO - ##### 03:17:02 INFO - ##### Running install step. 03:17:02 INFO - ##### 03:17:02 INFO - Running pre-action listener: _resource_record_pre_action 03:17:02 INFO - Running main action method: install 03:17:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:17:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:17:02 INFO - Reading from file tmpfile_stdout 03:17:02 INFO - Detecting whether we're running mozinstall >=1.0... 03:17:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:17:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:17:03 INFO - Reading from file tmpfile_stdout 03:17:03 INFO - Output received: 03:17:03 INFO - Usage: mozinstall [options] installer 03:17:03 INFO - Options: 03:17:03 INFO - -h, --help show this help message and exit 03:17:03 INFO - -d DEST, --destination=DEST 03:17:03 INFO - Directory to install application into. [default: 03:17:03 INFO - "/builds/slave/test-pgo"] 03:17:03 INFO - --app=APP Application being installed. [default: firefox] 03:17:03 INFO - mkdir: /builds/slave/test-pgo/build/application 03:17:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:17:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:17:18 INFO - Reading from file tmpfile_stdout 03:17:18 INFO - Output received: 03:17:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:17:18 INFO - Running post-action listener: _resource_record_post_action 03:17:18 INFO - ##### 03:17:18 INFO - ##### Running run-tests step. 03:17:18 INFO - ##### 03:17:18 INFO - Running pre-action listener: _resource_record_pre_action 03:17:18 INFO - Running main action method: run_tests 03:17:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:17:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:17:18 INFO - Python 2.7.3 03:17:18 INFO - Return code: 0 03:17:18 INFO - grabbing minidump binary from tooltool 03:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:18 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 0x2b8a7f0>, '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 0x2af62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:17:18 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 03:17:18 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 03:17:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:17:18 INFO - Return code: 0 03:17:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:17:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:17:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:17:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:17:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:17:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:17:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:17:19 INFO - Return code: 0 03:17:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 03:17:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:17:19 INFO - Using env: {'DISPLAY': ':0', 03:17:19 INFO - 'HOME': '/home/cltbld', 03:17:19 INFO - 'LANG': 'en_US.UTF-8', 03:17:19 INFO - 'LANGUAGE': 'en_US:en', 03:17:19 INFO - 'LOGNAME': 'cltbld', 03:17:19 INFO - 'MAIL': '/var/mail/cltbld', 03:17:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:17:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:19 INFO - 'MOZ_NO_REMOTE': '1', 03:17:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:19 INFO - 'NO_EM_RESTART': '1', 03:17:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:17:19 INFO - 'PWD': '/builds/slave/test-pgo', 03:17:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:17:19 INFO - 'SHELL': '/bin/bash', 03:17:19 INFO - 'SHLVL': '1', 03:17:19 INFO - 'TERM': 'linux', 03:17:19 INFO - 'TMOUT': '86400', 03:17:19 INFO - 'USER': 'cltbld', 03:17:19 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475', 03:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:19 INFO - '_': '/tools/buildbot/bin/python'} 03:17:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:17:19 INFO - mozversion application_buildid: 20160225004014 03:17:19 INFO - mozversion application_changeset: a6621cd9929e1b7337f85a8b8a237918c15436ed 03:17:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:17:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:17:19 INFO - mozversion application_name: Firefox 03:17:19 INFO - mozversion application_remotingname: firefox-dev 03:17:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:19 INFO - mozversion application_vendor: Mozilla 03:17:19 INFO - mozversion application_version: 46.0a2 03:17:19 INFO - mozversion platform_buildid: 20160225004014 03:17:19 INFO - mozversion platform_changeset: a6621cd9929e1b7337f85a8b8a237918c15436ed 03:17:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:19 INFO - mozversion platform_version: 46.0a2 03:17:19 INFO - using testdate: 1456399039 03:17:19 INFO - actual date: 1456399039 03:17:19 INFO - starting webserver on 'localhost:35635' 03:17:19 INFO - SUITE-START | Running 3 tests 03:17:19 INFO - TEST-START | dromaeo_css 03:17:19 INFO - operating with platform_type : linux_ 03:17:19 INFO - Initialising browser for dromaeo_css test... 03:17:19 INFO - TEST-INFO | started process 1870 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuCWPvJ/profile http://localhost:35635/getInfo.html) 03:17:23 INFO - PROCESS | 1870 | 03:17:23 INFO - PROCESS | 1870 | (process:1951): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:17:23 INFO - PROCESS | 1870 | __metrics Screen width/height:1600/1200 03:17:23 INFO - PROCESS | 1870 | colorDepth:24 03:17:23 INFO - PROCESS | 1870 | Browser inner width/height: 1024/697 03:17:23 INFO - PROCESS | 1870 | __metrics 03:17:24 INFO - TEST-INFO | 1870: exit 0 03:17:24 INFO - Browser initialized. 03:17:24 INFO - Running cycle 1/1 for dromaeo_css test... 03:17:24 INFO - TEST-INFO | started process 2000 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuCWPvJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:26 INFO - PROCESS | 2000 | 03:17:26 INFO - PROCESS | 2000 | (process:2062): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:17:36 INFO - PROCESS | 2000 | RSS: Main: 141328384 03:17:36 INFO - PROCESS | 2000 | 03:18:26 INFO - PROCESS | 2000 | 1456399106443 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] 03:20:34 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:35635/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35635/tests/dromaeo/cssquery-ext.html) 03:20:35 INFO - PROCESS | 2000 | RSS: Main: 145747968 03:20:35 INFO - PROCESS | 2000 | 03:23:37 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:35635/tests/dromaeo/cssquery-ext.html (next: http://localhost:35635/tests/dromaeo/cssquery-jquery.html) 03:23:37 INFO - PROCESS | 2000 | RSS: Main: 144826368 03:23:37 INFO - PROCESS | 2000 | 03:26:39 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:35635/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35635/tests/dromaeo/cssquery-mootools.html) 03:26:40 INFO - PROCESS | 2000 | RSS: Main: 142364672 03:26:40 INFO - PROCESS | 2000 | 03:29:41 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:35635/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35635/tests/dromaeo/cssquery-prototype.html) 03:29:42 INFO - PROCESS | 2000 | RSS: Main: 142696448 03:29:42 INFO - PROCESS | 2000 | 03:32:44 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:35635/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35635/tests/dromaeo/cssquery-yui.html) 03:32:45 INFO - PROCESS | 2000 | RSS: Main: 143564800 03:32:45 INFO - PROCESS | 2000 | 03:35:47 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:35635/tests/dromaeo/cssquery-yui.html (next: http://localhost:35635/tests/dromaeo/cssquery-dojo.html) 03:35:47 INFO - PROCESS | 2000 | RSS: Main: 146911232 03:35:47 INFO - PROCESS | 2000 | 03:35:47 INFO - PROCESS | 2000 | __start_tp_report 03:35:47 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 03:35:47 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 03:35:47 INFO - PROCESS | 2000 | |i|pagename|runs| 03:35:47 INFO - PROCESS | 2000 | |0;dojo.html;3369.5282660427542;3395.5416018837464;3399.6090449598305;3414.9658503414958;3433;5483.945160548404;5514.338279406472;5514.393416724167;5544.861378465535;5554.139108438194;5437.13005919053;5538.833834984946;5543.417941116185;5557;5560.026995275831;4949.703017818933;5024.572911302525;5089.720065396402;5116.104681680709;5200.297959775438;4896.143174944388;5046.798128074873;5080.0601888650535;5080.136376815932;5177.508136727024;5054.823081192159;5066.518680725325;5108.872278193037;5130.640855140142;5144.202648589475;5056.620753443488;5078.339815823938;5084.51697088776;5103.770330335106;5122.487751224885;4923.975380123113;4927.605791536668;5015.548600625962;5031.899362012776;5051.267566202917;5290.0477913975465;5328.413874473805;5368.758405871745;5369.40936496985;5377.9512994966;5857.121431785224;5884.323302820188;5900.64596124234;5919.911201331984;5926.466618004357;5651.378348381675;5717.342505611825;5907.675077870758;5923.526117910556;5936.198613187207;5380.569554435636;5436.755346009439;5437.782488700487;5449.727513624303;5477.698726570037;6028.8794224116145;6057.666828324396;6082.422169893942;6094.542909281821;6101.725422356005;5642.4357564244065;5772.7113644317615;5835.183074369592;5857.121431785266;5861;5956.255468066492;5967.313758917693;5973.253343332083;5984.401559843981;5991;5891.05743081105;5921.970390148022;5924.733386997509;5940.70296485174;5945.137954996501;5730.713464326767;5792.681402522818;5848.239728835224;5907.527397808165;5937.70311484424;4552.226121559343;4554.590086892195;4566.406367172246;4583.449986001635;4592.425946756655;4091.3044782387065;4093.201825643971;4108.055147316134;4111.60939710727;4138.379243113557;5450.700211488406;5537.1140617501005;5634.943650563442;5677.545796336283;5685.829425117253;5992.0712289595185;6009.399060094043;6018.398160183947;6027.879442411215;6031.819045428644;5629.296337957755;5645.125005624135;5650.7174641267775;5653.773849045992;5673.631213971079;4970.15507363749;5114.48855114493;5135.6148288878485;5175.275461435402;5209.166533354645;6072.453479186895;6118.724657390429;6131.724072416752;6138.386161383915;6157.9384206158265;5805.10020946754;5955.464008239279;5960.374160713062;5982.461578457785;5994.850128746729;6010.909836352545;6044.848878778066;6129.603311142764;6135.44703110649;6139.461473530676;5881.7647294107755;5910.906482300788;5914.822555323347;5937.7921772737745;5949.286085669747;5857.384974577608;5936.7922122725495;5987.550933679904;5995.250593675791;5998;5826.271716035496;5878.2064421302575;5899.056151015817;5928.970355148197;5936.881262374642;5802.0426629605645;5809.390014048633;5836.328822185334;5842.065269556851;5857.326407463196;5522.530584900329;5595.608307418442;5695.914561281501;5765.711714414347;5774.855628609318;5844.444777746107;5865.237519122486;5872.530197584098;5891.911621325769;5897.3807750185615;5674.177244299471;5724.942750572608;5735.311762588516;5737.766380228271;5747.023006088892 03:35:47 INFO - PROCESS | 2000 | |1;ext.html;560.8645521877626;567.8637127089498;573.3005733005732;616.2081724983398;619.3187493756868;29936;31053.378932421365;37299;37767.05582360442;37837.432438513446;39543.40684889729;40007.59992400075;40184;40184.39723404151;40282.19435611286;8647.65409383624;8792;8796.8680469793;8801;8828.823423531525;8686.913130868674;8770.166834150745;8845;8854.247388971946;8859.5570221489;8753.562321883912;8851.645934162625;9075.228605568534;9083.500407477586;9085.136911993382;8955.910440895574;8965.058668839809;9007.954960225223;9043.321750868645;9049.864252036225;8802.559872006437;8961.731148065568;8977.416467929565;8994;9002.50486223264;41475.1704965899;41880.58119418797;41891.37162942559;41892;42014.1597168058;3715.4055351143957;3730.459083432914;3797.2405518896053;3809.5999920008276;3927.0182454386404;31321.686783132332;31324.21689457759;31563;31587.21031974196;32043.51934720981;4246.299360605496;4338.110687309094;4370.628496577795;4409.272470042439;4419;228600;231273;231845;232113;232942.9999999983;43768.343474847905;43997;44283.77858110689;44400.77799610981;44511;42120.157596847894;42442.15115697669;42497.57502424936;42550.78724606357;42561.14877702429;14751.041182323115;14818.184999825113;14839;14887.255637218095;14919.701605967819;11714.238574492801;11800.881991179978;11828.34944078084;11855.110866685032;11878.346690932081;14368.353424095942;14416.207108608918;14502.202378869264;14554.563363099123;14621.92689036548;6050.848728781728;6282.717277722422;6284.214473190851;6316.810495685137;6331.905021424683;1055.9947200264103;1089.6404186618397;1143.4740019590915;1176.823476478535;1182.722060315825;29107.981220657177;29508.852455738015;29680.2579935499;30039.699603004126;32765.344693106006;1142.154805443982;1175.5591653130077;1188.7503624239007;1237;1318.1959005006938;15298.617534561503;15586.610334741723;15705.136217508147;15719.05685658864;15731.370745170065;458263;474814;486886;491665;491955;51570;51974;51996.48003519992;52470.688232794484;52645;1490.1208287110658;1490.5304828978838;1499.0855578097353;1502.894797364174;1511.6220944763809;28506.85746571254;28667.426651466438;28768.280792980342;29627;29817.403651927274;45945.31082033705;46580.7670961643;46823.53176468192;46833.765831170625;46850.76574617105;316327;317152;318423;318706;319354;31973.520397194527;32504;32569.18577035593;32805.17987050343;32951.34097318088;47672.2849157256;47791;48075.75962120167;48539;49044.75477622589;34175.829120854236;34277.65722342845;35199.64800351964;35465.46801798027;35809.28381432409;34791.13022174466;34815.12962175966;35032;35100.12249693778;40079.59920400759;35839.283214335046;36369.27261454809;36466.27067458689;36493.45259821052;36635.81682091679;30374.544381834734;30579.23551911131;30616.540751888293;31094;31143.532847007766;25334.366640834127;25553;25732.8713356432;25785.742142578332;26060.8696956514 03:35:47 INFO - PROCESS | 2000 | |2;jquery.html;389.4003235018074;390.57817557038396;393.91136994176316;394.38475977475133;404.1230529750441;15430;16561.751573726404;16667.16664166793;18003.27986880525;18037.45887623372;16699.165041747925;17208.741868871977;17750.822491775078;17900.82099179011;17995.73006404905;5025.170846810281;5716.828495145152;5720.713964301789;5746.48281654651;5754.82735517933;5337.386200586943;5591.329040515124;5611.270534830466;5620.803271885485;5624.29696287964;5447.400785913546;5582.7766889324585;5594.748236329355;5601.047821870292;6008.699565021753;6103.420175083382;6119.847003824895;6150.969245153746;6162.476189523896;6166.198394208769;5264.2893209416625;5394.730263486849;5417.377001644822;5424.213489044067;5427.3758517770175;12915.67710807228;12967.805482917764;20806.895965520227;21048.158073677187;21528.246511372185;2244.461329280961;2290.324354315481;2321.1875843454823;2386.093284551859;2447.4126209709543;10218.79562408755;10318;10383.792324153475;10416.427096509764;10574.418406987612;1945.9610807783765;1956.188181904508;1964.0866996846391;2018.5760990192077;2020.7878172791793;61216.0817587741;61527;63274;63923.68038159779;64021;10932.344059356465;10938.124950003981;10975;10977.725556861142;10998.06516446111;14609.342579583945;14664.706705865823;14667.633309167357;14668.633284167769;14758.778618320734;7482.812929676802;7500.474966752384;7502.924970750332;7530.2846229609195;7557.017587713562;6884.759033433806;6933.930660693329;7035.296470352924;7046.260142684944;7050.365467107985;4699.835505757282;4743.976280118577;4775.570198682135;4825.1555977703765;7882.132965373804;3036.59006034187;3112.144160355875;3124.3907438049364;3172.4924012157944;3186.1556687477837;934.7663084228943;967.9419234845932;1008.5864795433837;1044.8223801953686;1188.714708469961;17354.739678904825;18182;18998.335058272893;19084.236630534902;19553.608927821362;1019.2915923433291;1079.266099052636;1079.3362082319318;1088.7169335972546;1109.839073334362;10337.844932326021;10378.06597406237;10635.46822658864;10638.627648032281;10706.46467676613;539828;571255;587174;587346;590056;47055.05889882183;59294.407055929754;62888.68555657284;73422.26577734154;78796;1183.0594677231622;1202.4889421995617;1206.6681662542871;1211.170348311392;1214.7509760499076;15695.843041569438;15964.28160732793;16212.513624591282;16398.672026559165;16714.080725560212;32752;32863;33799;34085.31829363448;35139;42457.1508569833;42596;43253;44170.33744493771;44918.550814492744;7862.439784924844;7935.2064793520185;8050;8116.675332986614;8244.587770611566;3892.338302488527;10599.403146228915;11223.270487418291;11745.823812642988;11876.52493900269;10455.268131231045;10508.42203678805;10952.452377381258;11031.877308093764;11185.608503702331;10160.491975401348;10419.218558607983;10505.632302869362;10650.240378639995;10794.946025269823;11003.944980275048;11198.928198283344;11234.83147752768;11391.259568128045;11520.423978801195;7887.5267483948855;7894.131645519104;7905.881411778713;7916.722914697958;7955.5624440654;10909.618163364245;11234.4382780859;11255.774884502427;11428.428578571204;11526.193166478266 03:35:47 INFO - PROCESS | 2000 | |3;mootools.html;1580.7075690997165;1613.4756204233624;1843.9631207375853;1914.550080731027;1953.4335042837579;7121.572705637665;7160.892586611205;8092.2716955474;8252.917470825298;8276;7846.882296765553;7999.640016199271;8030.277275045245;8040.035195776515;8043.879341809878;2402.9519409611753;2426.1872272788637;2435.2207293665947;2436.6954130733657;2439.2438344113293;2387.4986252886915;2400;2420.5279970405777;2422.2248880358293;2434.3427274635837;2370.893309801063;2391.9475430810476;2393.4734358441115;2428.7449817769143;2428.9878550607223;2403.6875206223253;2404.8797560121925;2441.6825812644333;2444.633305004246;2452.852828830276;2368.8933997970134;2369.301056188411;2369.5616310982523;2376.9049238030457;2390.306811024801;8200.138985406506;8221.506709597383;8226.712065077694;8272.33821294301;8293.502389856567;5115.104856650071;5137.845864624067;5150.459201783796;5185.6888586684545;5228.686278823283;3219.2112932331493;3222.065600975714;3268.82021488818;3310.5696259486112;3324.983375083133;1060.5810704771573;1119.5969450997634;1124.5108377855659;1125.5385292030228;1134.444122380028;11967.64097077089;11981.400929953468;12021.759564808743;12028.939855300667;12034.939825300906;4569.748663823455;4618.699784513996;4652.046330502239;4674.252119660838;4694.2958556216845;10003.949980250198;10091.444970526545;10142.847857282146;10147.340422872638;10155.289129760846;5218.399884013311;5233.712145832016;5263.552598029134;5265.131253343232;5280.947190528045;4434.246178149722;4550.931736023962;4561.201789686792;4584.633229341644;4735.810567577328;3681.245344704329;3689.6310368963427;3695.150115473456;3698.204885949534;3701.9629803702155;1078.1105587890022;1086.9782604347868;1087.8694556653252;1092.4210168610648;1128.7516746315798;1185.25921299188;1197.4072833947253;1299.9990007694023;1418.9574312770633;1436.74138655041;8017.919820801834;8025.117237103914;8067.636956336979;8109.351251899951;8122.9187708123345;530.3370786516854;531.1422053383758;534.9090654588729;542.2841848759679;544.1185279846595;5930.970345148333;5966.284045914431;5983.04271316596;5987.251593550806;6071.574989750763;9424.198943089777;9601.807963840824;9616.567254473566;9715.0770676787;9753.853692194623;9357.578908949114;9406.576704048335;9436.85844712316;9567.856482152773;9649.565769540388;7846.882296765553;7893.802654933673;7911.960440197878;7935.682572697027;8008.15914328987;7830.92169078302;7839.059312882263;7911.050673919167;7965.442419030613;8177.836443271221;8992.415492992934;9097.590608422504;9146.679866204651;9188.724338269863;9258.074192580689;9001.954990225007;9190.954045229731;9262.212711919563;9279.304052195977;9426.905730942603;7564.50830696003;7787.532748035136;7791;7980.321672657657;8109.878351824846;7806.41451891099;7813.687452501837;7829.099653539915;7842.764717058498;7872.173421790859;7269.259192681831;7393.260673932564;7499.062617172854;7515.661795219337;7572.204918483701;7253.238409967089;7275;7323.560586364835;7404.444666650131;7480.625968701434;7432.256774322741;7461.141968673672;7486.363659089038;7523.473356864967;7539.2083831199125;6854.280300568568;6908.205556361083;6932.722691092502;6944.583325000516;7034.507584469038;6988.440924725908;7116.537425067354;7160.534565253241;7165.964170179116;7189.065421495172 03:35:47 INFO - PROCESS | 2000 | |4;prototype.html;358.52853497650585;364.4296675702527;367.1024345475313;367.89882782234884;373.6338388379388;6354.7458101675875;6394.584352017121;6412.935870641298;6415.230172379309;6453.645049522274;6237.719302631381;6347.619142851432;6377.298497165308;6394.808155755335;6407.199100112486;4933.531314525132;4937.111319962414;4938.7530623468865;4938.827141050064;4947.356843610326;4936.80252789888;4945.802167913297;4949.158643030675;4969.503049695038;4973.328600638922;4704.529547045286;4792.305115758213;4827.468978412372;4837.153498137829;4856.2958371036175;4810.903781924342;4827.565519103297;4832.395950506187;4837.274408838684;4846.224604063368;4291.935620965688;4293.0340673348555;4295.398644189816;4298.78506074695;4298.828046878121;5958.344582095966;6085.665288409135;6092.543059270528;6102.72537735803;6108.816735497942;5659.60382773206;5671.6597004179885;5675.432456754333;5680.772769089232;5697.6011679182475;6733.562318449285;6790.083338749305;6801.4898882584;6801.843686573295;6810.489213309022;4682.250839865639;4710.929336059928;4712.410948631421;4724.102420540086;4727.479977202505;6900.413464855494;7044.36600705939;7095;7095.9290407096305;7096.893546596753;4783.258594917794;4783.784729687172;4792.424909010941;4795.112904112751;4795.6163506919365;4855.36880205571;4858.6356023298395;4862.80548778052;4867.123917694778;4868.85581888256;5514.476124768141;5615.9157612635845;5629.183768353566;5631.070873305941;5640.971795140998;6783.830404239933;6784.694688739019;6833.897491537631;6839.452843772487;6868.278830722702;1705.155947805844;1757.1390018890652;1757.7802774653169;1758.6746451906438;1760.7270873014704;1154.5670373609896;1164.2956011612853;1165.4464129538571;1176.4294317256124;1182.2847177457513;6358.618482891041;6382.819178451909;6401.135846660734;6436.356364363526;6441.903371449432;6903;6917.066196063568;6932.480063995221;6936.79189624312;6970.989206565121;6410.2500186952975;6418.358164183544;6471.708773105222;6479.3520647935775;6504.1219435375615;3790.905227369283;3795.411711184771;3795.8481660733814;3805.9048523786573;3806.657400833883;7143.857122857514;7160.353118782605;7188.532745371639;7193.676284567207;7195;6955.82610434733;7088.326608972139;7146.178189508169;7155.570665760071;7163.283671632899;7066.893996590055;7116.893246601305;7123.394511466479;7130.108736408053;7131;6973.023776671169;6978.057962175041;7021.613811240431;7045.048918395951;7050.894236586558;6640.236372817188;6731.865362692621;6761.459083273425;6814.829629259309;6853.760118395832;7118.181409138016;7161.355478007004;7181.605011724197;7187.460940429593;7187.8562428752175;4802.6638135330195;4819.843237623016;4825.5898248649255;4833.854984350475;4844.467108617979;6817.897731533932;6976.023356730163;6989.126359205099;7001.159860816734;7151.570905745672;6896.862062758817;6942.826429339307;6950.826229344307;6952.096227490596;6964.233934267328;6882.311768823078;6902.344277293649;6913.51605387618;6938.479614029069;6953.79138625842;6639.970804525306;6760.290169532128;6789.762358317435;6790.456763458813;6803.795886123424;6960.303969603202;6962;6964.094667693167;6965.373116419547;6976.965115174595;6695.196576410862;6722.428593569602;6734.023566582916;6742.359475849787;6742.561733487308 03:35:47 INFO - PROCESS | 2000 | |5;yui.html;825.896762904637;841.6633346661334;861.8118924077053;936.5083331251093;944.994205224213;14219.857801421982;14222.71554568908;14293;14359.712805743879;14410.207438590887;13551.25468099254;13664.453421863114;15603;15726.37094516218;15744.685106297868;891.9241864441531;902.5261737587754;909.0818273543736;912.32943786317;913.2191975860643;903.1961554216753;907.6278725722456;907.9001309855911;910.1671970147307;914.2868562521244;927.1516562345446;935.7847695030147;938.5729493080632;940.8259471997702;941.1717688434169;929.4655573045492;929.693201243588;931.9673811416602;933.3746389918771;933.7945651956559;687.189116842126;689.0250295831393;689.2074114768006;691.1533371619726;691.6438034412231;15324.846751532454;15328.23358832054;15403.22983850803;15413.306401211972;15481;13400.664983375396;13467.12463689857;13510.324483775772;13582.59252222435;13671.863281367258;11016.504257308441;11226.101911847032;11328.886711132865;11600.883991160064;11699.590514332043;3847.71142164336;3863.16941857502;3882.9223415531815;3898.8440462381473;3999.440078389028;52564.47435525634;52853.73573132148;53422.19866702003;53748.46251537474;53847;10516.26386152962;10683.519241634145;11203;11495.137864660184;11817.88182118185;19417;19417;19510.414687559394;19537.21851125939;19669.311574094838;7773.494722842997;8161.387895907831;8179.100298967109;8194.50832950025;8386.161383861565;4476.529964353761;4510.661700372485;4537.3647689323525;4539.273716205391;4616.76916154191;3262.9347413052083;3282.573265475473;3291.7860339077884;3299.0762586475826;3299.785513941586;579.7680927628898;600.3486217454024;604.1873679900615;609.9481544068803;624.5222404860285;641.7930465796748;661.497262080822;687.2920891481782;747.4468893019126;761.13611051457;10040.548175332127;10127.746346534474;10223.079922806983;10372.688819335432;10467.685969420929;652.3443938841434;683.5454422808776;750.846076554305;761.5354633673455;774.9806254843674;4435.756033418128;4446.933296000562;4671.906561868744;4677.321788340671;4722.929156062662;60383;60557;60702.39297606968;60849.39150608526;61306;49779.75110124426;51577.48422515727;51676.74161629168;51709.74145129325;51821.7408912953;46110.30834537485;46126.30810537845;46599.30101048487;47147.057058858634;47151;9743.26925480606;9975.20198384113;10003.29976901639;10063.446510441996;10143.492825358555;36946.630533695396;37176.81411592925;37722.43416348812;38898.4165237516;39040.41439378468;43857.78071109624;44057.77971110252;48351.27473087977;49700.50299496959;50263.49736502588;11329.206955513035;11360.659180224606;11496.88503114958;11591.18861679708;11868.347240901834;12818.294993775431;13131.803022954473;13411.329433528479;13448.394822232827;14959.252037398304;13044.217346959213;13075.280859552817;13193.736125277248;13367.799483007957;13748.662727336177;12492.750144997231;13171.341432928124;13370.465181392636;13373.39819708135;13838.308084595528;11962.22245554071;12306.569270075504;12510.124291299522;12530;12854;10507.15942724565;10518;10757.892421075689;10914.781704366027;10919.672409827717;10775.892241077803;11150.386728729998;11269.380184089627;11375.31748095117;11454.656360309204 03:35:47 INFO - PROCESS | 2000 | __end_tp_report 03:35:47 INFO - PROCESS | 2000 | __start_cc_report 03:35:47 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,302 03:35:47 INFO - PROCESS | 2000 | __end_cc_report 03:35:47 INFO - PROCESS | 2000 | __startTimestamp1456400147645__endTimestamp 03:35:47 INFO - PROCESS | 2000 | 03:35:47 INFO - PROCESS | 2000 | ------- Summary: start ------- 03:35:47 INFO - PROCESS | 2000 | Number of tests: 6 03:35:47 INFO - PROCESS | 2000 | 03:35:47 INFO - PROCESS | 2000 | [#0] dojo.html Cycles:165 Average:5514.15 Median:5724.94 stddev:597.90 (10.4%) stddev-sans-first:575.58 03:35:47 INFO - PROCESS | 2000 | Values: 3369.5 3395.5 3399.6 3415.0 3433.0 5483.9 5514.3 5514.4 5544.9 5554.1 5437.1 5538.8 5543.4 5557.0 5560.0 4949.7 5024.6 5089.7 5116.1 5200.3 4896.1 5046.8 5080.1 5080.1 5177.5 5054.8 5066.5 5108.9 5130.6 5144.2 5056.6 5078.3 5084.5 5103.8 5122.5 4924.0 4927.6 5015.5 5031.9 5051.3 5290.0 5328.4 5368.8 5369.4 5378.0 5857.1 5884.3 5900.6 5919.9 5926.5 5651.4 5717.3 5907.7 5923.5 5936.2 5380.6 5436.8 5437.8 5449.7 5477.7 6028.9 6057.7 6082.4 6094.5 6101.7 5642.4 5772.7 5835.2 5857.1 5861.0 5956.3 5967.3 5973.3 5984.4 5991.0 5891.1 5922.0 5924.7 5940.7 5945.1 5730.7 5792.7 5848.2 5907.5 5937.7 4552.2 4554.6 4566.4 4583.4 4592.4 4091.3 4093.2 4108.1 4111.6 4138.4 5450.7 5537.1 5634.9 5677.5 5685.8 5992.1 6009.4 6018.4 6027.9 6031.8 5629.3 5645.1 5650.7 5653.8 5673.6 4970.2 5114.5 5135.6 5175.3 5209.2 6072.5 6118.7 6131.7 6138.4 6157.9 5805.1 5955.5 5960.4 5982.5 5994.9 6010.9 6044.8 6129.6 6135.4 6139.5 5881.8 5910.9 5914.8 5937.8 5949.3 5857.4 5936.8 5987.6 5995.3 5998.0 5826.3 5878.2 5899.1 5929.0 5936.9 5802.0 5809.4 5836.3 5842.1 5857.3 5522.5 5595.6 5695.9 5765.7 5774.9 5844.4 5865.2 5872.5 5891.9 5897.4 5674.2 5724.9 5735.3 5737.8 5747.0 03:35:47 INFO - PROCESS | 2000 | 03:35:47 INFO - PROCESS | 2000 | [#1] ext.html Cycles:180 Average:49655.16 Median:20175.61 stddev:95021.12 (471.0%) stddev-sans-first:95216.19 03:35:47 INFO - PROCESS | 2000 | Values: 560.9 567.9 573.3 616.2 619.3 29936.0 31053.4 37299.0 37767.1 37837.4 39543.4 40007.6 40184.0 40184.4 40282.2 8647.7 8792.0 8796.9 8801.0 8828.8 8686.9 8770.2 8845.0 8854.2 8859.6 8753.6 8851.6 9075.2 9083.5 9085.1 8955.9 8965.1 9008.0 9043.3 9049.9 8802.6 8961.7 8977.4 8994.0 9002.5 41475.2 41880.6 41891.4 41892.0 42014.2 3715.4 3730.5 3797.2 3809.6 3927.0 31321.7 31324.2 31563.0 31587.2 32043.5 4246.3 4338.1 4370.6 4409.3 4419.0 228600.0 231273.0 231845.0 232113.0 232943.0 43768.3 43997.0 44283.8 44400.8 44511.0 42120.2 42442.2 42497.6 42550.8 42561.1 14751.0 14818.2 14839.0 14887.3 14919.7 11714.2 11800.9 11828.3 11855.1 11878.3 14368.4 14416.2 14502.2 14554.6 14621.9 6050.8 6282.7 6284.2 6316.8 6331.9 1056.0 1089.6 1143.5 1176.8 1182.7 29108.0 29508.9 29680.3 30039.7 32765.3 1142.2 1175.6 1188.8 1237.0 1318.2 15298.6 15586.6 15705.1 15719.1 15731.4 458263.0 474814.0 486886.0 491665.0 491955.0 51570.0 51974.0 51996.5 52470.7 52645.0 1490.1 1490.5 1499.1 1502.9 1511.6 28506.9 28667.4 28768.3 29627.0 29817.4 45945.3 46580.8 46823.5 46833.8 46850.8 316327.0 317152.0 318423.0 318706.0 319354.0 31973.5 32504.0 32569.2 32805.2 32951.3 47672.3 47791.0 48075.8 48539.0 49044.8 34175.8 34277.7 35199.6 35465.5 35809.3 34791.1 34815.1 35032.0 35100.1 40079.6 35839.3 36369.3 36466.3 36493.5 36635.8 30374.5 30579.2 30616.5 31094.0 31143.5 25334.4 25553.0 25732.9 25785.7 26060.9 03:35:47 INFO - PROCESS | 2000 | 03:35:47 INFO - PROCESS | 2000 | [#2] jquery.html Cycles:180 Average:28949.26 Median:2416.75 stddev:93850.41 (3883.3%) stddev-sans-first:94089.19 03:35:47 INFO - PROCESS | 2000 | Values: 389.4 390.6 393.9 394.4 404.1 15430.0 16561.8 16667.2 18003.3 18037.5 16699.2 17208.7 17750.8 17900.8 17995.7 5025.2 5716.8 5720.7 5746.5 5754.8 5337.4 5591.3 5611.3 5620.8 5624.3 5447.4 5582.8 5594.7 5601.0 6008.7 6103.4 6119.8 6151.0 6162.5 6166.2 5264.3 5394.7 5417.4 5424.2 5427.4 12915.7 12967.8 20806.9 21048.2 21528.2 2244.5 2290.3 2321.2 2386.1 2447.4 10218.8 10318.0 10383.8 10416.4 10574.4 1946.0 1956.2 1964.1 2018.6 2020.8 61216.1 61527.0 63274.0 63923.7 64021.0 10932.3 10938.1 10975.0 10977.7 10998.1 14609.3 14664.7 14667.6 14668.6 14758.8 7482.8 7500.5 7502.9 7530.3 7557.0 6884.8 6933.9 7035.3 7046.3 7050.4 4699.8 4744.0 4775.6 4825.2 7882.1 3036.6 3112.1 3124.4 3172.5 3186.2 934.8 967.9 1008.6 1044.8 1188.7 17354.7 18182.0 18998.3 19084.2 19553.6 1019.3 1079.3 1079.3 1088.7 1109.8 10337.8 10378.1 10635.5 10638.6 10706.5 539828.0 571255.0 587174.0 587346.0 590056.0 47055.1 59294.4 62888.7 73422.3 78796.0 1183.1 1202.5 1206.7 1211.2 1214.8 15695.8 15964.3 16212.5 16398.7 16714.1 32752.0 32863.0 33799.0 34085.3 35139.0 42457.2 42596.0 43253.0 44170.3 44918.6 7862.4 7935.2 8050.0 8116.7 8244.6 3892.3 10599.4 11223.3 11745.8 11876.5 10455.3 10508.4 10952.5 11031.9 11185.6 10160.5 10419.2 10505.6 10650.2 10794.9 11003.9 11198.9 11234.8 11391.3 11520.4 7887.5 7894.1 7905.9 7916.7 7955.6 10909.6 11234.4 11255.8 11428.4 11526.2 03:35:47 INFO - PROCESS | 2000 | 03:35:47 INFO - PROCESS | 2000 | [#3] mootools.html Cycles:180 Average:5834.04 Median:5948.63 stddev:3067.80 (51.6%) stddev-sans-first:3059.75 03:35:47 INFO - PROCESS | 2000 | Values: 1580.7 1613.5 1844.0 1914.6 1953.4 7121.6 7160.9 8092.3 8252.9 8276.0 7846.9 7999.6 8030.3 8040.0 8043.9 2403.0 2426.2 2435.2 2436.7 2439.2 2387.5 2400.0 2420.5 2422.2 2434.3 2370.9 2391.9 2393.5 2428.7 2429.0 2403.7 2404.9 2441.7 2444.6 2452.9 2368.9 2369.3 2369.6 2376.9 2390.3 8200.1 8221.5 8226.7 8272.3 8293.5 5115.1 5137.8 5150.5 5185.7 5228.7 3219.2 3222.1 3268.8 3310.6 3325.0 1060.6 1119.6 1124.5 1125.5 1134.4 11967.6 11981.4 12021.8 12028.9 12034.9 4569.7 4618.7 4652.0 4674.3 4694.3 10003.9 10091.4 10142.8 10147.3 10155.3 5218.4 5233.7 5263.6 5265.1 5280.9 4434.2 4550.9 4561.2 4584.6 4735.8 3681.2 3689.6 3695.2 3698.2 3702.0 1078.1 1087.0 1087.9 1092.4 1128.8 1185.3 1197.4 1300.0 1419.0 1436.7 8017.9 8025.1 8067.6 8109.4 8122.9 530.3 531.1 534.9 542.3 544.1 5931.0 5966.3 5983.0 5987.3 6071.6 9424.2 9601.8 9616.6 9715.1 9753.9 9357.6 9406.6 9436.9 9567.9 9649.6 7846.9 7893.8 7912.0 7935.7 8008.2 7830.9 7839.1 7911.1 7965.4 8177.8 8992.4 9097.6 9146.7 9188.7 9258.1 9002.0 9191.0 9262.2 9279.3 9426.9 7564.5 7787.5 7791.0 7980.3 8109.9 7806.4 7813.7 7829.1 7842.8 7872.2 7269.3 7393.3 7499.1 7515.7 7572.2 7253.2 7275.0 7323.6 7404.4 7480.6 7432.3 7461.1 7486.4 7523.5 7539.2 6854.3 6908.2 6932.7 6944.6 7034.5 6988.4 7116.5 7160.5 7166.0 7189.1 03:35:47 INFO - PROCESS | 2000 | 03:35:47 INFO - PROCESS | 2000 | [#4] prototype.html Cycles:180 Average:5674.61 Median:6411.59 stddev:1701.94 (26.5%) stddev-sans-first:1659.29 03:35:47 INFO - PROCESS | 2000 | Values: 358.5 364.4 367.1 367.9 373.6 6354.7 6394.6 6412.9 6415.2 6453.6 6237.7 6347.6 6377.3 6394.8 6407.2 4933.5 4937.1 4938.8 4938.8 4947.4 4936.8 4945.8 4949.2 4969.5 4973.3 4704.5 4792.3 4827.5 4837.2 4856.3 4810.9 4827.6 4832.4 4837.3 4846.2 4291.9 4293.0 4295.4 4298.8 4298.8 5958.3 6085.7 6092.5 6102.7 6108.8 5659.6 5671.7 5675.4 5680.8 5697.6 6733.6 6790.1 6801.5 6801.8 6810.5 4682.3 4710.9 4712.4 4724.1 4727.5 6900.4 7044.4 7095.0 7095.9 7096.9 4783.3 4783.8 4792.4 4795.1 4795.6 4855.4 4858.6 4862.8 4867.1 4868.9 5514.5 5615.9 5629.2 5631.1 5641.0 6783.8 6784.7 6833.9 6839.5 6868.3 1705.2 1757.1 1757.8 1758.7 1760.7 1154.6 1164.3 1165.4 1176.4 1182.3 6358.6 6382.8 6401.1 6436.4 6441.9 6903.0 6917.1 6932.5 6936.8 6971.0 6410.3 6418.4 6471.7 6479.4 6504.1 3790.9 3795.4 3795.8 3805.9 3806.7 7143.9 7160.4 7188.5 7193.7 7195.0 6955.8 7088.3 7146.2 7155.6 7163.3 7066.9 7116.9 7123.4 7130.1 7131.0 6973.0 6978.1 7021.6 7045.0 7050.9 6640.2 6731.9 6761.5 6814.8 6853.8 7118.2 7161.4 7181.6 7187.5 7187.9 4802.7 4819.8 4825.6 4833.9 4844.5 6817.9 6976.0 6989.1 7001.2 7151.6 6896.9 6942.8 6950.8 6952.1 6964.2 6882.3 6902.3 6913.5 6938.5 6953.8 6640.0 6760.3 6789.8 6790.5 6803.8 6960.3 6962.0 6964.1 6965.4 6977.0 6695.2 6722.4 6734.0 6742.4 6742.6 03:35:47 INFO - PROCESS | 2000 | 03:35:47 INFO - PROCESS | 2000 | [#5] yui.html Cycles:180 Average:14867.76 Median:21469.63 stddev:16673.99 (77.7%) stddev-sans-first:16687.42 03:35:47 INFO - PROCESS | 2000 | Values: 825.9 841.7 861.8 936.5 945.0 14219.9 14222.7 14293.0 14359.7 14410.2 13551.3 13664.5 15603.0 15726.4 15744.7 891.9 902.5 909.1 912.3 913.2 903.2 907.6 907.9 910.2 914.3 927.2 935.8 938.6 940.8 941.2 929.5 929.7 932.0 933.4 933.8 687.2 689.0 689.2 691.2 691.6 15324.8 15328.2 15403.2 15413.3 15481.0 13400.7 13467.1 13510.3 13582.6 13671.9 11016.5 11226.1 11328.9 11600.9 11699.6 3847.7 3863.2 3882.9 3898.8 3999.4 52564.5 52853.7 53422.2 53748.5 53847.0 10516.3 10683.5 11203.0 11495.1 11817.9 19417.0 19417.0 19510.4 19537.2 19669.3 7773.5 8161.4 8179.1 8194.5 8386.2 4476.5 4510.7 4537.4 4539.3 4616.8 3262.9 3282.6 3291.8 3299.1 3299.8 579.8 600.3 604.2 609.9 624.5 641.8 661.5 687.3 747.4 761.1 10040.5 10127.7 10223.1 10372.7 10467.7 652.3 683.5 750.8 761.5 775.0 4435.8 4446.9 4671.9 4677.3 4722.9 60383.0 60557.0 60702.4 60849.4 61306.0 49779.8 51577.5 51676.7 51709.7 51821.7 46110.3 46126.3 46599.3 47147.1 47151.0 9743.3 9975.2 10003.3 10063.4 10143.5 36946.6 37176.8 37722.4 38898.4 39040.4 43857.8 44057.8 48351.3 49700.5 50263.5 11329.2 11360.7 11496.9 11591.2 11868.3 12818.3 13131.8 13411.3 13448.4 14959.3 13044.2 13075.3 13193.7 13367.8 13748.7 12492.8 13171.3 13370.5 13373.4 13838.3 11962.2 12306.6 12510.1 12530.0 12854.0 10507.2 10518.0 10757.9 10914.8 10919.7 10775.9 11150.4 11269.4 11375.3 11454.7 03:35:47 INFO - PROCESS | 2000 | -------- Summary: end -------- 03:35:47 INFO - PROCESS | 2000 | 03:35:48 INFO - TEST-INFO | 2000: exit 0 03:35:48 INFO - TEST-OK | dromaeo_css | took 1108907ms 03:35:48 INFO - TEST-START | kraken 03:35:48 INFO - operating with platform_type : linux_ 03:35:48 INFO - Initialising browser for kraken test... 03:35:48 INFO - TEST-INFO | started process 2243 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBV3DtY/profile http://localhost:35635/getInfo.html) 03:35:51 INFO - PROCESS | 2243 | 03:35:51 INFO - PROCESS | 2243 | (process:2323): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:35:52 INFO - PROCESS | 2243 | __metrics Screen width/height:1600/1200 03:35:52 INFO - PROCESS | 2243 | colorDepth:24 03:35:52 INFO - PROCESS | 2243 | Browser inner width/height: 1024/697 03:35:52 INFO - PROCESS | 2243 | __metrics 03:35:53 INFO - TEST-INFO | 2243: exit 0 03:35:53 INFO - Browser initialized. 03:35:53 INFO - Running cycle 1/1 for kraken test... 03:35:53 INFO - TEST-INFO | started process 2445 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBV3DtY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:55 INFO - PROCESS | 2445 | 03:35:55 INFO - PROCESS | 2445 | (process:2525): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:36:05 INFO - PROCESS | 2445 | RSS: Main: 141279232 03:36:05 INFO - PROCESS | 2445 | 03:36:08 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35635/tests/kraken/driver.html?testName=audio-beat-detection) 03:36:08 INFO - PROCESS | 2445 | RSS: Main: 145264640 03:36:08 INFO - PROCESS | 2445 | 03:36:11 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35635/tests/kraken/driver.html?testName=audio-dft) 03:36:12 INFO - PROCESS | 2445 | RSS: Main: 146722816 03:36:12 INFO - PROCESS | 2445 | 03:36:14 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35635/tests/kraken/driver.html?testName=audio-fft) 03:36:15 INFO - PROCESS | 2445 | RSS: Main: 146644992 03:36:15 INFO - PROCESS | 2445 | 03:36:17 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35635/tests/kraken/driver.html?testName=audio-oscillator) 03:36:18 INFO - PROCESS | 2445 | RSS: Main: 146534400 03:36:18 INFO - PROCESS | 2445 | 03:36:20 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35635/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:36:20 INFO - PROCESS | 2445 | RSS: Main: 146681856 03:36:20 INFO - PROCESS | 2445 | 03:36:23 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35635/tests/kraken/driver.html?testName=imaging-darkroom) 03:36:24 INFO - PROCESS | 2445 | RSS: Main: 146628608 03:36:24 INFO - PROCESS | 2445 | 03:36:27 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35635/tests/kraken/driver.html?testName=imaging-desaturate) 03:36:28 INFO - PROCESS | 2445 | RSS: Main: 145506304 03:36:28 INFO - PROCESS | 2445 | 03:36:31 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35635/tests/kraken/driver.html?testName=json-parse-financial) 03:36:31 INFO - PROCESS | 2445 | RSS: Main: 145649664 03:36:31 INFO - PROCESS | 2445 | 03:36:33 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35635/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:36:33 INFO - PROCESS | 2445 | RSS: Main: 146141184 03:36:33 INFO - PROCESS | 2445 | 03:36:35 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35635/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:36:36 INFO - PROCESS | 2445 | RSS: Main: 146350080 03:36:36 INFO - PROCESS | 2445 | 03:36:38 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35635/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:36:38 INFO - PROCESS | 2445 | RSS: Main: 147828736 03:36:38 INFO - PROCESS | 2445 | 03:36:41 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35635/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:41 INFO - PROCESS | 2445 | RSS: Main: 147345408 03:36:41 INFO - PROCESS | 2445 | 03:36:44 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35635/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:44 INFO - PROCESS | 2445 | RSS: Main: 146644992 03:36:44 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | Cycle 1(1): loaded http://localhost:35635/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35635/tests/kraken/driver.html?testName=ai-astar) 03:36:46 INFO - PROCESS | 2445 | RSS: Main: 147480576 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | __start_tp_report 03:36:46 INFO - PROCESS | 2445 | _x_x_mozilla_page_load 03:36:46 INFO - PROCESS | 2445 | _x_x_mozilla_page_load_details 03:36:46 INFO - PROCESS | 2445 | |i|pagename|runs| 03:36:46 INFO - PROCESS | 2445 | |0;ai-astar;112;104;110;110;112;119;108;112;110;110 03:36:46 INFO - PROCESS | 2445 | |1;audio-beat-detection;162;130;149;168;123;153;150;134;164;127 03:36:46 INFO - PROCESS | 2445 | |2;audio-dft;161;160;161;165;163;163;162;160;161;161 03:36:46 INFO - PROCESS | 2445 | |3;audio-fft;75;73;74;164;77;73;73;76;155;76 03:36:46 INFO - PROCESS | 2445 | |4;audio-oscillator;96;96;149;94;96;96;144;96;95;138 03:36:46 INFO - PROCESS | 2445 | |5;imaging-gaussian-blur;110;110;109;109;110;109;110;110;110;109 03:36:46 INFO - PROCESS | 2445 | |6;imaging-darkroom;148;148;146;146;146;147;146;147;146;146 03:36:46 INFO - PROCESS | 2445 | |7;imaging-desaturate;97;97;98;96;97;96;97;97;97;97 03:36:46 INFO - PROCESS | 2445 | |8;json-parse-financial;56;55;55;55;55;57;54;61;55;53 03:36:46 INFO - PROCESS | 2445 | |9;json-stringify-tinderbox;63;64;64;65;64;64;65;64;65;65 03:36:46 INFO - PROCESS | 2445 | |10;stanford-crypto-aes;81;81;83;82;83;82;82;82;82;82 03:36:46 INFO - PROCESS | 2445 | |11;stanford-crypto-ccm;115;119;111;124;113;115;124;114;111;120 03:36:46 INFO - PROCESS | 2445 | |12;stanford-crypto-pbkdf2;128;143;138;136;149;126;140;140;140;141 03:36:46 INFO - PROCESS | 2445 | |13;stanford-crypto-sha256-iterative;65;72;65;66;68;65;66;66;66;63 03:36:46 INFO - PROCESS | 2445 | __end_tp_report 03:36:46 INFO - PROCESS | 2445 | __start_cc_report 03:36:46 INFO - PROCESS | 2445 | _x_x_mozilla_cycle_collect,721 03:36:46 INFO - PROCESS | 2445 | __end_cc_report 03:36:46 INFO - PROCESS | 2445 | __startTimestamp1456400206793__endTimestamp 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | ------- Summary: start ------- 03:36:46 INFO - PROCESS | 2445 | Number of tests: 14 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:3.77 (3.4%) stddev-sans-first:3.97 03:36:46 INFO - PROCESS | 2445 | Values: 112.0 104.0 110.0 110.0 112.0 119.0 108.0 112.0 110.0 110.0 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:151.50 stddev:16.42 (10.8%) stddev-sans-first:16.37 03:36:46 INFO - PROCESS | 2445 | Values: 162.0 130.0 149.0 168.0 123.0 153.0 150.0 134.0 164.0 127.0 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.57 (1.0%) stddev-sans-first:1.64 03:36:46 INFO - PROCESS | 2445 | Values: 161.0 160.0 161.0 165.0 163.0 163.0 162.0 160.0 161.0 161.0 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#3] audio-fft Cycles:10 Average:91.60 Median:74.50 stddev:35.88 (48.2%) stddev-sans-first:37.55 03:36:46 INFO - PROCESS | 2445 | Values: 75.0 73.0 74.0 164.0 77.0 73.0 73.0 76.0 155.0 76.0 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:23.39 (24.4%) stddev-sans-first:24.25 03:36:46 INFO - PROCESS | 2445 | Values: 96.0 96.0 149.0 94.0 96.0 96.0 144.0 96.0 95.0 138.0 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:36:46 INFO - PROCESS | 2445 | Values: 110.0 110.0 109.0 109.0 110.0 109.0 110.0 110.0 110.0 109.0 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 03:36:46 INFO - PROCESS | 2445 | Values: 148.0 148.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:36:46 INFO - PROCESS | 2445 | Values: 97.0 97.0 98.0 96.0 97.0 96.0 97.0 97.0 97.0 97.0 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:2.17 (3.9%) stddev-sans-first:2.30 03:36:46 INFO - PROCESS | 2445 | Values: 56.0 55.0 55.0 55.0 55.0 57.0 54.0 61.0 55.0 53.0 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 03:36:46 INFO - PROCESS | 2445 | Values: 63.0 64.0 64.0 65.0 64.0 64.0 65.0 64.0 65.0 65.0 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:0.67 (0.8%) stddev-sans-first:0.60 03:36:46 INFO - PROCESS | 2445 | Values: 81.0 81.0 83.0 82.0 83.0 82.0 82.0 82.0 82.0 82.0 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#11] stanford-crypto-ccm Cycles:10 Average:116.60 Median:117.00 stddev:4.88 (4.2%) stddev-sans-first:5.14 03:36:46 INFO - PROCESS | 2445 | Values: 115.0 119.0 111.0 124.0 113.0 115.0 124.0 114.0 111.0 120.0 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.10 Median:140.00 stddev:6.79 (4.8%) stddev-sans-first:6.14 03:36:46 INFO - PROCESS | 2445 | Values: 128.0 143.0 138.0 136.0 149.0 126.0 140.0 140.0 140.0 141.0 03:36:46 INFO - PROCESS | 2445 | 03:36:46 INFO - PROCESS | 2445 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:2.39 (3.6%) stddev-sans-first:2.50 03:36:46 INFO - PROCESS | 2445 | Values: 65.0 72.0 65.0 66.0 68.0 65.0 66.0 66.0 66.0 63.0 03:36:46 INFO - PROCESS | 2445 | -------- Summary: end -------- 03:36:46 INFO - PROCESS | 2445 | 03:36:47 INFO - TEST-INFO | 2445: exit 0 03:36:47 INFO - TEST-OK | kraken | took 59349ms 03:36:47 INFO - TEST-START | v8_7 03:36:47 INFO - operating with platform_type : linux_ 03:36:47 INFO - Initialising browser for v8_7 test... 03:36:47 INFO - TEST-INFO | started process 2838 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBCjbOi/profile http://localhost:35635/getInfo.html) 03:36:51 INFO - PROCESS | 2838 | 03:36:51 INFO - PROCESS | 2838 | (process:2938): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:36:52 INFO - PROCESS | 2838 | __metrics Screen width/height:1600/1200 03:36:52 INFO - PROCESS | 2838 | colorDepth:24 03:36:52 INFO - PROCESS | 2838 | Browser inner width/height: 1024/697 03:36:52 INFO - PROCESS | 2838 | __metrics 03:36:53 INFO - TEST-INFO | 2838: exit 0 03:36:53 INFO - Browser initialized. 03:36:53 INFO - Running cycle 1/1 for v8_7 test... 03:36:53 INFO - TEST-INFO | started process 2987 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBCjbOi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:54 INFO - PROCESS | 2987 | 03:36:54 INFO - PROCESS | 2987 | (process:3048): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:37:05 INFO - PROCESS | 2987 | RSS: Main: 141381632 03:37:05 INFO - PROCESS | 2987 | 03:37:27 INFO - PROCESS | 2987 | Cycle 1(1): loaded http://localhost:35635/tests/v8_7/run.html (next: http://localhost:35635/tests/v8_7/run.html) 03:37:27 INFO - PROCESS | 2987 | RSS: Main: 145121280 03:37:27 INFO - PROCESS | 2987 | 03:37:27 INFO - PROCESS | 2987 | __start_tp_report 03:37:27 INFO - PROCESS | 2987 | _x_x_mozilla_page_load 03:37:27 INFO - PROCESS | 2987 | _x_x_mozilla_page_load_details 03:37:27 INFO - PROCESS | 2987 | |i|pagename|runs| 03:37:27 INFO - PROCESS | 2987 | |0;Richards;165.59032952475576 03:37:27 INFO - PROCESS | 2987 | |1;DeltaBlue;170.47391749062393 03:37:27 INFO - PROCESS | 2987 | |2;Encrypt;279.72027972027973 03:37:27 INFO - PROCESS | 2987 | |3;Decrypt;5181.347150259067 03:37:27 INFO - PROCESS | 2987 | |4;RayTrace;932.8358208955224 03:37:27 INFO - PROCESS | 2987 | |5;Earley;564.3340857787811 03:37:27 INFO - PROCESS | 2987 | |6;Boyer;11144.444444444445 03:37:27 INFO - PROCESS | 2987 | |7;RegExp;39057.692307692305 03:37:27 INFO - PROCESS | 2987 | |8;Splay;504.54086781029264 03:37:27 INFO - PROCESS | 2987 | |9;NavierStokes;4826.923076923077 03:37:27 INFO - PROCESS | 2987 | __end_tp_report 03:37:27 INFO - PROCESS | 2987 | __startTimestamp1456400247686__endTimestamp 03:37:27 INFO - PROCESS | 2987 | 03:37:27 INFO - PROCESS | 2987 | ------- Summary: start ------- 03:37:27 INFO - PROCESS | 2987 | Number of tests: 10 03:37:27 INFO - PROCESS | 2987 | 03:37:27 INFO - PROCESS | 2987 | [#0] Richards Cycles:1 Average:165.59 Median:165.59 stddev:0.00 (0.0%) 03:37:27 INFO - PROCESS | 2987 | Values: 165.6 03:37:27 INFO - PROCESS | 2987 | 03:37:27 INFO - PROCESS | 2987 | [#1] DeltaBlue Cycles:1 Average:170.47 Median:170.47 stddev:0.00 (0.0%) 03:37:27 INFO - PROCESS | 2987 | Values: 170.5 03:37:27 INFO - PROCESS | 2987 | 03:37:27 INFO - PROCESS | 2987 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 03:37:27 INFO - PROCESS | 2987 | Values: 279.7 03:37:27 INFO - PROCESS | 2987 | 03:37:27 INFO - PROCESS | 2987 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 03:37:27 INFO - PROCESS | 2987 | Values: 5181.3 03:37:27 INFO - PROCESS | 2987 | 03:37:27 INFO - PROCESS | 2987 | [#4] RayTrace Cycles:1 Average:932.84 Median:932.84 stddev:0.00 (0.0%) 03:37:27 INFO - PROCESS | 2987 | Values: 932.8 03:37:27 INFO - PROCESS | 2987 | 03:37:27 INFO - PROCESS | 2987 | [#5] Earley Cycles:1 Average:564.33 Median:564.33 stddev:0.00 (0.0%) 03:37:27 INFO - PROCESS | 2987 | Values: 564.3 03:37:27 INFO - PROCESS | 2987 | 03:37:27 INFO - PROCESS | 2987 | [#6] Boyer Cycles:1 Average:11144.44 Median:11144.44 stddev:0.00 (0.0%) 03:37:27 INFO - PROCESS | 2987 | Values: 11144.4 03:37:27 INFO - PROCESS | 2987 | 03:37:27 INFO - PROCESS | 2987 | [#7] RegExp Cycles:1 Average:39057.69 Median:39057.69 stddev:0.00 (0.0%) 03:37:27 INFO - PROCESS | 2987 | Values: 39057.7 03:37:27 INFO - PROCESS | 2987 | 03:37:27 INFO - PROCESS | 2987 | [#8] Splay Cycles:1 Average:504.54 Median:504.54 stddev:0.00 (0.0%) 03:37:27 INFO - PROCESS | 2987 | Values: 504.5 03:37:27 INFO - PROCESS | 2987 | 03:37:27 INFO - PROCESS | 2987 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 03:37:27 INFO - PROCESS | 2987 | Values: 4826.9 03:37:27 INFO - PROCESS | 2987 | -------- Summary: end -------- 03:37:27 INFO - PROCESS | 2987 | 03:37:28 INFO - TEST-INFO | 2987: exit 0 03:37:28 INFO - TEST-OK | v8_7 | took 40883ms 03:37:28 INFO - SUITE-END | took 1209s 03:37:28 INFO - Completed test suite (00:20:09) 03:37:28 INFO - Working with test: dromaeo_css 03:37:28 INFO - Generating results file: dromaeo_css 03:37:28 INFO - Working with test: kraken 03:37:28 INFO - Generating results file: kraken 03:37:28 INFO - javascript benchmark 03:37:28 INFO - Working with test: v8_7 03:37:28 INFO - Generating results file: v8_7 03:37:28 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:37:28 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 03:37:28 INFO - process_Request line: dromaeo_css 7282.64 graph.html#tests=[[72,52,43]] 03:37:28 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:37:28 INFO - process_Request line: kraken 1495.90 graph.html#tests=[[232,52,43]] 03:37:28 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:37:28 INFO - process_Request line: v8_7 22088.05 graph.html#tests=[[230,52,43]] 03:37:28 INFO - RETURN: dromaeo_css: 7282.64 03:37:28 INFO - RETURN: kraken: 1495.90 03:37:28 INFO - RETURN: v8_7: 22088.05 03:37:28 INFO - javascript benchmark 03:37:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3369.5282660427542, 3395.5416018837464, 3399.6090449598305, 3414.9658503414958, 3433.0, 5483.945160548404, 5514.338279406472, 5514.393416724167, 5544.861378465535, 5554.139108438194, 5437.13005919053, 5538.833834984946, 5543.417941116185, 5557.0, 5560.026995275831, 4949.703017818933, 5024.572911302525, 5089.720065396402, 5116.104681680709, 5200.297959775438, 4896.143174944388, 5046.798128074873, 5080.0601888650535, 5080.136376815932, 5177.508136727024, 5054.823081192159, 5066.518680725325, 5108.872278193037, 5130.640855140142, 5144.202648589475, 5056.620753443488, 5078.339815823938, 5084.51697088776, 5103.770330335106, 5122.487751224885, 4923.975380123113, 4927.605791536668, 5015.548600625962, 5031.899362012776, 5051.267566202917, 5290.0477913975465, 5328.413874473805, 5368.758405871745, 5369.40936496985, 5377.9512994966, 5857.121431785224, 5884.323302820188, 5900.64596124234, 5919.911201331984, 5926.466618004357, 5651.378348381675, 5717.342505611825, 5907.675077870758, 5923.526117910556, 5936.198613187207, 5380.569554435636, 5436.755346009439, 5437.782488700487, 5449.727513624303, 5477.698726570037, 6028.8794224116145, 6057.666828324396, 6082.422169893942, 6094.542909281821, 6101.725422356005, 5642.4357564244065, 5772.7113644317615, 5835.183074369592, 5857.121431785266, 5861.0, 5956.255468066492, 5967.313758917693, 5973.253343332083, 5984.401559843981, 5991.0, 5891.05743081105, 5921.970390148022, 5924.733386997509, 5940.70296485174, 5945.137954996501, 5730.713464326767, 5792.681402522818, 5848.239728835224, 5907.527397808165, 5937.70311484424, 4552.226121559343, 4554.590086892195, 4566.406367172246, 4583.449986001635, 4592.425946756655, 4091.3044782387065, 4093.201825643971, 4108.055147316134, 4111.60939710727, 4138.379243113557, 5450.700211488406, 5537.1140617501005, 5634.943650563442, 5677.545796336283, 5685.829425117253, 5992.0712289595185, 6009.399060094043, 6018.398160183947, 6027.879442411215, 6031.819045428644, 5629.296337957755, 5645.125005624135, 5650.7174641267775, 5653.773849045992, 5673.631213971079, 4970.15507363749, 5114.48855114493, 5135.6148288878485, 5175.275461435402, 5209.166533354645, 6072.453479186895, 6118.724657390429, 6131.724072416752, 6138.386161383915, 6157.9384206158265, 5805.10020946754, 5955.464008239279, 5960.374160713062, 5982.461578457785, 5994.850128746729, 6010.909836352545, 6044.848878778066, 6129.603311142764, 6135.44703110649, 6139.461473530676, 5881.7647294107755, 5910.906482300788, 5914.822555323347, 5937.7921772737745, 5949.286085669747, 5857.384974577608, 5936.7922122725495, 5987.550933679904, 5995.250593675791, 5998.0, 5826.271716035496, 5878.2064421302575, 5899.056151015817, 5928.970355148197, 5936.881262374642, 5802.0426629605645, 5809.390014048633, 5836.328822185334, 5842.065269556851, 5857.326407463196, 5522.530584900329, 5595.608307418442, 5695.914561281501, 5765.711714414347, 5774.855628609318, 5844.444777746107, 5865.237519122486, 5872.530197584098, 5891.911621325769, 5897.3807750185615, 5674.177244299471, 5724.942750572608, 5735.311762588516, 5737.766380228271, 5747.023006088892], "unit": "score", "name": "dojo.html", "value": 5476.675757621533}, {"lowerIsBetter": false, "replicates": [560.8645521877626, 567.8637127089498, 573.3005733005732, 616.2081724983398, 619.3187493756868, 29936.0, 31053.378932421365, 37299.0, 37767.05582360442, 37837.432438513446, 39543.40684889729, 40007.59992400075, 40184.0, 40184.39723404151, 40282.19435611286, 8647.65409383624, 8792.0, 8796.8680469793, 8801.0, 8828.823423531525, 8686.913130868674, 8770.166834150745, 8845.0, 8854.247388971946, 8859.5570221489, 8753.562321883912, 8851.645934162625, 9075.228605568534, 9083.500407477586, 9085.136911993382, 8955.910440895574, 8965.058668839809, 9007.954960225223, 9043.321750868645, 9049.864252036225, 8802.559872006437, 8961.731148065568, 8977.416467929565, 8994.0, 9002.50486223264, 41475.1704965899, 41880.58119418797, 41891.37162942559, 41892.0, 42014.1597168058, 3715.4055351143957, 3730.459083432914, 3797.2405518896053, 3809.5999920008276, 3927.0182454386404, 31321.686783132332, 31324.21689457759, 31563.0, 31587.21031974196, 32043.51934720981, 4246.299360605496, 4338.110687309094, 4370.628496577795, 4409.272470042439, 4419.0, 228600.0, 231273.0, 231845.0, 232113.0, 232942.9999999983, 43768.343474847905, 43997.0, 44283.77858110689, 44400.77799610981, 44511.0, 42120.157596847894, 42442.15115697669, 42497.57502424936, 42550.78724606357, 42561.14877702429, 14751.041182323115, 14818.184999825113, 14839.0, 14887.255637218095, 14919.701605967819, 11714.238574492801, 11800.881991179978, 11828.34944078084, 11855.110866685032, 11878.346690932081, 14368.353424095942, 14416.207108608918, 14502.202378869264, 14554.563363099123, 14621.92689036548, 6050.848728781728, 6282.717277722422, 6284.214473190851, 6316.810495685137, 6331.905021424683, 1055.9947200264103, 1089.6404186618397, 1143.4740019590915, 1176.823476478535, 1182.722060315825, 29107.981220657177, 29508.852455738015, 29680.2579935499, 30039.699603004126, 32765.344693106006, 1142.154805443982, 1175.5591653130077, 1188.7503624239007, 1237.0, 1318.1959005006938, 15298.617534561503, 15586.610334741723, 15705.136217508147, 15719.05685658864, 15731.370745170065, 458263.0, 474814.0, 486886.0, 491665.0, 491955.0, 51570.0, 51974.0, 51996.48003519992, 52470.688232794484, 52645.0, 1490.1208287110658, 1490.5304828978838, 1499.0855578097353, 1502.894797364174, 1511.6220944763809, 28506.85746571254, 28667.426651466438, 28768.280792980342, 29627.0, 29817.403651927274, 45945.31082033705, 46580.7670961643, 46823.53176468192, 46833.765831170625, 46850.76574617105, 316327.0, 317152.0, 318423.0, 318706.0, 319354.0, 31973.520397194527, 32504.0, 32569.18577035593, 32805.17987050343, 32951.34097318088, 47672.2849157256, 47791.0, 48075.75962120167, 48539.0, 49044.75477622589, 34175.829120854236, 34277.65722342845, 35199.64800351964, 35465.46801798027, 35809.28381432409, 34791.13022174466, 34815.12962175966, 35032.0, 35100.12249693778, 40079.59920400759, 35839.283214335046, 36369.27261454809, 36466.27067458689, 36493.45259821052, 36635.81682091679, 30374.544381834734, 30579.23551911131, 30616.540751888293, 31094.0, 31143.532847007766, 25334.366640834127, 25553.0, 25732.8713356432, 25785.742142578332, 26060.8696956514], "unit": "score", "name": "ext.html", "value": 18493.556551135873}, {"lowerIsBetter": false, "replicates": [389.4003235018074, 390.57817557038396, 393.91136994176316, 394.38475977475133, 404.1230529750441, 15430.0, 16561.751573726404, 16667.16664166793, 18003.27986880525, 18037.45887623372, 16699.165041747925, 17208.741868871977, 17750.822491775078, 17900.82099179011, 17995.73006404905, 5025.170846810281, 5716.828495145152, 5720.713964301789, 5746.48281654651, 5754.82735517933, 5337.386200586943, 5591.329040515124, 5611.270534830466, 5620.803271885485, 5624.29696287964, 5447.400785913546, 5582.7766889324585, 5594.748236329355, 5601.047821870292, 6008.699565021753, 6103.420175083382, 6119.847003824895, 6150.969245153746, 6162.476189523896, 6166.198394208769, 5264.2893209416625, 5394.730263486849, 5417.377001644822, 5424.213489044067, 5427.3758517770175, 12915.67710807228, 12967.805482917764, 20806.895965520227, 21048.158073677187, 21528.246511372185, 2244.461329280961, 2290.324354315481, 2321.1875843454823, 2386.093284551859, 2447.4126209709543, 10218.79562408755, 10318.0, 10383.792324153475, 10416.427096509764, 10574.418406987612, 1945.9610807783765, 1956.188181904508, 1964.0866996846391, 2018.5760990192077, 2020.7878172791793, 61216.0817587741, 61527.0, 63274.0, 63923.68038159779, 64021.0, 10932.344059356465, 10938.124950003981, 10975.0, 10977.725556861142, 10998.06516446111, 14609.342579583945, 14664.706705865823, 14667.633309167357, 14668.633284167769, 14758.778618320734, 7482.812929676802, 7500.474966752384, 7502.924970750332, 7530.2846229609195, 7557.017587713562, 6884.759033433806, 6933.930660693329, 7035.296470352924, 7046.260142684944, 7050.365467107985, 4699.835505757282, 4743.976280118577, 4775.570198682135, 4825.1555977703765, 7882.132965373804, 3036.59006034187, 3112.144160355875, 3124.3907438049364, 3172.4924012157944, 3186.1556687477837, 934.7663084228943, 967.9419234845932, 1008.5864795433837, 1044.8223801953686, 1188.714708469961, 17354.739678904825, 18182.0, 18998.335058272893, 19084.236630534902, 19553.608927821362, 1019.2915923433291, 1079.266099052636, 1079.3362082319318, 1088.7169335972546, 1109.839073334362, 10337.844932326021, 10378.06597406237, 10635.46822658864, 10638.627648032281, 10706.46467676613, 539828.0, 571255.0, 587174.0, 587346.0, 590056.0, 47055.05889882183, 59294.407055929754, 62888.68555657284, 73422.26577734154, 78796.0, 1183.0594677231622, 1202.4889421995617, 1206.6681662542871, 1211.170348311392, 1214.7509760499076, 15695.843041569438, 15964.28160732793, 16212.513624591282, 16398.672026559165, 16714.080725560212, 32752.0, 32863.0, 33799.0, 34085.31829363448, 35139.0, 42457.1508569833, 42596.0, 43253.0, 44170.33744493771, 44918.550814492744, 7862.439784924844, 7935.2064793520185, 8050.0, 8116.675332986614, 8244.587770611566, 3892.338302488527, 10599.403146228915, 11223.270487418291, 11745.823812642988, 11876.52493900269, 10455.268131231045, 10508.42203678805, 10952.452377381258, 11031.877308093764, 11185.608503702331, 10160.491975401348, 10419.218558607983, 10505.632302869362, 10650.240378639995, 10794.946025269823, 11003.944980275048, 11198.928198283344, 11234.83147752768, 11391.259568128045, 11520.423978801195, 7887.5267483948855, 7894.131645519104, 7905.881411778713, 7916.722914697958, 7955.5624440654, 10909.618163364245, 11234.4382780859, 11255.774884502427, 11428.428578571204, 11526.193166478266], "unit": "score", "name": "jquery.html", "value": 8820.581546152296}, {"lowerIsBetter": false, "replicates": [1580.7075690997165, 1613.4756204233624, 1843.9631207375853, 1914.550080731027, 1953.4335042837579, 7121.572705637665, 7160.892586611205, 8092.2716955474, 8252.917470825298, 8276.0, 7846.882296765553, 7999.640016199271, 8030.277275045245, 8040.035195776515, 8043.879341809878, 2402.9519409611753, 2426.1872272788637, 2435.2207293665947, 2436.6954130733657, 2439.2438344113293, 2387.4986252886915, 2400.0, 2420.5279970405777, 2422.2248880358293, 2434.3427274635837, 2370.893309801063, 2391.9475430810476, 2393.4734358441115, 2428.7449817769143, 2428.9878550607223, 2403.6875206223253, 2404.8797560121925, 2441.6825812644333, 2444.633305004246, 2452.852828830276, 2368.8933997970134, 2369.301056188411, 2369.5616310982523, 2376.9049238030457, 2390.306811024801, 8200.138985406506, 8221.506709597383, 8226.712065077694, 8272.33821294301, 8293.502389856567, 5115.104856650071, 5137.845864624067, 5150.459201783796, 5185.6888586684545, 5228.686278823283, 3219.2112932331493, 3222.065600975714, 3268.82021488818, 3310.5696259486112, 3324.983375083133, 1060.5810704771573, 1119.5969450997634, 1124.5108377855659, 1125.5385292030228, 1134.444122380028, 11967.64097077089, 11981.400929953468, 12021.759564808743, 12028.939855300667, 12034.939825300906, 4569.748663823455, 4618.699784513996, 4652.046330502239, 4674.252119660838, 4694.2958556216845, 10003.949980250198, 10091.444970526545, 10142.847857282146, 10147.340422872638, 10155.289129760846, 5218.399884013311, 5233.712145832016, 5263.552598029134, 5265.131253343232, 5280.947190528045, 4434.246178149722, 4550.931736023962, 4561.201789686792, 4584.633229341644, 4735.810567577328, 3681.245344704329, 3689.6310368963427, 3695.150115473456, 3698.204885949534, 3701.9629803702155, 1078.1105587890022, 1086.9782604347868, 1087.8694556653252, 1092.4210168610648, 1128.7516746315798, 1185.25921299188, 1197.4072833947253, 1299.9990007694023, 1418.9574312770633, 1436.74138655041, 8017.919820801834, 8025.117237103914, 8067.636956336979, 8109.351251899951, 8122.9187708123345, 530.3370786516854, 531.1422053383758, 534.9090654588729, 542.2841848759679, 544.1185279846595, 5930.970345148333, 5966.284045914431, 5983.04271316596, 5987.251593550806, 6071.574989750763, 9424.198943089777, 9601.807963840824, 9616.567254473566, 9715.0770676787, 9753.853692194623, 9357.578908949114, 9406.576704048335, 9436.85844712316, 9567.856482152773, 9649.565769540388, 7846.882296765553, 7893.802654933673, 7911.960440197878, 7935.682572697027, 8008.15914328987, 7830.92169078302, 7839.059312882263, 7911.050673919167, 7965.442419030613, 8177.836443271221, 8992.415492992934, 9097.590608422504, 9146.679866204651, 9188.724338269863, 9258.074192580689, 9001.954990225007, 9190.954045229731, 9262.212711919563, 9279.304052195977, 9426.905730942603, 7564.50830696003, 7787.532748035136, 7791.0, 7980.321672657657, 8109.878351824846, 7806.41451891099, 7813.687452501837, 7829.099653539915, 7842.764717058498, 7872.173421790859, 7269.259192681831, 7393.260673932564, 7499.062617172854, 7515.661795219337, 7572.204918483701, 7253.238409967089, 7275.0, 7323.560586364835, 7404.444666650131, 7480.625968701434, 7432.256774322741, 7461.141968673672, 7486.363659089038, 7523.473356864967, 7539.2083831199125, 6854.280300568568, 6908.205556361083, 6932.722691092502, 6944.583325000516, 7034.507584469038, 6988.440924725908, 7116.537425067354, 7160.534565253241, 7165.964170179116, 7189.065421495172], "unit": "score", "name": "mootools.html", "value": 4699.528463183918}, {"lowerIsBetter": false, "replicates": [358.52853497650585, 364.4296675702527, 367.1024345475313, 367.89882782234884, 373.6338388379388, 6354.7458101675875, 6394.584352017121, 6412.935870641298, 6415.230172379309, 6453.645049522274, 6237.719302631381, 6347.619142851432, 6377.298497165308, 6394.808155755335, 6407.199100112486, 4933.531314525132, 4937.111319962414, 4938.7530623468865, 4938.827141050064, 4947.356843610326, 4936.80252789888, 4945.802167913297, 4949.158643030675, 4969.503049695038, 4973.328600638922, 4704.529547045286, 4792.305115758213, 4827.468978412372, 4837.153498137829, 4856.2958371036175, 4810.903781924342, 4827.565519103297, 4832.395950506187, 4837.274408838684, 4846.224604063368, 4291.935620965688, 4293.0340673348555, 4295.398644189816, 4298.78506074695, 4298.828046878121, 5958.344582095966, 6085.665288409135, 6092.543059270528, 6102.72537735803, 6108.816735497942, 5659.60382773206, 5671.6597004179885, 5675.432456754333, 5680.772769089232, 5697.6011679182475, 6733.562318449285, 6790.083338749305, 6801.4898882584, 6801.843686573295, 6810.489213309022, 4682.250839865639, 4710.929336059928, 4712.410948631421, 4724.102420540086, 4727.479977202505, 6900.413464855494, 7044.36600705939, 7095.0, 7095.9290407096305, 7096.893546596753, 4783.258594917794, 4783.784729687172, 4792.424909010941, 4795.112904112751, 4795.6163506919365, 4855.36880205571, 4858.6356023298395, 4862.80548778052, 4867.123917694778, 4868.85581888256, 5514.476124768141, 5615.9157612635845, 5629.183768353566, 5631.070873305941, 5640.971795140998, 6783.830404239933, 6784.694688739019, 6833.897491537631, 6839.452843772487, 6868.278830722702, 1705.155947805844, 1757.1390018890652, 1757.7802774653169, 1758.6746451906438, 1760.7270873014704, 1154.5670373609896, 1164.2956011612853, 1165.4464129538571, 1176.4294317256124, 1182.2847177457513, 6358.618482891041, 6382.819178451909, 6401.135846660734, 6436.356364363526, 6441.903371449432, 6903.0, 6917.066196063568, 6932.480063995221, 6936.79189624312, 6970.989206565121, 6410.2500186952975, 6418.358164183544, 6471.708773105222, 6479.3520647935775, 6504.1219435375615, 3790.905227369283, 3795.411711184771, 3795.8481660733814, 3805.9048523786573, 3806.657400833883, 7143.857122857514, 7160.353118782605, 7188.532745371639, 7193.676284567207, 7195.0, 6955.82610434733, 7088.326608972139, 7146.178189508169, 7155.570665760071, 7163.283671632899, 7066.893996590055, 7116.893246601305, 7123.394511466479, 7130.108736408053, 7131.0, 6973.023776671169, 6978.057962175041, 7021.613811240431, 7045.048918395951, 7050.894236586558, 6640.236372817188, 6731.865362692621, 6761.459083273425, 6814.829629259309, 6853.760118395832, 7118.181409138016, 7161.355478007004, 7181.605011724197, 7187.460940429593, 7187.8562428752175, 4802.6638135330195, 4819.843237623016, 4825.5898248649255, 4833.854984350475, 4844.467108617979, 6817.897731533932, 6976.023356730163, 6989.126359205099, 7001.159860816734, 7151.570905745672, 6896.862062758817, 6942.826429339307, 6950.826229344307, 6952.096227490596, 6964.233934267328, 6882.311768823078, 6902.344277293649, 6913.51605387618, 6938.479614029069, 6953.79138625842, 6639.970804525306, 6760.290169532128, 6789.762358317435, 6790.456763458813, 6803.795886123424, 6960.303969603202, 6962.0, 6964.094667693167, 6965.373116419547, 6976.965115174595, 6695.196576410862, 6722.428593569602, 6734.023566582916, 6742.359475849787, 6742.561733487308], "unit": "score", "name": "prototype.html", "value": 5125.159815805874}, {"lowerIsBetter": false, "replicates": [825.896762904637, 841.6633346661334, 861.8118924077053, 936.5083331251093, 944.994205224213, 14219.857801421982, 14222.71554568908, 14293.0, 14359.712805743879, 14410.207438590887, 13551.25468099254, 13664.453421863114, 15603.0, 15726.37094516218, 15744.685106297868, 891.9241864441531, 902.5261737587754, 909.0818273543736, 912.32943786317, 913.2191975860643, 903.1961554216753, 907.6278725722456, 907.9001309855911, 910.1671970147307, 914.2868562521244, 927.1516562345446, 935.7847695030147, 938.5729493080632, 940.8259471997702, 941.1717688434169, 929.4655573045492, 929.693201243588, 931.9673811416602, 933.3746389918771, 933.7945651956559, 687.189116842126, 689.0250295831393, 689.2074114768006, 691.1533371619726, 691.6438034412231, 15324.846751532454, 15328.23358832054, 15403.22983850803, 15413.306401211972, 15481.0, 13400.664983375396, 13467.12463689857, 13510.324483775772, 13582.59252222435, 13671.863281367258, 11016.504257308441, 11226.101911847032, 11328.886711132865, 11600.883991160064, 11699.590514332043, 3847.71142164336, 3863.16941857502, 3882.9223415531815, 3898.8440462381473, 3999.440078389028, 52564.47435525634, 52853.73573132148, 53422.19866702003, 53748.46251537474, 53847.0, 10516.26386152962, 10683.519241634145, 11203.0, 11495.137864660184, 11817.88182118185, 19417.0, 19417.0, 19510.414687559394, 19537.21851125939, 19669.311574094838, 7773.494722842997, 8161.387895907831, 8179.100298967109, 8194.50832950025, 8386.161383861565, 4476.529964353761, 4510.661700372485, 4537.3647689323525, 4539.273716205391, 4616.76916154191, 3262.9347413052083, 3282.573265475473, 3291.7860339077884, 3299.0762586475826, 3299.785513941586, 579.7680927628898, 600.3486217454024, 604.1873679900615, 609.9481544068803, 624.5222404860285, 641.7930465796748, 661.497262080822, 687.2920891481782, 747.4468893019126, 761.13611051457, 10040.548175332127, 10127.746346534474, 10223.079922806983, 10372.688819335432, 10467.685969420929, 652.3443938841434, 683.5454422808776, 750.846076554305, 761.5354633673455, 774.9806254843674, 4435.756033418128, 4446.933296000562, 4671.906561868744, 4677.321788340671, 4722.929156062662, 60383.0, 60557.0, 60702.39297606968, 60849.39150608526, 61306.0, 49779.75110124426, 51577.48422515727, 51676.74161629168, 51709.74145129325, 51821.7408912953, 46110.30834537485, 46126.30810537845, 46599.30101048487, 47147.057058858634, 47151.0, 9743.26925480606, 9975.20198384113, 10003.29976901639, 10063.446510441996, 10143.492825358555, 36946.630533695396, 37176.81411592925, 37722.43416348812, 38898.4165237516, 39040.41439378468, 43857.78071109624, 44057.77971110252, 48351.27473087977, 49700.50299496959, 50263.49736502588, 11329.206955513035, 11360.659180224606, 11496.88503114958, 11591.18861679708, 11868.347240901834, 12818.294993775431, 13131.803022954473, 13411.329433528479, 13448.394822232827, 14959.252037398304, 13044.217346959213, 13075.280859552817, 13193.736125277248, 13367.799483007957, 13748.662727336177, 12492.750144997231, 13171.341432928124, 13370.465181392636, 13373.39819708135, 13838.308084595528, 11962.22245554071, 12306.569270075504, 12510.124291299522, 12530.0, 12854.0, 10507.15942724565, 10518.0, 10757.892421075689, 10914.781704366027, 10919.672409827717, 10775.892241077803, 11150.386728729998, 11269.380184089627, 11375.31748095117, 11454.656360309204], "unit": "score", "name": "yui.html", "value": 6932.72178689175}], "name": "dromaeo_css", "value": 7282.643084965621}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 104.0, 110.0, 110.0, 112.0, 119.0, 108.0, 112.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [162.0, 130.0, 149.0, 168.0, 123.0, 153.0, 150.0, 134.0, 164.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 165.0, 163.0, 163.0, 162.0, 160.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 74.0, 164.0, 77.0, 73.0, 73.0, 76.0, 155.0, 76.0], "unit": "score", "name": "audio-fft", "value": 91.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 149.0, 94.0, 96.0, 96.0, 144.0, 96.0, 95.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 98.0, 96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 57.0, 54.0, 61.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 83.0, 82.0, 83.0, 82.0, 82.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [115.0, 119.0, 111.0, 124.0, 113.0, 115.0, 124.0, 114.0, 111.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.6}, {"lowerIsBetter": true, "replicates": [128.0, 143.0, 138.0, 136.0, 149.0, 126.0, 140.0, 140.0, 140.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.1}, {"lowerIsBetter": true, "replicates": [65.0, 72.0, 65.0, 66.0, 68.0, 65.0, 66.0, 66.0, 66.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1495.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.59032952475576], "unit": "score", "name": "Richards", "value": 213.18877800000007}, {"lowerIsBetter": false, "replicates": [170.47391749062393], "unit": "score", "name": "DeltaBlue", "value": 387.84818800000005}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [932.8358208955224], "unit": "score", "name": "RayTrace", "value": 793.2682079999998}, {"lowerIsBetter": false, "replicates": [564.3340857787811], "unit": "score", "name": "Earley", "value": 1180.9724359999996}, {"lowerIsBetter": false, "replicates": [11144.444444444445], "unit": "score", "name": "Boyer", "value": 59.80226321036885}, {"lowerIsBetter": false, "replicates": [39057.692307692305], "unit": "score", "name": "RegExp", "value": 23.32408665681932}, {"lowerIsBetter": false, "replicates": [504.54086781029264], "unit": "score", "name": "Splay", "value": 161.51516199999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 22088.050561055847}]} 03:37:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22088.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1495.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7282.64"}}} 03:37:28 INFO - Return code: 0 03:37:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:37:28 INFO - # TBPL SUCCESS # 03:37:28 INFO - Running post-action listener: _resource_record_post_action 03:37:28 INFO - Running post-run listener: _resource_record_post_run 03:37:30 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517935104; Read time: 108; Write time: 357144 03:37:30 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 252760064; Read time: 0; Write time: 221332 03:37:30 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 264577024; Read time: 108; Write time: 135812 03:37:30 INFO - Running post-run listener: _upload_blobber_files 03:37:30 INFO - Blob upload gear active. 03:37:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 03:37:30 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:37:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 03:37:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 03:37:30 INFO - (blobuploader) - INFO - Open directory for files ... 03:37:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:37:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:37:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:31 INFO - (blobuploader) - INFO - Done attempting. 03:37:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:37:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:32 INFO - (blobuploader) - INFO - Done attempting. 03:37:32 INFO - (blobuploader) - INFO - Iteration through files over. 03:37:32 INFO - Return code: 0 03:37:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 03:37:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 03:37:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/598943357e7a3359557a0415573c0d5e95e8f94f2b21ae59fc2b49373df3000cc4d3f2dec38fdd64795966c73ba450f0288f63c748dafcaddee208865a99f133", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ccf1f6ce2992ffa3a7fc3d0006df1f73a8e7257a8f6bfe77320d8c25823af5cef026dc05eeeacefef42346a4f48d1703f1979a5708605e2d0786344dce83ab24"} 03:37:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 03:37:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 03:37:32 INFO - Contents: 03:37:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/598943357e7a3359557a0415573c0d5e95e8f94f2b21ae59fc2b49373df3000cc4d3f2dec38fdd64795966c73ba450f0288f63c748dafcaddee208865a99f133", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ccf1f6ce2992ffa3a7fc3d0006df1f73a8e7257a8f6bfe77320d8c25823af5cef026dc05eeeacefef42346a4f48d1703f1979a5708605e2d0786344dce83ab24"} 03:37:32 INFO - Running post-run listener: copy_logs_to_upload_dir 03:37:32 INFO - Copying logs to upload dir... 03:37:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 03:37:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.359912 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-25 03:37:31.861912) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 03:37:31.865171) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/598943357e7a3359557a0415573c0d5e95e8f94f2b21ae59fc2b49373df3000cc4d3f2dec38fdd64795966c73ba450f0288f63c748dafcaddee208865a99f133", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ccf1f6ce2992ffa3a7fc3d0006df1f73a8e7257a8f6bfe77320d8c25823af5cef026dc05eeeacefef42346a4f48d1703f1979a5708605e2d0786344dce83ab24"} build_url:https://queue.taskcluster.net/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011475 build_url: 'https://queue.taskcluster.net/v1/task/VhFvNIE8TzShrGIrc4MBIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/598943357e7a3359557a0415573c0d5e95e8f94f2b21ae59fc2b49373df3000cc4d3f2dec38fdd64795966c73ba450f0288f63c748dafcaddee208865a99f133", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ccf1f6ce2992ffa3a7fc3d0006df1f73a8e7257a8f6bfe77320d8c25823af5cef026dc05eeeacefef42346a4f48d1703f1979a5708605e2d0786344dce83ab24"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 03:37:31.890710) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:37:31.891050) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456398986.946878-989283475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:37:31.976032) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 03:37:31.976406) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 03:37:31.976755) ========= ========= Total master_lag: 0.28 =========