builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1452817036.16 results: success (0) buildid: 20160114133012 builduid: 41870f43a616461d868adfe003c49912 revision: 6593b2842fa103cc725f5bd2f7c9039ac0978855 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.159740) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.160261) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.160605) ========= 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=1861a34ebfea852630dec091000001fa-1452817035.874978-103113873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006449 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.184151) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.184487) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.199613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.199979) ========= 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=1861a34ebfea852630dec091000001fa-1452817035.874978-103113873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.249662) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.250000) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.250463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.250784) ========= 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=1861a34ebfea852630dec091000001fa-1452817035.874978-103113873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 16:17:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.4M=0s 2016-01-14 16:17:17 (40.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160395 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.424410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.424798) ========= 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=1861a34ebfea852630dec091000001fa-1452817035.874978-103113873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017192 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:16.474752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 16:17:16.475158) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6593b2842fa103cc725f5bd2f7c9039ac0978855 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6593b2842fa103cc725f5bd2f7c9039ac0978855 --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=1861a34ebfea852630dec091000001fa-1452817035.874978-103113873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 16:17:17,270 truncating revision to first 12 chars 2016-01-14 16:17:17,271 Setting DEBUG logging. 2016-01-14 16:17:17,271 attempt 1/10 2016-01-14 16:17:17,271 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6593b2842fa1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 16:17:18,405 unpacking tar archive at: mozilla-inbound-6593b2842fa1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.417968 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 16:17:17.906106) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:17.906419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:17.913950) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:17.914256) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 16:17:17.914663) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-14 16:17:17.914942) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1452817035.874978-103113873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:17:18 INFO - MultiFileLogger online at 20160114 16:17:18 in /builds/slave/test-pgo 16:17:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:17:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:17:18 INFO - {'append_to_log': False, 16:17:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:17:18 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:17:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:17:18 INFO - 'branch': 'Mozilla-Inbound', 16:17:18 INFO - 'buildbot_json_path': 'buildprops.json', 16:17:18 INFO - 'config_files': ('talos/linux_config.py',), 16:17:18 INFO - 'default_actions': ('clobber', 16:17:18 INFO - 'read-buildbot-config', 16:17:18 INFO - 'download-and-extract', 16:17:18 INFO - 'populate-webroot', 16:17:18 INFO - 'create-virtualenv', 16:17:18 INFO - 'install', 16:17:18 INFO - 'run-tests'), 16:17:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:17:18 INFO - 'download_minidump_stackwalk': True, 16:17:18 INFO - 'download_symbols': 'ondemand', 16:17:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:17:18 INFO - 'tooltool.py': '/tools/tooltool.py', 16:17:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:17:18 INFO - '/tools/misc-python/virtualenv.py')}, 16:17:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:17:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:17:18 INFO - 'installer_path': 'installer.exe', 16:17:18 INFO - 'log_level': 'info', 16:17:18 INFO - 'log_name': 'talos', 16:17:18 INFO - 'log_to_console': True, 16:17:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:17:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:17:18 INFO - 'opt_config_files': (), 16:17:18 INFO - 'pip_index': False, 16:17:18 INFO - 'sps_profile': False, 16:17:18 INFO - 'sps_profile_interval': 0, 16:17:18 INFO - 'suite': 'dromaeojs-e10s', 16:17:18 INFO - 'system_bits': '32', 16:17:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:17:18 INFO - 'title': 'talos-linux64-ix-069', 16:17:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:17:18 INFO - 'use_talos_json': True, 16:17:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:17:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:17:18 INFO - 'work_dir': 'build'} 16:17:18 INFO - ##### 16:17:18 INFO - ##### Running clobber step. 16:17:18 INFO - ##### 16:17:18 INFO - Running pre-action listener: _resource_record_pre_action 16:17:18 INFO - Running main action method: clobber 16:17:18 INFO - rmtree: /builds/slave/test-pgo/build 16:17:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:17:19 INFO - Running post-action listener: _resource_record_post_action 16:17:19 INFO - ##### 16:17:19 INFO - ##### Running read-buildbot-config step. 16:17:19 INFO - ##### 16:17:19 INFO - Running pre-action listener: _resource_record_pre_action 16:17:19 INFO - Running main action method: read_buildbot_config 16:17:19 INFO - Using buildbot properties: 16:17:19 INFO - { 16:17:19 INFO - "project": "", 16:17:19 INFO - "product": "firefox", 16:17:19 INFO - "script_repo_revision": "production", 16:17:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:17:19 INFO - "repository": "", 16:17:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:17:19 INFO - "buildid": "20160114133012", 16:17:19 INFO - "pgo_build": "True", 16:17:19 INFO - "basedir": "/builds/slave/test-pgo", 16:17:19 INFO - "buildnumber": 306, 16:17:19 INFO - "slavename": "talos-linux64-ix-069", 16:17:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:17:19 INFO - "platform": "ubuntu64_hw", 16:17:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:17:19 INFO - "branch": "mozilla-inbound", 16:17:19 INFO - "repo_path": "integration/mozilla-inbound", 16:17:19 INFO - "revision": "6593b2842fa103cc725f5bd2f7c9039ac0978855", 16:17:19 INFO - "stage_platform": "linux64-pgo", 16:17:19 INFO - "builduid": "41870f43a616461d868adfe003c49912", 16:17:19 INFO - "slavebuilddir": "test" 16:17:19 INFO - } 16:17:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:17:19 INFO - Running post-action listener: _resource_record_post_action 16:17:19 INFO - ##### 16:17:19 INFO - ##### Running download-and-extract step. 16:17:19 INFO - ##### 16:17:19 INFO - Running pre-action listener: _resource_record_pre_action 16:17:19 INFO - Running main action method: download_and_extract 16:17:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:19 INFO - https://queue.taskcluster.net/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:17:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/test_packages.json 16:17:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/test_packages.json 16:17:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:17:20 INFO - Downloaded 1448 bytes. 16:17:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:17:20 INFO - Using the following test package requirements: 16:17:20 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:17:20 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:17:20 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:17:20 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:20 INFO - u'jsshell-linux-x86_64.zip'], 16:17:20 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:17:20 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:17:20 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:17:20 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:17:20 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:17:20 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:17:20 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:17:20 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:20 INFO - https://queue.taskcluster.net/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:17:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:17:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:17:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:17:22 INFO - Downloaded 24032265 bytes. 16:17:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:17:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:17:23 INFO - Return code: 0 16:17:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:23 INFO - https://queue.taskcluster.net/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:17:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:17:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:17:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:17:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:17:26 INFO - Downloaded 24032265 bytes. 16:17:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:17:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:17:27 INFO - Return code: 0 16:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:27 INFO - https://queue.taskcluster.net/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:17:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:17:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:17:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:17:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:17:29 INFO - Downloaded 11132144 bytes. 16:17:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:17:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 16:17:29 INFO - Return code: 0 16:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:29 INFO - https://queue.taskcluster.net/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:17:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:17:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:17:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:17:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:17:33 INFO - Downloaded 55853813 bytes. 16:17:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:17:33 INFO - mkdir: /builds/slave/test-pgo/properties 16:17:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:17:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:17:33 INFO - Contents: 16:17:33 INFO - build_url:https://queue.taskcluster.net/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:17:33 INFO - Running post-action listener: _resource_record_post_action 16:17:33 INFO - Running post-action listener: set_extra_try_arguments 16:17:33 INFO - ##### 16:17:33 INFO - ##### Running populate-webroot step. 16:17:33 INFO - ##### 16:17:33 INFO - Running pre-action listener: _resource_record_pre_action 16:17:33 INFO - Running main action method: populate_webroot 16:17:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:17:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:17:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:17:33 INFO - '--tppagecycles', 16:17:33 INFO - '7'], 16:17:33 INFO - 'tests': ['tsvgm']}}, 16:17:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:17:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:17:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:17:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:17:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:17:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:17:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:17:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:33 INFO - 'talos_options': ['--e10s'], 16:17:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:17:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:33 INFO - 'tests': ['damp', 'tps']}, 16:17:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:33 INFO - 'talos_options': ['--e10s'], 16:17:33 INFO - 'tests': ['damp', 'tps']}, 16:17:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:17:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:17:33 INFO - 'other': {'tests': ['a11yr', 16:17:33 INFO - 'ts_paint', 16:17:33 INFO - 'tpaint', 16:17:33 INFO - 'sessionrestore', 16:17:33 INFO - 'sessionrestore_no_auto_restore']}, 16:17:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:17:33 INFO - 'tests': ['a11yr', 16:17:33 INFO - 'ts_paint', 16:17:33 INFO - 'tpaint', 16:17:33 INFO - 'sessionrestore', 16:17:33 INFO - 'sessionrestore_no_auto_restore']}, 16:17:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:17:33 INFO - 'tests': ['a11yr', 16:17:33 INFO - 'ts_paint', 16:17:33 INFO - 'tpaint', 16:17:33 INFO - 'sessionrestore', 16:17:33 INFO - 'sessionrestore_no_auto_restore']}, 16:17:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:17:33 INFO - 'tests': ['a11yr', 16:17:33 INFO - 'ts_paint', 16:17:33 INFO - 'tpaint', 16:17:33 INFO - 'sessionrestore', 16:17:33 INFO - 'sessionrestore_no_auto_restore']}, 16:17:33 INFO - 'other_l64': {'tests': ['a11yr', 16:17:33 INFO - 'ts_paint', 16:17:33 INFO - 'tpaint', 16:17:33 INFO - 'sessionrestore', 16:17:33 INFO - 'sessionrestore_no_auto_restore']}, 16:17:33 INFO - 'other_nol64': {'tests': ['a11yr', 16:17:33 INFO - 'ts_paint', 16:17:33 INFO - 'tpaint', 16:17:33 INFO - 'sessionrestore', 16:17:33 INFO - 'sessionrestore_no_auto_restore']}, 16:17:33 INFO - 'svgr': {'tests': ['tsvgx', 16:17:33 INFO - 'tsvgr_opacity', 16:17:33 INFO - 'tart', 16:17:33 INFO - 'tscrollx', 16:17:33 INFO - 'cart']}, 16:17:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:17:33 INFO - 'tests': ['tsvgx', 16:17:33 INFO - 'tsvgr_opacity', 16:17:33 INFO - 'tart', 16:17:33 INFO - 'tscrollx', 16:17:33 INFO - 'cart']}, 16:17:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:33 INFO - 'tests': ['tp5o']}, 16:17:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:33 INFO - 'talos_options': ['--e10s'], 16:17:33 INFO - 'tests': ['tp5o']}, 16:17:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:33 INFO - 'talos_options': ['--xperf_path', 16:17:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:17:33 INFO - 'tests': ['tp5n']}, 16:17:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:33 INFO - 'talos_options': ['--e10s', 16:17:33 INFO - '--xperf_path', 16:17:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:17:33 INFO - 'tests': ['tp5n']}}, 16:17:33 INFO - 'talos.zip': {'path': '', 16:17:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:17:33 INFO - Running post-action listener: _resource_record_post_action 16:17:33 INFO - ##### 16:17:33 INFO - ##### Running create-virtualenv step. 16:17:33 INFO - ##### 16:17:33 INFO - Running pre-action listener: _resource_record_pre_action 16:17:33 INFO - Running main action method: create_virtualenv 16:17:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:17:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 16:17:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:17:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:17:34 INFO - Using real prefix '/usr' 16:17:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:17:34 INFO - Installing distribute.............................................................................................................................................................................................done. 16:17:36 INFO - Installing pip.................done. 16:17:36 INFO - Return code: 0 16:17:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59a2293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20797f0>, '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 0x1fe52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5760>, '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': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:17:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:17:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:17:36 INFO - Using env: {'DISPLAY': ':0', 16:17:36 INFO - 'HOME': '/home/cltbld', 16:17:36 INFO - 'LANG': 'en_US.UTF-8', 16:17:36 INFO - 'LANGUAGE': 'en_US:en', 16:17:36 INFO - 'LOGNAME': 'cltbld', 16:17:36 INFO - 'MAIL': '/var/mail/cltbld', 16:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:36 INFO - 'MOZ_NO_REMOTE': '1', 16:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:36 INFO - 'NO_EM_RESTART': '1', 16:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:36 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:36 INFO - 'SHELL': '/bin/bash', 16:17:36 INFO - 'SHLVL': '1', 16:17:36 INFO - 'TERM': 'linux', 16:17:36 INFO - 'TMOUT': '86400', 16:17:36 INFO - 'USER': 'cltbld', 16:17:36 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 16:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:36 INFO - '_': '/tools/buildbot/bin/python'} 16:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:17:36 INFO - Cleaning up... 16:17:36 INFO - Return code: 0 16:17:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59a2293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20797f0>, '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 0x1fe52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5760>, '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': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:17:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:17:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:17:36 INFO - Using env: {'DISPLAY': ':0', 16:17:36 INFO - 'HOME': '/home/cltbld', 16:17:36 INFO - 'LANG': 'en_US.UTF-8', 16:17:36 INFO - 'LANGUAGE': 'en_US:en', 16:17:36 INFO - 'LOGNAME': 'cltbld', 16:17:36 INFO - 'MAIL': '/var/mail/cltbld', 16:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:36 INFO - 'MOZ_NO_REMOTE': '1', 16:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:36 INFO - 'NO_EM_RESTART': '1', 16:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:36 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:36 INFO - 'SHELL': '/bin/bash', 16:17:36 INFO - 'SHLVL': '1', 16:17:36 INFO - 'TERM': 'linux', 16:17:36 INFO - 'TMOUT': '86400', 16:17:36 INFO - 'USER': 'cltbld', 16:17:36 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 16:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:36 INFO - '_': '/tools/buildbot/bin/python'} 16:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:36 INFO - Downloading/unpacking psutil>=0.7.1 16:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:38 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:17:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:17:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:17:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:17:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:17:38 INFO - Installing collected packages: psutil 16:17:38 INFO - Running setup.py install for psutil 16:17:38 INFO - building 'psutil._psutil_linux' extension 16:17:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:17:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:17:39 INFO - building 'psutil._psutil_posix' extension 16:17:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:17:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:17:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:17:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:17:39 INFO - Successfully installed psutil 16:17:39 INFO - Cleaning up... 16:17:39 INFO - Return code: 0 16:17:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59a2293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20797f0>, '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 0x1fe52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5760>, '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': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:17:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:17:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:17:39 INFO - Using env: {'DISPLAY': ':0', 16:17:39 INFO - 'HOME': '/home/cltbld', 16:17:39 INFO - 'LANG': 'en_US.UTF-8', 16:17:39 INFO - 'LANGUAGE': 'en_US:en', 16:17:39 INFO - 'LOGNAME': 'cltbld', 16:17:39 INFO - 'MAIL': '/var/mail/cltbld', 16:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:39 INFO - 'MOZ_NO_REMOTE': '1', 16:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:39 INFO - 'NO_EM_RESTART': '1', 16:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:39 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:39 INFO - 'SHELL': '/bin/bash', 16:17:39 INFO - 'SHLVL': '1', 16:17:39 INFO - 'TERM': 'linux', 16:17:39 INFO - 'TMOUT': '86400', 16:17:39 INFO - 'USER': 'cltbld', 16:17:39 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 16:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:39 INFO - '_': '/tools/buildbot/bin/python'} 16:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:17:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:17:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:17:41 INFO - Installing collected packages: mozsystemmonitor 16:17:41 INFO - Running setup.py install for mozsystemmonitor 16:17:41 INFO - Successfully installed mozsystemmonitor 16:17:41 INFO - Cleaning up... 16:17:41 INFO - Return code: 0 16:17:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f59a2293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20797f0>, '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 0x1fe52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5760>, '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': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:17:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:17:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:17:41 INFO - Using env: {'DISPLAY': ':0', 16:17:41 INFO - 'HOME': '/home/cltbld', 16:17:41 INFO - 'LANG': 'en_US.UTF-8', 16:17:41 INFO - 'LANGUAGE': 'en_US:en', 16:17:41 INFO - 'LOGNAME': 'cltbld', 16:17:41 INFO - 'MAIL': '/var/mail/cltbld', 16:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:41 INFO - 'MOZ_NO_REMOTE': '1', 16:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:41 INFO - 'NO_EM_RESTART': '1', 16:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:41 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:41 INFO - 'SHELL': '/bin/bash', 16:17:41 INFO - 'SHLVL': '1', 16:17:41 INFO - 'TERM': 'linux', 16:17:41 INFO - 'TMOUT': '86400', 16:17:41 INFO - 'USER': 'cltbld', 16:17:41 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 16:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:41 INFO - '_': '/tools/buildbot/bin/python'} 16:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:41 INFO - Downloading/unpacking blobuploader==1.2.4 16:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:43 INFO - Downloading blobuploader-1.2.4.tar.gz 16:17:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:17:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:17:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:17:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:17:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:44 INFO - Downloading docopt-0.6.1.tar.gz 16:17:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:17:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:17:44 INFO - Installing collected packages: blobuploader, requests, docopt 16:17:44 INFO - Running setup.py install for blobuploader 16:17:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:17:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:17:44 INFO - Running setup.py install for requests 16:17:44 INFO - Running setup.py install for docopt 16:17:44 INFO - Successfully installed blobuploader requests docopt 16:17:44 INFO - Cleaning up... 16:17:44 INFO - Return code: 0 16:17:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:17: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')]} 16:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17: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')]} 16:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59a2293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20797f0>, '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 0x1fe52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5760>, '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': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:17:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:17:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:17:44 INFO - Using env: {'DISPLAY': ':0', 16:17:44 INFO - 'HOME': '/home/cltbld', 16:17:44 INFO - 'LANG': 'en_US.UTF-8', 16:17:44 INFO - 'LANGUAGE': 'en_US:en', 16:17:44 INFO - 'LOGNAME': 'cltbld', 16:17:44 INFO - 'MAIL': '/var/mail/cltbld', 16:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:44 INFO - 'MOZ_NO_REMOTE': '1', 16:17:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:44 INFO - 'NO_EM_RESTART': '1', 16:17:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:44 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:44 INFO - 'SHELL': '/bin/bash', 16:17:44 INFO - 'SHLVL': '1', 16:17:44 INFO - 'TERM': 'linux', 16:17:44 INFO - 'TMOUT': '86400', 16:17:44 INFO - 'USER': 'cltbld', 16:17:44 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 16:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:44 INFO - '_': '/tools/buildbot/bin/python'} 16:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:17:44 INFO - Running setup.py (path:/tmp/pip-0wedZo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:17:45 INFO - Running setup.py (path:/tmp/pip-V2CqVQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:17:45 INFO - Running setup.py (path:/tmp/pip-bfUOod-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:17:45 INFO - Running setup.py (path:/tmp/pip-4Y9uhw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:17:45 INFO - Running setup.py (path:/tmp/pip-qxGNTb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:17:45 INFO - Running setup.py (path:/tmp/pip-1VFgea-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:17:45 INFO - Running setup.py (path:/tmp/pip-mRTycm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:17:45 INFO - Running setup.py (path:/tmp/pip-nRTlgX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:17:45 INFO - Running setup.py (path:/tmp/pip-27apII-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:17:45 INFO - Running setup.py (path:/tmp/pip-TtMzwo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:17:45 INFO - Running setup.py (path:/tmp/pip-Du6uxF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:17:45 INFO - Running setup.py (path:/tmp/pip-1vZqW4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:17:45 INFO - Running setup.py (path:/tmp/pip-afmiRH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:17:45 INFO - Running setup.py (path:/tmp/pip-gIf1t_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:17:45 INFO - Running setup.py (path:/tmp/pip-hNg0md-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:17:46 INFO - Running setup.py (path:/tmp/pip-xkEc6p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:17:46 INFO - Running setup.py (path:/tmp/pip-LLlFpY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:17:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:17:46 INFO - Running setup.py install for manifestparser 16:17:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:17:46 INFO - Running setup.py install for mozcrash 16:17:46 INFO - Running setup.py install for mozdebug 16:17:46 INFO - Running setup.py install for mozdevice 16:17:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:17:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:17:46 INFO - Running setup.py install for mozfile 16:17:46 INFO - Running setup.py install for mozhttpd 16:17:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:17:46 INFO - Running setup.py install for mozinfo 16:17:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:17:46 INFO - Running setup.py install for mozInstall 16:17:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:17:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:17:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:17:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:17:46 INFO - Running setup.py install for mozleak 16:17:47 INFO - Running setup.py install for mozlog 16:17:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:17:47 INFO - Running setup.py install for moznetwork 16:17:47 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:17:47 INFO - Running setup.py install for mozprocess 16:17:47 INFO - Running setup.py install for mozprofile 16:17:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:17:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:17:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:17:47 INFO - Running setup.py install for mozrunner 16:17:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:17:47 INFO - Running setup.py install for mozscreenshot 16:17:47 INFO - Running setup.py install for moztest 16:17:47 INFO - Running setup.py install for mozversion 16:17:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:17:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:17:47 INFO - Cleaning up... 16:17:47 INFO - Return code: 0 16:17:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59a2293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20797f0>, '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 0x1fe52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5760>, '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': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:17:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:17:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:17:47 INFO - Using env: {'DISPLAY': ':0', 16:17:47 INFO - 'HOME': '/home/cltbld', 16:17:47 INFO - 'LANG': 'en_US.UTF-8', 16:17:47 INFO - 'LANGUAGE': 'en_US:en', 16:17:47 INFO - 'LOGNAME': 'cltbld', 16:17:47 INFO - 'MAIL': '/var/mail/cltbld', 16:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:47 INFO - 'MOZ_NO_REMOTE': '1', 16:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:47 INFO - 'NO_EM_RESTART': '1', 16:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:47 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:47 INFO - 'SHELL': '/bin/bash', 16:17:47 INFO - 'SHLVL': '1', 16:17:47 INFO - 'TERM': 'linux', 16:17:47 INFO - 'TMOUT': '86400', 16:17:47 INFO - 'USER': 'cltbld', 16:17:47 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 16:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:47 INFO - '_': '/tools/buildbot/bin/python'} 16:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:17:48 INFO - Running setup.py (path:/tmp/pip-X1YEqN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 16:17:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:17:48 INFO - Running setup.py (path:/tmp/pip-ntDR72-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:17:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:17:48 INFO - Running setup.py (path:/tmp/pip-RDr_19-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:17:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:17:48 INFO - Running setup.py (path:/tmp/pip-wbfRRl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:17:48 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)) 16:17:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:17:48 INFO - Running setup.py (path:/tmp/pip-EOWGIY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 16:17:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:17:48 INFO - Running setup.py (path:/tmp/pip-fDmivi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 16:17:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:17:48 INFO - Running setup.py (path:/tmp/pip-Y4fflW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 16:17:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:17:48 INFO - Running setup.py (path:/tmp/pip-p33A3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 16:17:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:17:48 INFO - Running setup.py (path:/tmp/pip-1CsrLB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 16:17:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:17:48 INFO - Running setup.py (path:/tmp/pip-gEu8fu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:17:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:17:48 INFO - Running setup.py (path:/tmp/pip-II3Vvk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 16:17:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:17:49 INFO - Running setup.py (path:/tmp/pip-OxUw1v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 16:17:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:17:49 INFO - Running setup.py (path:/tmp/pip-JhPXyg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:17:49 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)) 16:17:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:17:49 INFO - Running setup.py (path:/tmp/pip-4AJAAs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 16:17:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:17:49 INFO - Running setup.py (path:/tmp/pip-Sl61zg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 16:17:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:17:49 INFO - Running setup.py (path:/tmp/pip-CZputp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 16:17:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:17:49 INFO - Running setup.py (path:/tmp/pip-4ykXRf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 16:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:17:49 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)) 16:17:49 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)) 16:17:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:51 INFO - Downloading blessings-1.5.1.tar.gz 16:17:51 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:17:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:17:51 INFO - Installing collected packages: blessings 16:17:51 INFO - Running setup.py install for blessings 16:17:51 INFO - Successfully installed blessings 16:17:51 INFO - Cleaning up... 16:17:51 INFO - Return code: 0 16:17:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:17:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:17:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:17:51 INFO - Reading from file tmpfile_stdout 16:17:51 INFO - Current package versions: 16:17:51 INFO - argparse == 1.2.1 16:17:51 INFO - blessings == 1.5.1 16:17:51 INFO - blobuploader == 1.2.4 16:17:51 INFO - docopt == 0.6.1 16:17:51 INFO - manifestparser == 1.1 16:17:51 INFO - mozInstall == 1.12 16:17:51 INFO - mozcrash == 0.16 16:17:51 INFO - mozdebug == 0.1 16:17:51 INFO - mozdevice == 0.48 16:17:51 INFO - mozfile == 1.2 16:17:51 INFO - mozhttpd == 0.7 16:17:51 INFO - mozinfo == 0.9 16:17:51 INFO - mozleak == 0.1 16:17:51 INFO - mozlog == 3.1 16:17:51 INFO - moznetwork == 0.27 16:17:51 INFO - mozprocess == 0.22 16:17:51 INFO - mozprofile == 0.28 16:17:51 INFO - mozrunner == 6.11 16:17:51 INFO - mozscreenshot == 0.1 16:17:51 INFO - mozsystemmonitor == 0.0 16:17:51 INFO - moztest == 0.7 16:17:51 INFO - mozversion == 1.4 16:17:51 INFO - psutil == 3.1.1 16:17:51 INFO - requests == 1.2.3 16:17:51 INFO - wsgiref == 0.1.2 16:17:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f59a2293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20797f0>, '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 0x1fe52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5760>, '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': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:17:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:17:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:17:51 INFO - Using env: {'DISPLAY': ':0', 16:17:51 INFO - 'HOME': '/home/cltbld', 16:17:51 INFO - 'LANG': 'en_US.UTF-8', 16:17:51 INFO - 'LANGUAGE': 'en_US:en', 16:17:51 INFO - 'LOGNAME': 'cltbld', 16:17:51 INFO - 'MAIL': '/var/mail/cltbld', 16:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:51 INFO - 'MOZ_NO_REMOTE': '1', 16:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:51 INFO - 'NO_EM_RESTART': '1', 16:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:51 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:51 INFO - 'SHELL': '/bin/bash', 16:17:51 INFO - 'SHLVL': '1', 16:17:51 INFO - 'TERM': 'linux', 16:17:51 INFO - 'TMOUT': '86400', 16:17:51 INFO - 'USER': 'cltbld', 16:17:51 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 16:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:51 INFO - '_': '/tools/buildbot/bin/python'} 16:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:51 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)) 16:17:51 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)) 16:17:51 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)) 16:17:51 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)) 16:17:51 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)) 16:17:51 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)) 16:17:51 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)) 16:17:51 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)) 16:17:51 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)) 16:17:51 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)) 16:17:51 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)) 16:17:51 INFO - Cleaning up... 16:17:51 INFO - Return code: 0 16:17:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59a2293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20797f0>, '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 0x1fe52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5760>, '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': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:17:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:17:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:17:51 INFO - Using env: {'DISPLAY': ':0', 16:17:51 INFO - 'HOME': '/home/cltbld', 16:17:51 INFO - 'LANG': 'en_US.UTF-8', 16:17:51 INFO - 'LANGUAGE': 'en_US:en', 16:17:51 INFO - 'LOGNAME': 'cltbld', 16:17:51 INFO - 'MAIL': '/var/mail/cltbld', 16:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:51 INFO - 'MOZ_NO_REMOTE': '1', 16:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:51 INFO - 'NO_EM_RESTART': '1', 16:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:51 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:51 INFO - 'SHELL': '/bin/bash', 16:17:51 INFO - 'SHLVL': '1', 16:17:51 INFO - 'TERM': 'linux', 16:17:51 INFO - 'TMOUT': '86400', 16:17:51 INFO - 'USER': 'cltbld', 16:17:51 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 16:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:51 INFO - '_': '/tools/buildbot/bin/python'} 16:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:52 INFO - Downloading/unpacking jsonschema 16:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:17:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 16:17:53 INFO - Downloading/unpacking functools32 (from jsonschema) 16:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:53 INFO - Downloading functools32-3.2.3-2.tar.gz 16:17:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:17:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:17:54 INFO - warning: no files found matching '*.txt' 16:17:54 INFO - no previously-included directories found matching 'build' 16:17:54 INFO - no previously-included directories found matching 'dist' 16:17:54 INFO - no previously-included directories found matching '.git*' 16:17:54 INFO - Installing collected packages: jsonschema, functools32 16:17:54 INFO - Running setup.py install for functools32 16:17:54 INFO - warning: no files found matching '*.txt' 16:17:54 INFO - no previously-included directories found matching 'build' 16:17:54 INFO - no previously-included directories found matching 'dist' 16:17:54 INFO - no previously-included directories found matching '.git*' 16:17:54 INFO - Successfully installed jsonschema functools32 16:17:54 INFO - Cleaning up... 16:17:54 INFO - Return code: 0 16:17:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59a2293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20797f0>, '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 0x1fe52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5760>, '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': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:17:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:17:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:17:54 INFO - Using env: {'DISPLAY': ':0', 16:17:54 INFO - 'HOME': '/home/cltbld', 16:17:54 INFO - 'LANG': 'en_US.UTF-8', 16:17:54 INFO - 'LANGUAGE': 'en_US:en', 16:17:54 INFO - 'LOGNAME': 'cltbld', 16:17:54 INFO - 'MAIL': '/var/mail/cltbld', 16:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:54 INFO - 'MOZ_NO_REMOTE': '1', 16:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:54 INFO - 'NO_EM_RESTART': '1', 16:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:54 INFO - 'SHELL': '/bin/bash', 16:17:54 INFO - 'SHLVL': '1', 16:17:54 INFO - 'TERM': 'linux', 16:17:54 INFO - 'TMOUT': '86400', 16:17:54 INFO - 'USER': 'cltbld', 16:17:54 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 16:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:54 INFO - '_': '/tools/buildbot/bin/python'} 16:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:54 INFO - Downloading/unpacking flake8 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:17:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:17:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:17:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:17:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 16:17:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:17:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:17:56 INFO - no previously-included directories found matching 'docs/_build' 16:17:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:17:56 INFO - Running setup.py install for pep8 16:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:17:56 INFO - no previously-included directories found matching 'docs/_build' 16:17:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:17:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:17:56 INFO - Cleaning up... 16:17:57 INFO - Return code: 0 16:17:57 INFO - Running post-action listener: _resource_record_post_action 16:17:57 INFO - Running post-action listener: _start_resource_monitoring 16:17:57 INFO - Starting resource monitoring. 16:17:57 INFO - ##### 16:17:57 INFO - ##### Running install step. 16:17:57 INFO - ##### 16:17:57 INFO - Running pre-action listener: _resource_record_pre_action 16:17:57 INFO - Running main action method: install 16:17:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:17:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:17:57 INFO - Reading from file tmpfile_stdout 16:17:57 INFO - Detecting whether we're running mozinstall >=1.0... 16:17:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:17:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:17:57 INFO - Reading from file tmpfile_stdout 16:17:57 INFO - Output received: 16:17:57 INFO - Usage: mozinstall [options] installer 16:17:57 INFO - Options: 16:17:57 INFO - -h, --help show this help message and exit 16:17:57 INFO - -d DEST, --destination=DEST 16:17:57 INFO - Directory to install application into. [default: 16:17:57 INFO - "/builds/slave/test-pgo"] 16:17:57 INFO - --app=APP Application being installed. [default: firefox] 16:17:57 INFO - mkdir: /builds/slave/test-pgo/build/application 16:17:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:17:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:18:13 INFO - Reading from file tmpfile_stdout 16:18:13 INFO - Output received: 16:18:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:18:13 INFO - Running post-action listener: _resource_record_post_action 16:18:13 INFO - ##### 16:18:13 INFO - ##### Running run-tests step. 16:18:13 INFO - ##### 16:18:13 INFO - Running pre-action listener: _resource_record_pre_action 16:18:13 INFO - Running main action method: run_tests 16:18:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:18:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:18:13 INFO - Python 2.7.3 16:18:13 INFO - Return code: 0 16:18:13 INFO - grabbing minidump binary from tooltool 16:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:13 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 0x20797f0>, '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 0x1fe52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:18:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 16:18:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:18:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:18:13 INFO - Return code: 0 16:18:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:18:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:18:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:18:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:18:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:18:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:18:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:18:14 INFO - Return code: 0 16:18:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 16:18:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 16:18:14 INFO - Using env: {'DISPLAY': ':0', 16:18:14 INFO - 'HOME': '/home/cltbld', 16:18:14 INFO - 'LANG': 'en_US.UTF-8', 16:18:14 INFO - 'LANGUAGE': 'en_US:en', 16:18:14 INFO - 'LOGNAME': 'cltbld', 16:18:14 INFO - 'MAIL': '/var/mail/cltbld', 16:18:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:18:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:14 INFO - 'MOZ_NO_REMOTE': '1', 16:18:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:14 INFO - 'NO_EM_RESTART': '1', 16:18:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:18:14 INFO - 'PWD': '/builds/slave/test-pgo', 16:18:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:18:14 INFO - 'SHELL': '/bin/bash', 16:18:14 INFO - 'SHLVL': '1', 16:18:14 INFO - 'TERM': 'linux', 16:18:14 INFO - 'TMOUT': '86400', 16:18:14 INFO - 'USER': 'cltbld', 16:18:14 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452817035.874978-103113873', 16:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:14 INFO - '_': '/tools/buildbot/bin/python'} 16:18:14 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 16:18:14 INFO - mozversion application_buildid: 20160114133012 16:18:14 INFO - mozversion application_changeset: 6593b2842fa103cc725f5bd2f7c9039ac0978855 16:18:14 INFO - mozversion application_display_name: Nightly 16:18:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:18:14 INFO - mozversion application_name: Firefox 16:18:14 INFO - mozversion application_remotingname: firefox 16:18:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:18:14 INFO - mozversion application_vendor: Mozilla 16:18:14 INFO - mozversion application_version: 46.0a1 16:18:14 INFO - mozversion platform_buildid: 20160114133012 16:18:14 INFO - mozversion platform_changeset: 6593b2842fa103cc725f5bd2f7c9039ac0978855 16:18:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:18:14 INFO - mozversion platform_version: 46.0a1 16:18:14 INFO - using testdate: 1452817094 16:18:14 INFO - actual date: 1452817094 16:18:14 INFO - starting webserver on 'localhost:48037' 16:18:14 INFO - SUITE-START | Running 3 tests 16:18:14 INFO - TEST-START | dromaeo_css 16:18:14 INFO - operating with platform_type : linux_ 16:18:14 INFO - Initialising browser for dromaeo_css test... 16:18:14 INFO - TEST-INFO | started process 10871 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpijdEXi/profile http://localhost:48037/getInfo.html) 16:18:18 INFO - PROCESS | 10871 | 16:18:18 INFO - PROCESS | 10871 | (process:10953): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:18:19 INFO - PROCESS | 10871 | __metrics Screen width/height:1600/1200 16:18:19 INFO - PROCESS | 10871 | colorDepth:24 16:18:19 INFO - PROCESS | 10871 | Browser inner width/height: 1024/697 16:18:19 INFO - PROCESS | 10871 | __metrics 16:18:19 INFO - PROCESS | 10871 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:18:20 INFO - TEST-INFO | 10871: exit 0 16:18:20 INFO - Browser initialized. 16:18:20 INFO - Running cycle 1/1 for dromaeo_css test... 16:18:20 INFO - TEST-INFO | started process 11002 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpijdEXi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:21 INFO - PROCESS | 11002 | 16:18:21 INFO - PROCESS | 11002 | (process:11060): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:18:32 INFO - PROCESS | 11002 | RSS: Main: 151085056 16:18:32 INFO - PROCESS | 11002 | 16:19:21 INFO - PROCESS | 11002 | 1452817161934 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:21:30 INFO - PROCESS | 11002 | Cycle 1(1): loaded http://localhost:48037/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48037/tests/dromaeo/cssquery-ext.html) 16:21:31 INFO - PROCESS | 11002 | RSS: Main: 154943488 16:21:31 INFO - PROCESS | 11002 | 16:24:33 INFO - PROCESS | 11002 | Cycle 1(1): loaded http://localhost:48037/tests/dromaeo/cssquery-ext.html (next: http://localhost:48037/tests/dromaeo/cssquery-jquery.html) 16:24:34 INFO - PROCESS | 11002 | RSS: Main: 151527424 16:24:34 INFO - PROCESS | 11002 | 16:27:35 INFO - PROCESS | 11002 | Cycle 1(1): loaded http://localhost:48037/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48037/tests/dromaeo/cssquery-mootools.html) 16:27:36 INFO - PROCESS | 11002 | RSS: Main: 152805376 16:27:36 INFO - PROCESS | 11002 | 16:30:38 INFO - PROCESS | 11002 | Cycle 1(1): loaded http://localhost:48037/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48037/tests/dromaeo/cssquery-prototype.html) 16:30:38 INFO - PROCESS | 11002 | RSS: Main: 149024768 16:30:38 INFO - PROCESS | 11002 | 16:33:41 INFO - PROCESS | 11002 | Cycle 1(1): loaded http://localhost:48037/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48037/tests/dromaeo/cssquery-yui.html) 16:33:41 INFO - PROCESS | 11002 | RSS: Main: 150671360 16:33:41 INFO - PROCESS | 11002 | 16:36:44 INFO - PROCESS | 11002 | Cycle 1(1): loaded http://localhost:48037/tests/dromaeo/cssquery-yui.html (next: http://localhost:48037/tests/dromaeo/cssquery-dojo.html) 16:36:44 INFO - PROCESS | 11002 | RSS: Main: 154107904 16:36:44 INFO - PROCESS | 11002 | 16:36:44 INFO - PROCESS | 11002 | __start_tp_report 16:36:44 INFO - PROCESS | 11002 | _x_x_mozilla_page_load 16:36:44 INFO - PROCESS | 11002 | _x_x_mozilla_page_load_details 16:36:44 INFO - PROCESS | 11002 | |i|pagename|runs| 16:36:44 INFO - PROCESS | 11002 | |0;dojo.html;3173.111528771944;3197.1847178969374;3215.646278909321;3231.3052693670866;3243.4972579250225;5129.974350128244;5202.583793296537;5209.583233341338;5236.685798852067;5246.580273578114;5242.108841496945;5244.527992480676;5298.09932311507;5323.733813309338;5350.384705758829;4830.975845120778;4860.3195552622665;4914.582260507861;4953.257011448276;5001.424836143854;4867.9269810952865;4871.391076115486;4894.388201474816;4904.386951631046;4958.876028099308;4789.736564488934;4802.2316429371485;4871.171900776876;4884.291777692232;4920.237363208708;4914.754262286871;4916.0905232532095;4920.163572192736;4922.064807686528;4981.626378021663;4896.657233993622;4899.216125419915;4902.901941961177;4919.631027672939;4938.851834444972;5050.823221187241;5065.569426598743;5078.5175408336145;5129.666571672829;5156.613254005927;5647.209390685307;5684.744186511617;5686.2039314496005;5686.488216060533;5698.059820129673;5729;5735.082386818089;5740.368559458456;5741.45456181662;5747.540196784289;5360;5385.649932754359;5459.153831156177;5463.071277882769;5497.917531237034;5846.444587764156;5873.177755114288;5876.118582212617;5884.735186916599;5895.764169433261;5443.047466693313;5522.337319521683;5626.85932851682;5644.181593668977;5675.858103547362;5676.574256930747;5676.943230567724;5697.430256974352;5698.088305871041;5727.713614319267;5616.466435688685;5629.746661400247;5656.6888821115235;5663.745131469093;5668.093105103246;5468.808591699351;5586.888262234733;5605.7197140142825;5606.299212598426;5705.744736158039;4416.271315233015;4436.64506839452;4439.733615983051;4462.531434199363;4469.932951005738;3932.6853851691794;3932.744371615836;3943.408488726714;3979.303621866162;3987.1228329767987;5172.094883395391;5238.633295669343;5249.658772179796;5334.279872217201;5347.625666203328;5666.603337766399;5679.630823996427;5682.034054210794;5688.601797874109;5694.686792226385;5220.451852555427;5282.841514754564;5300.257963885059;5300.840974770763;5349.010433069894;4765.237561990134;4806.8798280043275;4812.326274321597;4877.975610121926;4891.608671306287;5843.678597677083;5914.4381283777975;5917.112433134978;5949.077892926603;5984.132300816357;5607.74765135578;5769.07694768835;5806.82579522615;5807.883842323215;5844.240248767633;5824.5340372770925;5896.086106653475;5916.73374698131;5942.732577033958;5951.55363347742;5636.3799982002765;5643.097104463266;5652.5477961762135;5656.208130861601;5676.7445464955;5649.491545760901;5718.542516598579;5720.513756330759;5721;5722.3991480895575;5565.638233514808;5569.164625306074;5588.329400471969;5610.326760788568;5650.434956504481;5620.718964051863;5652.349979752216;5655.349634792052;5671.17767923657;5702.800401985911;5395.946040539544;5457.972710136424;5458.426865179258;5561.360443549043;5582.16267559853;5709.20071190042;5717.342505611908;5731.627444216113;5732.111522713986;5742.023855944583;5548.112302031655;5593.412691667317;5603.859903502445;5604.635698679573;5609.80365687199 16:36:44 INFO - PROCESS | 11002 | |1;ext.html;501.7090087749106;521.7573828169901;531.9547838433733;543.8422857371361;552.4944675621801;29140.708592914092;36689.63310366896;36889.81555092228;36913;37223.813880930626;39223.21553568927;39711.20577588447;39765;39844;39871.40192897109;8406;8553.40126191167;8598.22615964563;8599.656013759442;8615.95692021539;8264.710735124272;8428.283595894356;8460.78848028798;8462.323014158883;8487.448315859448;8461.407701460901;8510.234078932895;8514.616842242083;8558.358123140759;8558.572071396437;8396.07643159252;8487.74536763895;8552.102029286929;8594;8689.435186712843;8495.745127646118;8657.95671021641;8666.6100025499;8683.696070637561;8701.956490217572;39188.608113919065;40091;40108.398374024415;40256.19487610261;40378.596214037774;2938.9706102938912;2997.28065264335;3133.5769671094567;3218.4689526228144;3538.115471132217;30069.248268793453;30261;30431.847840760875;31071.37857242865;31209;3784.3377408953324;3875.8643447479485;3881.0879443330796;3917.5886531914307;4018.8593399230886;266126;266828;267031;268292;268316;53883;54767.45232547703;59205.40794592085;59511;59603;62878.68560657167;65230.84614423197;65856;65891.34108658852;65972.67013664998;15474.303656335493;15730.056196628238;15802.762958555631;15876.206189690469;15898.125603091941;11943.104267179997;11999.160058795975;12030;12062.69843253908;12070.517179312905;20234.494137646678;20416.897915510624;20571.58856822855;20589.38231853047;20618.175272988912;7341.375983041501;7510.436717246119;7567.621618919032;7607.885881711779;7636.69453221876;877.1623099939543;885.3227281129941;946.3091942881597;1036.9481525923825;1137.6871360375796;26694.19917402481;28947;29001.85499072491;29680.257993550335;29734.107976760733;1030.0883717909553;1034.5034383495963;1045.132539991805;1089.5315014543664;1094.4527736131934;15371.000884942667;15757;15826.366945322057;15830.366785328459;15856.60358491047;322802;332282;332655;332816.67958301236;334743;54900;54982.45017549853;55044.52299646525;55246;55371.44628553744;1280.1742875845214;1297.3772589157256;1315.2108734759067;1316.4010375279224;1329.5213723059692;28510.857445712638;29117.854410728658;29590.852045739633;29782.553261701527;29841.104766857028;46637.30044049274;46903.29645055395;47055.52944470511;47251.29123063088;47271;315153;315772;316445;316753.5785531818;317457;31506.842465787526;32754.83622581872;33548.66451335553;33596.16009599682;33617.49573756347;38804.6119538801;39424;39492;39695.80152099221;40316;33485.49771753377;33531.83234083814;33634.347432595365;33947;34318.48522272118;33557;36522.452163218106;36569.817150914074;37988.81005594954;38147;32866.83566582152;33479.33041339208;33507.832460838516;33886.83056584701;34014.829925850216;30073;31133.221669458446;31156.22109447282;31218.21954451066;31473.52789708202;24809;25422.618660719734;25743.613845792705;25985.480290394466;26082.60876086822 16:36:44 INFO - PROCESS | 11002 | |2;jquery.html;367.9651527055383;370.078504523736;374.4869528745619;375.62625187938005;375.63188075685827;15547;16868;16923.3230670773;17463.126843657814;17581;11151.665450036491;11869.940650296758;16476.917615411938;16508.504744857644;16575.419860304894;4996.175631020887;5563.554915606742;5564.081926482146;5567.610267281292;5573.885222955405;4263.59495847894;5087.643864929457;5134.666246693953;5561.499465048145;5564.026295398309;5128.358955130609;5132.769025393847;5143.845684629448;5167.48325167484;5382.67703937765;5301.125314323132;5306.124489459254;5315.681059136445;5334.386545547253;5342.118550439173;5372.355317361941;5376.059189641797;5383.542398896098;5383.919241211385;5387.595930305243;12123.757524849454;12775.87224127756;18274.45176644703;19825.405237842886;19944.90027549853;2032.2785411178966;2038.1949130093678;2124.1821997284287;2137.2840098567;2153.590817744639;9130.223930965876;9204.723858284262;9599.232061435137;9765.707028789147;9824;1735.1411051529446;1753.693103706859;1819.5905921167764;1821.080354421022;1840.5398650337415;52014;52496.21255681206;52735.736321318145;55812;58416.41583584152;9895.703128906145;10118.59525618967;10174.389536627827;10177;10216.131628811485;12807.423665935055;12996.285204313854;12998.545050923172;13067.215967042008;13113.27876966757;7308.378787803096;7323;7668.65491052904;7676.53940763556;7716;7424.698343513528;7684;7706.38348932084;7709.691612335444;7735.458517903805;4523.32150177476;4545.931811022837;4557.430321209848;4574.405327307429;4607.884802879955;1836.4123480486116;1845.344902559599;1891.3569386408412;1900.2873922279146;1908.7136929460414;775.7478819383723;912.1972664055721;982.5627595719836;994.2344394816096;1065.63235683689;14784.63038424048;15830;15898.284577194054;16354.836451635569;17010.744838827428;896.7264984179888;912.2473958983733;944.5749412764284;955.9569819358146;1000.8548760429843;9533.285003624756;9565.473898935486;9619.711408657611;9653.227741780782;9690.903090969141;449131;450934;463685;486656;494457;55100;71275;73522.31724577807;73804.63097684477;74426.88359674609;1101.212632967416;1107.0645304717661;1135.4833550734395;1144.8339990701302;1153.411760002388;14680.632984175481;14723.116613003254;14804.925975370485;15004.623691197054;15263.313150908014;30071.84964075253;30131.698683013765;30445.23886902845;31676;31935.520967185974;39908.600913990485;41377.1724565513;41947.790261048496;42221.15557688768;42340.36489452722;7365.373943214887;7542.245775422414;7595.240475952361;7621.961890190513;7821.843563128592;9162.31282653817;10507.684769456928;10737.838932416176;10910.181736369645;11655.417229138679;9228.723138305862;9684.273679473927;9819.410835349901;9887.110160085627;10151.543180556744;9210.539473026456;9316.20812230968;9810.509474526389;10014.248931330034;10457.529411176667;9821.017898210122;10321.277510574188;10329.793404132026;10430.791384172122;10576.524056417633;7565.735199268;7655.387568994356;7790.8831367530665;7814.843703125792;7834.725784597512;9351.485668288038;9961;10045.045720656526;10151.238657100599;10208.081272685495 16:36:44 INFO - PROCESS | 11002 | |3;mootools.html;1419.758641031025;1428.764253898107;1526.6870291590226;1703.8977661340314;1725.663495618354;7340.70637174513;7348.2651734826495;7491.475596708233;7522.623868806565;7545.660445279955;7592.12690540588;7659.042619672541;7667.079950405945;7675.385969122471;7756.573388463632;2323.9883800580974;2332.626779715246;2345.659879317498;2346.2609278077434;2350.25966820451;2340.3447034830187;2370.8696021718797;2376.3821406434276;2376.976230237701;2378.3816207786012;2277.1005452846116;2283.8858057097164;2291.702078729763;2297.9885100574556;2353.646952957053;2348.330725743155;2351.3416243451775;2354.6703461515403;2356.22244659262;2369.845960012594;2268.7050683411217;2281.9657705134437;2297.1615360393503;2301.4131396493954;2306.4925716342377;7504.5872477013745;7647.388208943326;7656.617169141577;7696.230376962315;7708;4741.359916411275;4822.107910036654;4849.127157111719;4853.417589889201;4865;3043.8337834824106;3135.827529485877;3154.57413249213;3158.7946783459233;3175.888843890476;1000.8748906386702;1011.519528224095;1014.3508154780947;1027.3014350241833;1053.961847580133;9935;9960.501974901226;9980.351277166961;9980.850287245697;9981.401115932995;4108.50697916246;4117.382392641128;4150.252954468165;4161.56303588125;4297.162053399557;8232.547209903512;8233.300169485541;8281.21328473794;8320.417570769989;8346.415750897379;4695.272232803921;4695.624350051988;4728.834490792806;4738.07607516531;4752.809887604457;4301.913961720748;4319.308910574293;4326.610605045561;4327.5239723630375;4329.28566786483;3449.3963556377535;3478.6347433519118;3509.1051781795477;3510.1049232446076;3542.1852973816167;1070.82866741321;1105.7290963713942;1121.4560937945091;1121.506537123663;1122.36586328724;1008.1581879130861;1012.6860673191334;1036.461040259076;1089.3300620118728;1206.4209179593845;6856.177258728885;6922.688479018456;6976.895346569806;7005.54463959841;7009.54437961541;1017.3844823881445;1021.8467229915572;1039.6776999130143;1123.1800785426685;1145.68493664243;5448.482394172547;5480.588955828329;5488.067028605146;5496.725163741797;5561.332640083216;9033.45595718587;9260.21288190498;9412.811743765087;9419.576119074658;9536.713898583053;9220.53897305132;9318.254539636813;9330.486823224652;9335.346525743269;9363.485008324471;6916.6541672916155;7092.822679432952;7109.253528379446;7158.498905076699;7203.567785932861;7035.648217588998;7059.929400706133;7067.505274630932;7112.6088065154845;7145.714171433085;8030.759077227693;8038.276555110068;8233;8305.37709671765;8388.622511987098;8487.405881588229;8513.063563008189;8527.658893644184;8612.267957223707;8621.094785047731;6573.3098024706715;6755.594664320157;6781.254062053269;6819.215790184192;6832.316768323128;7107.466939979626;7121.394681452135;7130.643467826691;7199.316064973819;7207.783766487014;6711;6747.190337159376;6847.417969472651;6920.411765000032;7023.157221133497;6342.492600592034;6400.71196796136;6449.7097630605795;6484.70818813164;6743.662816859235;6506.642134682448;6531.575447595891;6627.536072474881;6627.569208001464;6665.833354166185;6159.907601385893;6174.629522228501;6180.443760061616;6185.938140618716;6196.194494715658;6032.8793424132145;6109.969450152721;6256.843578910381;6280.1207830902795;6303.873922521616 16:36:44 INFO - PROCESS | 11002 | |4;prototype.html;346.6810534308436;354.30732917146975;355.4703491797221;356.21987846615923;365.20385559480354;6259.342769009246;6306.779262725806;6344.873102537947;6410.134631824702;6412.358764123585;6133.233345831771;6281.654509002003;6308.116863639094;6340.58786178898;6350.936490635092;4835.540623640749;4846.273059041155;4864.294677271811;4872.4640289568115;4887.315775791392;4835.468098509161;4855.514448555134;4874.390701162355;4878.926816097762;4887.951120488803;4601.930971035437;4731;4743.430788305408;4754.263089221176;4754.85735427936;4724.905501889943;4739.502352252998;4741.122892264942;4742.672051825494;4755.571998520115;4145.626893579592;4183.6653067754505;4194.769287689176;4195;4203.7057405981595;5898.911516327258;6017.157597936292;6025.427584379477;6030.33666296707;6037.30570984338;5469.288992430998;5522.91715624266;5555.916661250085;5557.305336832896;5566.276384070085;6676.4992625552795;6684.030815531769;6686.632235227061;6687.832804179886;6697.598144111369;4571.6114130298965;4578.473475550321;4592.425946756655;4595.793189306456;4596.03483268514;6823.863522729567;6998.300169983012;7022.332878376546;7088.326608972139;7094.1841688206005;4723.598494128038;4759.50025247351;4762.357081793983;4764.309175169581;4772.5227477252;4807.110684523374;4819.855404337875;4834.734089625034;4838.274258861199;4841.201201801734;5545.140503222007;5587.972060139755;5589.524890384281;5598.636088654224;5599.692016939108;6556.409923106943;6767.1879374475375;6781.11845460087;6789.355011273921;6792.21889482706;1664.051490650342;1695.8473737363697;1698.8640908727273;1705.556555295632;1707.8804483686022;1122.7080958950569;1135.460656188304;1136.6419577832955;1141.5662048421714;1158.8377627132209;6285.434310911948;6292.716827742763;6297.086922396227;6309.08518264849;6315.684215789192;6799.082123913208;6808.319168083152;6834.316568343126;6871.244163142051;6882.414994725505;6244.063390491372;6252.749890004349;6303.6532990685955;6306.810795676137;6332.715027823759;3758.248350329945;3782.5650050244026;3787.0910981364273;3788.1666033472593;3789.5642001169667;7326.267373262738;7329.74345897891;7345.15530713964;7437.405007599379;7441.962790186014;7067.82330441743;7197.9640101800205;7204.891926621105;7211.278872112747;7228.638568071576;7277.417806575461;7291.963540182265;7311.0495635568095;7318.780436586911;7318.817029574303;6983.790486285419;6992.16094068715;7033.577985320897;7046.189688185924;7064.258252883374;6674.765168443853;6907.89638155418;6920.792376228721;6963.651817409211;6965.233824279427;7283.417326613964;7311.195768465358;7332.120145582564;7348.265173482609;7359.889601656087;4762.6189904808225;4808.3989501312335;4809.254565542346;4822.300766388784;4833.540813622701;6853;6866.519343645897;7059.294070593105;7059.752908648173;7072.681729322296;6801.2858649841055;6820.283870193757;6844.076049733222;6866.965665171842;6880.105586273752;6778.220504641832;6807.081044059187;6827.010083537959;6835.7949261522235;6845;6505.60966342021;6684.364985326386;6702;6709.966450167718;6716.018774461448;6805.149356330458;6815.727370905108;6863.794086177422;6864.828379290558;6890.793276201722;6649.534532582867;6672.799816005528;6680.565763225375;6695.296993815774;6702.865942681022 16:36:44 INFO - PROCESS | 11002 | |5;yui.html;826.3389288569143;826.7767702720265;828.5484410996006;851.2934264560415;874.0603850860326;13833.654158646026;13855.099418537788;13951.651208719763;13952.302384880753;13977.790333144998;12866.099373043891;13061.93469032656;13062.477500899977;13070.542531011417;13086.280254585994;662.1160750398224;666.014298837718;805.3275514944999;814.6293436486415;815.8735396013627;815.8164413007086;819.9795005124889;823.390690888744;824.2869917521331;824.3034635732796;859.1537335724306;861.8621020636699;865.074370423647;866.8873046503945;868.3747701654798;857.3869683176558;857.6012154348196;858.2919091749332;862.7153039496951;864.4683519635411;630.6531407725778;633.1009965848506;634.9301576826546;634.9714262858182;636.2810024672091;13618.18290902549;13665.453381864714;13665.931670341584;13689.589312320646;13695.452181912711;12808.6797830055;13106.934465327708;13238.27189504577;13295.86704132956;13369.259301843098;9956.701298961043;9989.650362237287;9995.050470205319;10114.747131321703;10227.130693891027;3520.559930008749;3546.627604101558;3549.112721819545;3585.731070169748;3606.495090687306;46154.307685384745;46166.30750538745;46272.53727462716;46429.30356044662;46572;9794.902050979541;9948.701538953843;9967.900320996698;10042.246831487668;10053.824404688225;18639.81360186408;18762.155702993397;18796.248150074116;18874.905625471783;18923.243070277036;7402.444816638774;7494.962525187449;7619.580923049175;7687.154413014564;7785.299323060838;4238.533761286256;4340.8697739067875;4341.305391137403;4377.9781101094295;4529.048899731093;3169.2869104451315;3177.396294703999;3192.058342788883;3214.4053350130303;3242.8054316741072;537.2907761754525;541.0315535192041;552.7927027364739;561.332014902265;566.1140315406376;563.4956713741178;603.7253049862389;636.9458596019298;674.5917076038495;677.2584020497547;8488.618012189343;8577.185167409087;8659.52372619512;8685.609147588248;8744.912550874536;528.5269683633204;550.0620798480413;618.8978818494988;624.3662682377391;646.9611823290618;3832.2143960488033;4050.959490405058;4086;4181.686373521937;4489.483709373399;53746.73126634342;54166.72916635471;54219;54635.45364546383;54980.72509637426;46821.76589117101;46834;47511.52488475071;48128;51274;44541.99999999935;45764.771176144575;46003;46152;46214.30678539824;8668.486533154351;8920.375573710038;8937;8938.24024957886;9011.864822027806;33379.165520862174;34363.65636343604;34565.82717086399;35396.46905296371;35503.28993420169;39598.80200598978;39626.40560391539;40103.997400064065;40268.395974061;40412;10366.896331036894;10688.732781680521;10829.891701083203;11056.617922759655;11118.833217501582;11722.238054526428;11778.705532361759;11810.232334898204;12007.75984480323;12066.276023438622;10536.994927409725;10747.785044299226;10866.456677165952;10919.781604367708;11053.11575073976;11458.82811757841;11618;11641.941790290994;11706.180567360203;12013.219140755822;11254.60608878718;11379.032782213604;11393.943030284796;11421.257618254787;11883.16817822744;9283.814323713623;9530.523473826419;9777.022297770167;9849.015098490094;10112.595496180365;8844.819334769156;9645.228381729585;9698.27262955267;9738.269629777653;9740.951295243478 16:36:44 INFO - PROCESS | 11002 | __end_tp_report 16:36:44 INFO - PROCESS | 11002 | __start_cc_report 16:36:44 INFO - PROCESS | 11002 | _x_x_mozilla_cycle_collect,317 16:36:44 INFO - PROCESS | 11002 | __end_cc_report 16:36:44 INFO - PROCESS | 11002 | __startTimestamp1452818204549__endTimestamp 16:36:44 INFO - PROCESS | 11002 | 16:36:44 INFO - PROCESS | 11002 | ------- Summary: start ------- 16:36:44 INFO - PROCESS | 11002 | Number of tests: 6 16:36:44 INFO - PROCESS | 11002 | 16:36:44 INFO - PROCESS | 11002 | [#0] dojo.html Cycles:165 Average:5304.65 Median:5561.36 stddev:581.38 (10.5%) stddev-sans-first:558.60 16:36:44 INFO - PROCESS | 11002 | Values: 3173.1 3197.2 3215.6 3231.3 3243.5 5130.0 5202.6 5209.6 5236.7 5246.6 5242.1 5244.5 5298.1 5323.7 5350.4 4831.0 4860.3 4914.6 4953.3 5001.4 4867.9 4871.4 4894.4 4904.4 4958.9 4789.7 4802.2 4871.2 4884.3 4920.2 4914.8 4916.1 4920.2 4922.1 4981.6 4896.7 4899.2 4902.9 4919.6 4938.9 5050.8 5065.6 5078.5 5129.7 5156.6 5647.2 5684.7 5686.2 5686.5 5698.1 5729.0 5735.1 5740.4 5741.5 5747.5 5360.0 5385.6 5459.2 5463.1 5497.9 5846.4 5873.2 5876.1 5884.7 5895.8 5443.0 5522.3 5626.9 5644.2 5675.9 5676.6 5676.9 5697.4 5698.1 5727.7 5616.5 5629.7 5656.7 5663.7 5668.1 5468.8 5586.9 5605.7 5606.3 5705.7 4416.3 4436.6 4439.7 4462.5 4469.9 3932.7 3932.7 3943.4 3979.3 3987.1 5172.1 5238.6 5249.7 5334.3 5347.6 5666.6 5679.6 5682.0 5688.6 5694.7 5220.5 5282.8 5300.3 5300.8 5349.0 4765.2 4806.9 4812.3 4878.0 4891.6 5843.7 5914.4 5917.1 5949.1 5984.1 5607.7 5769.1 5806.8 5807.9 5844.2 5824.5 5896.1 5916.7 5942.7 5951.6 5636.4 5643.1 5652.5 5656.2 5676.7 5649.5 5718.5 5720.5 5721.0 5722.4 5565.6 5569.2 5588.3 5610.3 5650.4 5620.7 5652.3 5655.3 5671.2 5702.8 5395.9 5458.0 5458.4 5561.4 5582.2 5709.2 5717.3 5731.6 5732.1 5742.0 5548.1 5593.4 5603.9 5604.6 5609.8 16:36:44 INFO - PROCESS | 11002 | 16:36:44 INFO - PROCESS | 11002 | [#1] ext.html Cycles:180 Average:47262.13 Median:33980.91 stddev:80148.99 (235.9%) stddev-sans-first:80296.93 16:36:44 INFO - PROCESS | 11002 | Values: 501.7 521.8 532.0 543.8 552.5 29140.7 36689.6 36889.8 36913.0 37223.8 39223.2 39711.2 39765.0 39844.0 39871.4 8406.0 8553.4 8598.2 8599.7 8616.0 8264.7 8428.3 8460.8 8462.3 8487.4 8461.4 8510.2 8514.6 8558.4 8558.6 8396.1 8487.7 8552.1 8594.0 8689.4 8495.7 8658.0 8666.6 8683.7 8702.0 39188.6 40091.0 40108.4 40256.2 40378.6 2939.0 2997.3 3133.6 3218.5 3538.1 30069.2 30261.0 30431.8 31071.4 31209.0 3784.3 3875.9 3881.1 3917.6 4018.9 266126.0 266828.0 267031.0 268292.0 268316.0 53883.0 54767.5 59205.4 59511.0 59603.0 62878.7 65230.8 65856.0 65891.3 65972.7 15474.3 15730.1 15802.8 15876.2 15898.1 11943.1 11999.2 12030.0 12062.7 12070.5 20234.5 20416.9 20571.6 20589.4 20618.2 7341.4 7510.4 7567.6 7607.9 7636.7 877.2 885.3 946.3 1036.9 1137.7 26694.2 28947.0 29001.9 29680.3 29734.1 1030.1 1034.5 1045.1 1089.5 1094.5 15371.0 15757.0 15826.4 15830.4 15856.6 322802.0 332282.0 332655.0 332816.7 334743.0 54900.0 54982.5 55044.5 55246.0 55371.4 1280.2 1297.4 1315.2 1316.4 1329.5 28510.9 29117.9 29590.9 29782.6 29841.1 46637.3 46903.3 47055.5 47251.3 47271.0 315153.0 315772.0 316445.0 316753.6 317457.0 31506.8 32754.8 33548.7 33596.2 33617.5 38804.6 39424.0 39492.0 39695.8 40316.0 33485.5 33531.8 33634.3 33947.0 34318.5 33557.0 36522.5 36569.8 37988.8 38147.0 32866.8 33479.3 33507.8 33886.8 34014.8 30073.0 31133.2 31156.2 31218.2 31473.5 24809.0 25422.6 25743.6 25985.5 26082.6 16:36:44 INFO - PROCESS | 11002 | 16:36:44 INFO - PROCESS | 11002 | [#2] jquery.html Cycles:180 Average:25206.53 Median:4565.92 stddev:76694.62 (1679.7%) stddev-sans-first:76887.09 16:36:44 INFO - PROCESS | 11002 | Values: 368.0 370.1 374.5 375.6 375.6 15547.0 16868.0 16923.3 17463.1 17581.0 11151.7 11869.9 16476.9 16508.5 16575.4 4996.2 5563.6 5564.1 5567.6 5573.9 4263.6 5087.6 5134.7 5561.5 5564.0 5128.4 5132.8 5143.8 5167.5 5382.7 5301.1 5306.1 5315.7 5334.4 5342.1 5372.4 5376.1 5383.5 5383.9 5387.6 12123.8 12775.9 18274.5 19825.4 19944.9 2032.3 2038.2 2124.2 2137.3 2153.6 9130.2 9204.7 9599.2 9765.7 9824.0 1735.1 1753.7 1819.6 1821.1 1840.5 52014.0 52496.2 52735.7 55812.0 58416.4 9895.7 10118.6 10174.4 10177.0 10216.1 12807.4 12996.3 12998.5 13067.2 13113.3 7308.4 7323.0 7668.7 7676.5 7716.0 7424.7 7684.0 7706.4 7709.7 7735.5 4523.3 4545.9 4557.4 4574.4 4607.9 1836.4 1845.3 1891.4 1900.3 1908.7 775.7 912.2 982.6 994.2 1065.6 14784.6 15830.0 15898.3 16354.8 17010.7 896.7 912.2 944.6 956.0 1000.9 9533.3 9565.5 9619.7 9653.2 9690.9 449131.0 450934.0 463685.0 486656.0 494457.0 55100.0 71275.0 73522.3 73804.6 74426.9 1101.2 1107.1 1135.5 1144.8 1153.4 14680.6 14723.1 14804.9 15004.6 15263.3 30071.8 30131.7 30445.2 31676.0 31935.5 39908.6 41377.2 41947.8 42221.2 42340.4 7365.4 7542.2 7595.2 7622.0 7821.8 9162.3 10507.7 10737.8 10910.2 11655.4 9228.7 9684.3 9819.4 9887.1 10151.5 9210.5 9316.2 9810.5 10014.2 10457.5 9821.0 10321.3 10329.8 10430.8 10576.5 7565.7 7655.4 7790.9 7814.8 7834.7 9351.5 9961.0 10045.0 10151.2 10208.1 16:36:44 INFO - PROCESS | 11002 | 16:36:44 INFO - PROCESS | 11002 | [#3] mootools.html Cycles:180 Average:5316.76 Median:6191.07 stddev:2695.79 (43.5%) stddev-sans-first:2687.44 16:36:44 INFO - PROCESS | 11002 | Values: 1419.8 1428.8 1526.7 1703.9 1725.7 7340.7 7348.3 7491.5 7522.6 7545.7 7592.1 7659.0 7667.1 7675.4 7756.6 2324.0 2332.6 2345.7 2346.3 2350.3 2340.3 2370.9 2376.4 2377.0 2378.4 2277.1 2283.9 2291.7 2298.0 2353.6 2348.3 2351.3 2354.7 2356.2 2369.8 2268.7 2282.0 2297.2 2301.4 2306.5 7504.6 7647.4 7656.6 7696.2 7708.0 4741.4 4822.1 4849.1 4853.4 4865.0 3043.8 3135.8 3154.6 3158.8 3175.9 1000.9 1011.5 1014.4 1027.3 1054.0 9935.0 9960.5 9980.4 9980.9 9981.4 4108.5 4117.4 4150.3 4161.6 4297.2 8232.5 8233.3 8281.2 8320.4 8346.4 4695.3 4695.6 4728.8 4738.1 4752.8 4301.9 4319.3 4326.6 4327.5 4329.3 3449.4 3478.6 3509.1 3510.1 3542.2 1070.8 1105.7 1121.5 1121.5 1122.4 1008.2 1012.7 1036.5 1089.3 1206.4 6856.2 6922.7 6976.9 7005.5 7009.5 1017.4 1021.8 1039.7 1123.2 1145.7 5448.5 5480.6 5488.1 5496.7 5561.3 9033.5 9260.2 9412.8 9419.6 9536.7 9220.5 9318.3 9330.5 9335.3 9363.5 6916.7 7092.8 7109.3 7158.5 7203.6 7035.6 7059.9 7067.5 7112.6 7145.7 8030.8 8038.3 8233.0 8305.4 8388.6 8487.4 8513.1 8527.7 8612.3 8621.1 6573.3 6755.6 6781.3 6819.2 6832.3 7107.5 7121.4 7130.6 7199.3 7207.8 6711.0 6747.2 6847.4 6920.4 7023.2 6342.5 6400.7 6449.7 6484.7 6743.7 6506.6 6531.6 6627.5 6627.6 6665.8 6159.9 6174.6 6180.4 6185.9 6196.2 6032.9 6110.0 6256.8 6280.1 6303.9 16:36:44 INFO - PROCESS | 11002 | 16:36:44 INFO - PROCESS | 11002 | [#4] prototype.html Cycles:180 Average:5634.99 Median:6307.46 stddev:1718.51 (27.2%) stddev-sans-first:1676.86 16:36:44 INFO - PROCESS | 11002 | Values: 346.7 354.3 355.5 356.2 365.2 6259.3 6306.8 6344.9 6410.1 6412.4 6133.2 6281.7 6308.1 6340.6 6350.9 4835.5 4846.3 4864.3 4872.5 4887.3 4835.5 4855.5 4874.4 4878.9 4888.0 4601.9 4731.0 4743.4 4754.3 4754.9 4724.9 4739.5 4741.1 4742.7 4755.6 4145.6 4183.7 4194.8 4195.0 4203.7 5898.9 6017.2 6025.4 6030.3 6037.3 5469.3 5522.9 5555.9 5557.3 5566.3 6676.5 6684.0 6686.6 6687.8 6697.6 4571.6 4578.5 4592.4 4595.8 4596.0 6823.9 6998.3 7022.3 7088.3 7094.2 4723.6 4759.5 4762.4 4764.3 4772.5 4807.1 4819.9 4834.7 4838.3 4841.2 5545.1 5588.0 5589.5 5598.6 5599.7 6556.4 6767.2 6781.1 6789.4 6792.2 1664.1 1695.8 1698.9 1705.6 1707.9 1122.7 1135.5 1136.6 1141.6 1158.8 6285.4 6292.7 6297.1 6309.1 6315.7 6799.1 6808.3 6834.3 6871.2 6882.4 6244.1 6252.7 6303.7 6306.8 6332.7 3758.2 3782.6 3787.1 3788.2 3789.6 7326.3 7329.7 7345.2 7437.4 7442.0 7067.8 7198.0 7204.9 7211.3 7228.6 7277.4 7292.0 7311.0 7318.8 7318.8 6983.8 6992.2 7033.6 7046.2 7064.3 6674.8 6907.9 6920.8 6963.7 6965.2 7283.4 7311.2 7332.1 7348.3 7359.9 4762.6 4808.4 4809.3 4822.3 4833.5 6853.0 6866.5 7059.3 7059.8 7072.7 6801.3 6820.3 6844.1 6867.0 6880.1 6778.2 6807.1 6827.0 6835.8 6845.0 6505.6 6684.4 6702.0 6710.0 6716.0 6805.1 6815.7 6863.8 6864.8 6890.8 6649.5 6672.8 6680.6 6695.3 6702.9 16:36:44 INFO - PROCESS | 11002 | 16:36:44 INFO - PROCESS | 11002 | [#5] yui.html Cycles:180 Average:13460.97 Median:46190.31 stddev:15105.38 (32.7%) stddev-sans-first:15117.95 16:36:44 INFO - PROCESS | 11002 | Values: 826.3 826.8 828.5 851.3 874.1 13833.7 13855.1 13951.7 13952.3 13977.8 12866.1 13061.9 13062.5 13070.5 13086.3 662.1 666.0 805.3 814.6 815.9 815.8 820.0 823.4 824.3 824.3 859.2 861.9 865.1 866.9 868.4 857.4 857.6 858.3 862.7 864.5 630.7 633.1 634.9 635.0 636.3 13618.2 13665.5 13665.9 13689.6 13695.5 12808.7 13106.9 13238.3 13295.9 13369.3 9956.7 9989.7 9995.1 10114.7 10227.1 3520.6 3546.6 3549.1 3585.7 3606.5 46154.3 46166.3 46272.5 46429.3 46572.0 9794.9 9948.7 9967.9 10042.2 10053.8 18639.8 18762.2 18796.2 18874.9 18923.2 7402.4 7495.0 7619.6 7687.2 7785.3 4238.5 4340.9 4341.3 4378.0 4529.0 3169.3 3177.4 3192.1 3214.4 3242.8 537.3 541.0 552.8 561.3 566.1 563.5 603.7 636.9 674.6 677.3 8488.6 8577.2 8659.5 8685.6 8744.9 528.5 550.1 618.9 624.4 647.0 3832.2 4051.0 4086.0 4181.7 4489.5 53746.7 54166.7 54219.0 54635.5 54980.7 46821.8 46834.0 47511.5 48128.0 51274.0 44542.0 45764.8 46003.0 46152.0 46214.3 8668.5 8920.4 8937.0 8938.2 9011.9 33379.2 34363.7 34565.8 35396.5 35503.3 39598.8 39626.4 40104.0 40268.4 40412.0 10366.9 10688.7 10829.9 11056.6 11118.8 11722.2 11778.7 11810.2 12007.8 12066.3 10537.0 10747.8 10866.5 10919.8 11053.1 11458.8 11618.0 11641.9 11706.2 12013.2 11254.6 11379.0 11393.9 11421.3 11883.2 9283.8 9530.5 9777.0 9849.0 10112.6 8844.8 9645.2 9698.3 9738.3 9741.0 16:36:44 INFO - PROCESS | 11002 | -------- Summary: end -------- 16:36:44 INFO - PROCESS | 11002 | 16:36:45 INFO - TEST-INFO | 11002: exit 0 16:36:45 INFO - TEST-OK | dromaeo_css | took 1110606ms 16:36:45 INFO - TEST-START | kraken 16:36:45 INFO - operating with platform_type : linux_ 16:36:45 INFO - Initialising browser for kraken test... 16:36:45 INFO - TEST-INFO | started process 11242 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphTfGKT/profile http://localhost:48037/getInfo.html) 16:36:49 INFO - PROCESS | 11242 | 16:36:49 INFO - PROCESS | 11242 | (process:11314): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:36:49 INFO - PROCESS | 11242 | __metrics Screen width/height:1600/1200 16:36:49 INFO - PROCESS | 11242 | colorDepth:24 16:36:49 INFO - PROCESS | 11242 | Browser inner width/height: 1024/697 16:36:49 INFO - PROCESS | 11242 | __metrics 16:36:50 INFO - PROCESS | 11242 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:36:50 INFO - TEST-INFO | 11242: exit 0 16:36:50 INFO - Browser initialized. 16:36:50 INFO - Running cycle 1/1 for kraken test... 16:36:50 INFO - TEST-INFO | started process 11363 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphTfGKT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:52 INFO - PROCESS | 11363 | 16:36:52 INFO - PROCESS | 11363 | (process:11423): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:37:02 INFO - PROCESS | 11363 | RSS: Main: 151199744 16:37:02 INFO - PROCESS | 11363 | 16:37:05 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48037/tests/kraken/driver.html?testName=audio-beat-detection) 16:37:05 INFO - PROCESS | 11363 | RSS: Main: 152186880 16:37:05 INFO - PROCESS | 11363 | 16:37:08 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48037/tests/kraken/driver.html?testName=audio-dft) 16:37:09 INFO - PROCESS | 11363 | RSS: Main: 154865664 16:37:09 INFO - PROCESS | 11363 | 16:37:12 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48037/tests/kraken/driver.html?testName=audio-fft) 16:37:12 INFO - PROCESS | 11363 | RSS: Main: 147292160 16:37:12 INFO - PROCESS | 11363 | 16:37:14 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48037/tests/kraken/driver.html?testName=audio-oscillator) 16:37:15 INFO - PROCESS | 11363 | RSS: Main: 148635648 16:37:15 INFO - PROCESS | 11363 | 16:37:17 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48037/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:37:18 INFO - PROCESS | 11363 | RSS: Main: 149172224 16:37:18 INFO - PROCESS | 11363 | 16:37:21 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48037/tests/kraken/driver.html?testName=imaging-darkroom) 16:37:21 INFO - PROCESS | 11363 | RSS: Main: 149708800 16:37:21 INFO - PROCESS | 11363 | 16:37:25 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48037/tests/kraken/driver.html?testName=imaging-desaturate) 16:37:25 INFO - PROCESS | 11363 | RSS: Main: 150085632 16:37:25 INFO - PROCESS | 11363 | 16:37:28 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48037/tests/kraken/driver.html?testName=json-parse-financial) 16:37:29 INFO - PROCESS | 11363 | RSS: Main: 150564864 16:37:29 INFO - PROCESS | 11363 | 16:37:30 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48037/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:37:31 INFO - PROCESS | 11363 | RSS: Main: 149983232 16:37:31 INFO - PROCESS | 11363 | 16:37:33 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48037/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:37:33 INFO - PROCESS | 11363 | RSS: Main: 148516864 16:37:33 INFO - PROCESS | 11363 | 16:37:35 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48037/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:37:36 INFO - PROCESS | 11363 | RSS: Main: 149082112 16:37:36 INFO - PROCESS | 11363 | 16:37:38 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:37:39 INFO - PROCESS | 11363 | RSS: Main: 149188608 16:37:39 INFO - PROCESS | 11363 | 16:37:42 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:37:42 INFO - PROCESS | 11363 | RSS: Main: 150163456 16:37:42 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | Cycle 1(1): loaded http://localhost:48037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48037/tests/kraken/driver.html?testName=ai-astar) 16:37:44 INFO - PROCESS | 11363 | RSS: Main: 149372928 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | __start_tp_report 16:37:44 INFO - PROCESS | 11363 | _x_x_mozilla_page_load 16:37:44 INFO - PROCESS | 11363 | _x_x_mozilla_page_load_details 16:37:44 INFO - PROCESS | 11363 | |i|pagename|runs| 16:37:44 INFO - PROCESS | 11363 | |0;ai-astar;111;106;111;112;111;122;111;112;113;111 16:37:44 INFO - PROCESS | 11363 | |1;audio-beat-detection;157;126;165;159;128;167;155;130;169;127 16:37:44 INFO - PROCESS | 11363 | |2;audio-dft;162;162;161;165;163;165;164;175;163;163 16:37:44 INFO - PROCESS | 11363 | |3;audio-fft;72;73;71;75;75;131;73;73;70;76 16:37:44 INFO - PROCESS | 11363 | |4;audio-oscillator;96;96;139;95;97;97;146;97;96;142 16:37:44 INFO - PROCESS | 11363 | |5;imaging-gaussian-blur;110;109;110;110;110;110;110;110;111;110 16:37:44 INFO - PROCESS | 11363 | |6;imaging-darkroom;147;147;147;146;146;148;147;149;149;146 16:37:44 INFO - PROCESS | 11363 | |7;imaging-desaturate;97;97;96;97;97;97;97;96;97;96 16:37:44 INFO - PROCESS | 11363 | |8;json-parse-financial;58;59;58;57;60;60;56;57;55;56 16:37:44 INFO - PROCESS | 11363 | |9;json-stringify-tinderbox;67;70;67;68;68;68;68;68;68;69 16:37:44 INFO - PROCESS | 11363 | |10;stanford-crypto-aes;83;83;84;85;82;85;86;84;84;83 16:37:44 INFO - PROCESS | 11363 | |11;stanford-crypto-ccm;117;123;126;121;123;125;121;122;122;123 16:37:44 INFO - PROCESS | 11363 | |12;stanford-crypto-pbkdf2;140;154;152;150;150;149;149;148;150;150 16:37:44 INFO - PROCESS | 11363 | |13;stanford-crypto-sha256-iterative;66;71;67;68;67;66;68;67;67;69 16:37:44 INFO - PROCESS | 11363 | __end_tp_report 16:37:44 INFO - PROCESS | 11363 | __start_cc_report 16:37:44 INFO - PROCESS | 11363 | _x_x_mozilla_cycle_collect,719 16:37:44 INFO - PROCESS | 11363 | __end_cc_report 16:37:44 INFO - PROCESS | 11363 | __startTimestamp1452818264698__endTimestamp 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | ------- Summary: start ------- 16:37:44 INFO - PROCESS | 11363 | Number of tests: 14 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#0] ai-astar Cycles:10 Average:112.00 Median:111.50 stddev:3.97 (3.6%) stddev-sans-first:4.20 16:37:44 INFO - PROCESS | 11363 | Values: 111.0 106.0 111.0 112.0 111.0 122.0 111.0 112.0 113.0 111.0 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:158.00 stddev:18.23 (11.5%) stddev-sans-first:19.06 16:37:44 INFO - PROCESS | 11363 | Values: 157.0 126.0 165.0 159.0 128.0 167.0 155.0 130.0 169.0 127.0 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:3.97 (2.4%) stddev-sans-first:4.13 16:37:44 INFO - PROCESS | 11363 | Values: 162.0 162.0 161.0 165.0 163.0 165.0 164.0 175.0 163.0 163.0 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#3] audio-fft Cycles:10 Average:78.90 Median:73.00 stddev:18.40 (25.2%) stddev-sans-first:19.35 16:37:44 INFO - PROCESS | 11363 | Values: 72.0 73.0 71.0 75.0 75.0 131.0 73.0 73.0 70.0 76.0 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.00 stddev:22.31 (23.2%) stddev-sans-first:23.08 16:37:44 INFO - PROCESS | 11363 | Values: 96.0 96.0 139.0 95.0 97.0 97.0 146.0 97.0 96.0 142.0 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 16:37:44 INFO - PROCESS | 11363 | Values: 110.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 16:37:44 INFO - PROCESS | 11363 | Values: 147.0 147.0 147.0 146.0 146.0 148.0 147.0 149.0 149.0 146.0 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:37:44 INFO - PROCESS | 11363 | Values: 97.0 97.0 96.0 97.0 97.0 97.0 97.0 96.0 97.0 96.0 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.71 (3.0%) stddev-sans-first:1.81 16:37:44 INFO - PROCESS | 11363 | Values: 58.0 59.0 58.0 57.0 60.0 60.0 56.0 57.0 55.0 56.0 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 16:37:44 INFO - PROCESS | 11363 | Values: 67.0 70.0 67.0 68.0 68.0 68.0 68.0 68.0 68.0 69.0 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.20 (1.4%) stddev-sans-first:1.22 16:37:44 INFO - PROCESS | 11363 | Values: 83.0 83.0 84.0 85.0 82.0 85.0 86.0 84.0 84.0 83.0 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:123.00 stddev:2.45 (2.0%) stddev-sans-first:1.69 16:37:44 INFO - PROCESS | 11363 | Values: 117.0 123.0 126.0 121.0 123.0 125.0 121.0 122.0 122.0 123.0 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:150.00 stddev:3.65 (2.4%) stddev-sans-first:1.79 16:37:44 INFO - PROCESS | 11363 | Values: 140.0 154.0 152.0 150.0 150.0 149.0 149.0 148.0 150.0 150.0 16:37:44 INFO - PROCESS | 11363 | 16:37:44 INFO - PROCESS | 11363 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.51 (2.2%) stddev-sans-first:1.48 16:37:44 INFO - PROCESS | 11363 | Values: 66.0 71.0 67.0 68.0 67.0 66.0 68.0 67.0 67.0 69.0 16:37:44 INFO - PROCESS | 11363 | -------- Summary: end -------- 16:37:44 INFO - PROCESS | 11363 | 16:37:45 INFO - TEST-INFO | 11363: exit 0 16:37:45 INFO - TEST-OK | kraken | took 60475ms 16:37:45 INFO - TEST-START | v8_7 16:37:45 INFO - operating with platform_type : linux_ 16:37:45 INFO - Initialising browser for v8_7 test... 16:37:45 INFO - TEST-INFO | started process 11652 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyo6jBa/profile http://localhost:48037/getInfo.html) 16:37:49 INFO - PROCESS | 11652 | 16:37:49 INFO - PROCESS | 11652 | (process:11725): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:37:50 INFO - PROCESS | 11652 | __metrics Screen width/height:1600/1200 16:37:50 INFO - PROCESS | 11652 | colorDepth:24 16:37:50 INFO - PROCESS | 11652 | Browser inner width/height: 1024/697 16:37:50 INFO - PROCESS | 11652 | __metrics 16:37:50 INFO - PROCESS | 11652 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:37:51 INFO - TEST-INFO | 11652: exit 0 16:37:51 INFO - Browser initialized. 16:37:51 INFO - Running cycle 1/1 for v8_7 test... 16:37:51 INFO - TEST-INFO | started process 11774 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyo6jBa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:37:52 INFO - PROCESS | 11774 | 16:37:52 INFO - PROCESS | 11774 | (process:11835): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:38:03 INFO - PROCESS | 11774 | RSS: Main: 150302720 16:38:03 INFO - PROCESS | 11774 | 16:38:25 INFO - PROCESS | 11774 | Cycle 1(1): loaded http://localhost:48037/tests/v8_7/run.html (next: http://localhost:48037/tests/v8_7/run.html) 16:38:26 INFO - PROCESS | 11774 | RSS: Main: 146759680 16:38:26 INFO - PROCESS | 11774 | 16:38:26 INFO - PROCESS | 11774 | __start_tp_report 16:38:26 INFO - PROCESS | 11774 | _x_x_mozilla_page_load 16:38:26 INFO - PROCESS | 11774 | _x_x_mozilla_page_load_details 16:38:26 INFO - PROCESS | 11774 | |i|pagename|runs| 16:38:26 INFO - PROCESS | 11774 | |0;Richards;166.9449081803005 16:38:26 INFO - PROCESS | 11774 | |1;DeltaBlue;191.49751053236307 16:38:26 INFO - PROCESS | 11774 | |2;Encrypt;281.37310073157005 16:38:26 INFO - PROCESS | 11774 | |3;Decrypt;5223.958333333333 16:38:26 INFO - PROCESS | 11774 | |4;RayTrace;1077.5862068965516 16:38:26 INFO - PROCESS | 11774 | |5;Earley;755.8578987150415 16:38:26 INFO - PROCESS | 11774 | |6;Boyer;12047.619047619048 16:38:26 INFO - PROCESS | 11774 | |7;RegExp;42041.666666666664 16:38:26 INFO - PROCESS | 11774 | |8;Splay;608.6427267194157 16:38:26 INFO - PROCESS | 11774 | |9;NavierStokes;4826.923076923077 16:38:26 INFO - PROCESS | 11774 | __end_tp_report 16:38:26 INFO - PROCESS | 11774 | __startTimestamp1452818306051__endTimestamp 16:38:26 INFO - PROCESS | 11774 | 16:38:26 INFO - PROCESS | 11774 | ------- Summary: start ------- 16:38:26 INFO - PROCESS | 11774 | Number of tests: 10 16:38:26 INFO - PROCESS | 11774 | 16:38:26 INFO - PROCESS | 11774 | [#0] Richards Cycles:1 Average:166.94 Median:166.94 stddev:0.00 (0.0%) 16:38:26 INFO - PROCESS | 11774 | Values: 166.9 16:38:26 INFO - PROCESS | 11774 | 16:38:26 INFO - PROCESS | 11774 | [#1] DeltaBlue Cycles:1 Average:191.50 Median:191.50 stddev:0.00 (0.0%) 16:38:26 INFO - PROCESS | 11774 | Values: 191.5 16:38:26 INFO - PROCESS | 11774 | 16:38:26 INFO - PROCESS | 11774 | [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 16:38:26 INFO - PROCESS | 11774 | Values: 281.4 16:38:26 INFO - PROCESS | 11774 | 16:38:26 INFO - PROCESS | 11774 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 16:38:26 INFO - PROCESS | 11774 | Values: 5224.0 16:38:26 INFO - PROCESS | 11774 | 16:38:26 INFO - PROCESS | 11774 | [#4] RayTrace Cycles:1 Average:1077.59 Median:1077.59 stddev:0.00 (0.0%) 16:38:26 INFO - PROCESS | 11774 | Values: 1077.6 16:38:26 INFO - PROCESS | 11774 | 16:38:26 INFO - PROCESS | 11774 | [#5] Earley Cycles:1 Average:755.86 Median:755.86 stddev:0.00 (0.0%) 16:38:26 INFO - PROCESS | 11774 | Values: 755.9 16:38:26 INFO - PROCESS | 11774 | 16:38:26 INFO - PROCESS | 11774 | [#6] Boyer Cycles:1 Average:12047.62 Median:12047.62 stddev:0.00 (0.0%) 16:38:26 INFO - PROCESS | 11774 | Values: 12047.6 16:38:26 INFO - PROCESS | 11774 | 16:38:26 INFO - PROCESS | 11774 | [#7] RegExp Cycles:1 Average:42041.67 Median:42041.67 stddev:0.00 (0.0%) 16:38:26 INFO - PROCESS | 11774 | Values: 42041.7 16:38:26 INFO - PROCESS | 11774 | 16:38:26 INFO - PROCESS | 11774 | [#8] Splay Cycles:1 Average:608.64 Median:608.64 stddev:0.00 (0.0%) 16:38:26 INFO - PROCESS | 11774 | Values: 608.6 16:38:26 INFO - PROCESS | 11774 | 16:38:26 INFO - PROCESS | 11774 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 16:38:26 INFO - PROCESS | 11774 | Values: 4826.9 16:38:26 INFO - PROCESS | 11774 | -------- Summary: end -------- 16:38:26 INFO - PROCESS | 11774 | 16:38:26 INFO - TEST-INFO | 11774: exit 0 16:38:26 INFO - TEST-OK | v8_7 | took 41269ms 16:38:26 INFO - SUITE-END | took 1212s 16:38:27 INFO - Completed test suite (00:20:12) 16:38:27 INFO - Working with test: dromaeo_css 16:38:27 INFO - Generating results file: dromaeo_css 16:38:27 INFO - Working with test: kraken 16:38:27 INFO - Generating results file: kraken 16:38:27 INFO - javascript benchmark 16:38:27 INFO - Working with test: v8_7 16:38:27 INFO - Generating results file: v8_7 16:38:27 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:38:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 16:38:27 INFO - process_Request line: dromaeo_css 6915.25 graph.html#tests=[[72,63,43]] 16:38:27 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:38:27 INFO - process_Request line: kraken 1516.20 graph.html#tests=[[232,63,43]] 16:38:27 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:38:27 INFO - process_Request line: v8_7 20163.41 graph.html#tests=[[230,63,43]] 16:38:27 INFO - RETURN: dromaeo_css: 6915.25 16:38:27 INFO - RETURN: kraken: 1516.20 16:38:27 INFO - RETURN: v8_7: 20163.41 16:38:27 INFO - javascript benchmark 16:38:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3173.111528771944, 3197.1847178969374, 3215.646278909321, 3231.3052693670866, 3243.4972579250225, 5129.974350128244, 5202.583793296537, 5209.583233341338, 5236.685798852067, 5246.580273578114, 5242.108841496945, 5244.527992480676, 5298.09932311507, 5323.733813309338, 5350.384705758829, 4830.975845120778, 4860.3195552622665, 4914.582260507861, 4953.257011448276, 5001.424836143854, 4867.9269810952865, 4871.391076115486, 4894.388201474816, 4904.386951631046, 4958.876028099308, 4789.736564488934, 4802.2316429371485, 4871.171900776876, 4884.291777692232, 4920.237363208708, 4914.754262286871, 4916.0905232532095, 4920.163572192736, 4922.064807686528, 4981.626378021663, 4896.657233993622, 4899.216125419915, 4902.901941961177, 4919.631027672939, 4938.851834444972, 5050.823221187241, 5065.569426598743, 5078.5175408336145, 5129.666571672829, 5156.613254005927, 5647.209390685307, 5684.744186511617, 5686.2039314496005, 5686.488216060533, 5698.059820129673, 5729.0, 5735.082386818089, 5740.368559458456, 5741.45456181662, 5747.540196784289, 5360.0, 5385.649932754359, 5459.153831156177, 5463.071277882769, 5497.917531237034, 5846.444587764156, 5873.177755114288, 5876.118582212617, 5884.735186916599, 5895.764169433261, 5443.047466693313, 5522.337319521683, 5626.85932851682, 5644.181593668977, 5675.858103547362, 5676.574256930747, 5676.943230567724, 5697.430256974352, 5698.088305871041, 5727.713614319267, 5616.466435688685, 5629.746661400247, 5656.6888821115235, 5663.745131469093, 5668.093105103246, 5468.808591699351, 5586.888262234733, 5605.7197140142825, 5606.299212598426, 5705.744736158039, 4416.271315233015, 4436.64506839452, 4439.733615983051, 4462.531434199363, 4469.932951005738, 3932.6853851691794, 3932.744371615836, 3943.408488726714, 3979.303621866162, 3987.1228329767987, 5172.094883395391, 5238.633295669343, 5249.658772179796, 5334.279872217201, 5347.625666203328, 5666.603337766399, 5679.630823996427, 5682.034054210794, 5688.601797874109, 5694.686792226385, 5220.451852555427, 5282.841514754564, 5300.257963885059, 5300.840974770763, 5349.010433069894, 4765.237561990134, 4806.8798280043275, 4812.326274321597, 4877.975610121926, 4891.608671306287, 5843.678597677083, 5914.4381283777975, 5917.112433134978, 5949.077892926603, 5984.132300816357, 5607.74765135578, 5769.07694768835, 5806.82579522615, 5807.883842323215, 5844.240248767633, 5824.5340372770925, 5896.086106653475, 5916.73374698131, 5942.732577033958, 5951.55363347742, 5636.3799982002765, 5643.097104463266, 5652.5477961762135, 5656.208130861601, 5676.7445464955, 5649.491545760901, 5718.542516598579, 5720.513756330759, 5721.0, 5722.3991480895575, 5565.638233514808, 5569.164625306074, 5588.329400471969, 5610.326760788568, 5650.434956504481, 5620.718964051863, 5652.349979752216, 5655.349634792052, 5671.17767923657, 5702.800401985911, 5395.946040539544, 5457.972710136424, 5458.426865179258, 5561.360443549043, 5582.16267559853, 5709.20071190042, 5717.342505611908, 5731.627444216113, 5732.111522713986, 5742.023855944583, 5548.112302031655, 5593.412691667317, 5603.859903502445, 5604.635698679573, 5609.80365687199], "unit": "score", "name": "dojo.html", "value": 5267.503728514316}, {"lowerIsBetter": false, "replicates": [501.7090087749106, 521.7573828169901, 531.9547838433733, 543.8422857371361, 552.4944675621801, 29140.708592914092, 36689.63310366896, 36889.81555092228, 36913.0, 37223.813880930626, 39223.21553568927, 39711.20577588447, 39765.0, 39844.0, 39871.40192897109, 8406.0, 8553.40126191167, 8598.22615964563, 8599.656013759442, 8615.95692021539, 8264.710735124272, 8428.283595894356, 8460.78848028798, 8462.323014158883, 8487.448315859448, 8461.407701460901, 8510.234078932895, 8514.616842242083, 8558.358123140759, 8558.572071396437, 8396.07643159252, 8487.74536763895, 8552.102029286929, 8594.0, 8689.435186712843, 8495.745127646118, 8657.95671021641, 8666.6100025499, 8683.696070637561, 8701.956490217572, 39188.608113919065, 40091.0, 40108.398374024415, 40256.19487610261, 40378.596214037774, 2938.9706102938912, 2997.28065264335, 3133.5769671094567, 3218.4689526228144, 3538.115471132217, 30069.248268793453, 30261.0, 30431.847840760875, 31071.37857242865, 31209.0, 3784.3377408953324, 3875.8643447479485, 3881.0879443330796, 3917.5886531914307, 4018.8593399230886, 266126.0, 266828.0, 267031.0, 268292.0, 268316.0, 53883.0, 54767.45232547703, 59205.40794592085, 59511.0, 59603.0, 62878.68560657167, 65230.84614423197, 65856.0, 65891.34108658852, 65972.67013664998, 15474.303656335493, 15730.056196628238, 15802.762958555631, 15876.206189690469, 15898.125603091941, 11943.104267179997, 11999.160058795975, 12030.0, 12062.69843253908, 12070.517179312905, 20234.494137646678, 20416.897915510624, 20571.58856822855, 20589.38231853047, 20618.175272988912, 7341.375983041501, 7510.436717246119, 7567.621618919032, 7607.885881711779, 7636.69453221876, 877.1623099939543, 885.3227281129941, 946.3091942881597, 1036.9481525923825, 1137.6871360375796, 26694.19917402481, 28947.0, 29001.85499072491, 29680.257993550335, 29734.107976760733, 1030.0883717909553, 1034.5034383495963, 1045.132539991805, 1089.5315014543664, 1094.4527736131934, 15371.000884942667, 15757.0, 15826.366945322057, 15830.366785328459, 15856.60358491047, 322802.0, 332282.0, 332655.0, 332816.67958301236, 334743.0, 54900.0, 54982.45017549853, 55044.52299646525, 55246.0, 55371.44628553744, 1280.1742875845214, 1297.3772589157256, 1315.2108734759067, 1316.4010375279224, 1329.5213723059692, 28510.857445712638, 29117.854410728658, 29590.852045739633, 29782.553261701527, 29841.104766857028, 46637.30044049274, 46903.29645055395, 47055.52944470511, 47251.29123063088, 47271.0, 315153.0, 315772.0, 316445.0, 316753.5785531818, 317457.0, 31506.842465787526, 32754.83622581872, 33548.66451335553, 33596.16009599682, 33617.49573756347, 38804.6119538801, 39424.0, 39492.0, 39695.80152099221, 40316.0, 33485.49771753377, 33531.83234083814, 33634.347432595365, 33947.0, 34318.48522272118, 33557.0, 36522.452163218106, 36569.817150914074, 37988.81005594954, 38147.0, 32866.83566582152, 33479.33041339208, 33507.832460838516, 33886.83056584701, 34014.829925850216, 30073.0, 31133.221669458446, 31156.22109447282, 31218.21954451066, 31473.52789708202, 24809.0, 25422.618660719734, 25743.613845792705, 25985.480290394466, 26082.60876086822], "unit": "score", "name": "ext.html", "value": 18356.570238927954}, {"lowerIsBetter": false, "replicates": [367.9651527055383, 370.078504523736, 374.4869528745619, 375.62625187938005, 375.63188075685827, 15547.0, 16868.0, 16923.3230670773, 17463.126843657814, 17581.0, 11151.665450036491, 11869.940650296758, 16476.917615411938, 16508.504744857644, 16575.419860304894, 4996.175631020887, 5563.554915606742, 5564.081926482146, 5567.610267281292, 5573.885222955405, 4263.59495847894, 5087.643864929457, 5134.666246693953, 5561.499465048145, 5564.026295398309, 5128.358955130609, 5132.769025393847, 5143.845684629448, 5167.48325167484, 5382.67703937765, 5301.125314323132, 5306.124489459254, 5315.681059136445, 5334.386545547253, 5342.118550439173, 5372.355317361941, 5376.059189641797, 5383.542398896098, 5383.919241211385, 5387.595930305243, 12123.757524849454, 12775.87224127756, 18274.45176644703, 19825.405237842886, 19944.90027549853, 2032.2785411178966, 2038.1949130093678, 2124.1821997284287, 2137.2840098567, 2153.590817744639, 9130.223930965876, 9204.723858284262, 9599.232061435137, 9765.707028789147, 9824.0, 1735.1411051529446, 1753.693103706859, 1819.5905921167764, 1821.080354421022, 1840.5398650337415, 52014.0, 52496.21255681206, 52735.736321318145, 55812.0, 58416.41583584152, 9895.703128906145, 10118.59525618967, 10174.389536627827, 10177.0, 10216.131628811485, 12807.423665935055, 12996.285204313854, 12998.545050923172, 13067.215967042008, 13113.27876966757, 7308.378787803096, 7323.0, 7668.65491052904, 7676.53940763556, 7716.0, 7424.698343513528, 7684.0, 7706.38348932084, 7709.691612335444, 7735.458517903805, 4523.32150177476, 4545.931811022837, 4557.430321209848, 4574.405327307429, 4607.884802879955, 1836.4123480486116, 1845.344902559599, 1891.3569386408412, 1900.2873922279146, 1908.7136929460414, 775.7478819383723, 912.1972664055721, 982.5627595719836, 994.2344394816096, 1065.63235683689, 14784.63038424048, 15830.0, 15898.284577194054, 16354.836451635569, 17010.744838827428, 896.7264984179888, 912.2473958983733, 944.5749412764284, 955.9569819358146, 1000.8548760429843, 9533.285003624756, 9565.473898935486, 9619.711408657611, 9653.227741780782, 9690.903090969141, 449131.0, 450934.0, 463685.0, 486656.0, 494457.0, 55100.0, 71275.0, 73522.31724577807, 73804.63097684477, 74426.88359674609, 1101.212632967416, 1107.0645304717661, 1135.4833550734395, 1144.8339990701302, 1153.411760002388, 14680.632984175481, 14723.116613003254, 14804.925975370485, 15004.623691197054, 15263.313150908014, 30071.84964075253, 30131.698683013765, 30445.23886902845, 31676.0, 31935.520967185974, 39908.600913990485, 41377.1724565513, 41947.790261048496, 42221.15557688768, 42340.36489452722, 7365.373943214887, 7542.245775422414, 7595.240475952361, 7621.961890190513, 7821.843563128592, 9162.31282653817, 10507.684769456928, 10737.838932416176, 10910.181736369645, 11655.417229138679, 9228.723138305862, 9684.273679473927, 9819.410835349901, 9887.110160085627, 10151.543180556744, 9210.539473026456, 9316.20812230968, 9810.509474526389, 10014.248931330034, 10457.529411176667, 9821.017898210122, 10321.277510574188, 10329.793404132026, 10430.791384172122, 10576.524056417633, 7565.735199268, 7655.387568994356, 7790.8831367530665, 7814.843703125792, 7834.725784597512, 9351.485668288038, 9961.0, 10045.045720656526, 10151.238657100599, 10208.081272685495], "unit": "score", "name": "jquery.html", "value": 8080.475821763201}, {"lowerIsBetter": false, "replicates": [1419.758641031025, 1428.764253898107, 1526.6870291590226, 1703.8977661340314, 1725.663495618354, 7340.70637174513, 7348.2651734826495, 7491.475596708233, 7522.623868806565, 7545.660445279955, 7592.12690540588, 7659.042619672541, 7667.079950405945, 7675.385969122471, 7756.573388463632, 2323.9883800580974, 2332.626779715246, 2345.659879317498, 2346.2609278077434, 2350.25966820451, 2340.3447034830187, 2370.8696021718797, 2376.3821406434276, 2376.976230237701, 2378.3816207786012, 2277.1005452846116, 2283.8858057097164, 2291.702078729763, 2297.9885100574556, 2353.646952957053, 2348.330725743155, 2351.3416243451775, 2354.6703461515403, 2356.22244659262, 2369.845960012594, 2268.7050683411217, 2281.9657705134437, 2297.1615360393503, 2301.4131396493954, 2306.4925716342377, 7504.5872477013745, 7647.388208943326, 7656.617169141577, 7696.230376962315, 7708.0, 4741.359916411275, 4822.107910036654, 4849.127157111719, 4853.417589889201, 4865.0, 3043.8337834824106, 3135.827529485877, 3154.57413249213, 3158.7946783459233, 3175.888843890476, 1000.8748906386702, 1011.519528224095, 1014.3508154780947, 1027.3014350241833, 1053.961847580133, 9935.0, 9960.501974901226, 9980.351277166961, 9980.850287245697, 9981.401115932995, 4108.50697916246, 4117.382392641128, 4150.252954468165, 4161.56303588125, 4297.162053399557, 8232.547209903512, 8233.300169485541, 8281.21328473794, 8320.417570769989, 8346.415750897379, 4695.272232803921, 4695.624350051988, 4728.834490792806, 4738.07607516531, 4752.809887604457, 4301.913961720748, 4319.308910574293, 4326.610605045561, 4327.5239723630375, 4329.28566786483, 3449.3963556377535, 3478.6347433519118, 3509.1051781795477, 3510.1049232446076, 3542.1852973816167, 1070.82866741321, 1105.7290963713942, 1121.4560937945091, 1121.506537123663, 1122.36586328724, 1008.1581879130861, 1012.6860673191334, 1036.461040259076, 1089.3300620118728, 1206.4209179593845, 6856.177258728885, 6922.688479018456, 6976.895346569806, 7005.54463959841, 7009.54437961541, 1017.3844823881445, 1021.8467229915572, 1039.6776999130143, 1123.1800785426685, 1145.68493664243, 5448.482394172547, 5480.588955828329, 5488.067028605146, 5496.725163741797, 5561.332640083216, 9033.45595718587, 9260.21288190498, 9412.811743765087, 9419.576119074658, 9536.713898583053, 9220.53897305132, 9318.254539636813, 9330.486823224652, 9335.346525743269, 9363.485008324471, 6916.6541672916155, 7092.822679432952, 7109.253528379446, 7158.498905076699, 7203.567785932861, 7035.648217588998, 7059.929400706133, 7067.505274630932, 7112.6088065154845, 7145.714171433085, 8030.759077227693, 8038.276555110068, 8233.0, 8305.37709671765, 8388.622511987098, 8487.405881588229, 8513.063563008189, 8527.658893644184, 8612.267957223707, 8621.094785047731, 6573.3098024706715, 6755.594664320157, 6781.254062053269, 6819.215790184192, 6832.316768323128, 7107.466939979626, 7121.394681452135, 7130.643467826691, 7199.316064973819, 7207.783766487014, 6711.0, 6747.190337159376, 6847.417969472651, 6920.411765000032, 7023.157221133497, 6342.492600592034, 6400.71196796136, 6449.7097630605795, 6484.70818813164, 6743.662816859235, 6506.642134682448, 6531.575447595891, 6627.536072474881, 6627.569208001464, 6665.833354166185, 6159.907601385893, 6174.629522228501, 6180.443760061616, 6185.938140618716, 6196.194494715658, 6032.8793424132145, 6109.969450152721, 6256.843578910381, 6280.1207830902795, 6303.873922521616], "unit": "score", "name": "mootools.html", "value": 4398.0039479051375}, {"lowerIsBetter": false, "replicates": [346.6810534308436, 354.30732917146975, 355.4703491797221, 356.21987846615923, 365.20385559480354, 6259.342769009246, 6306.779262725806, 6344.873102537947, 6410.134631824702, 6412.358764123585, 6133.233345831771, 6281.654509002003, 6308.116863639094, 6340.58786178898, 6350.936490635092, 4835.540623640749, 4846.273059041155, 4864.294677271811, 4872.4640289568115, 4887.315775791392, 4835.468098509161, 4855.514448555134, 4874.390701162355, 4878.926816097762, 4887.951120488803, 4601.930971035437, 4731.0, 4743.430788305408, 4754.263089221176, 4754.85735427936, 4724.905501889943, 4739.502352252998, 4741.122892264942, 4742.672051825494, 4755.571998520115, 4145.626893579592, 4183.6653067754505, 4194.769287689176, 4195.0, 4203.7057405981595, 5898.911516327258, 6017.157597936292, 6025.427584379477, 6030.33666296707, 6037.30570984338, 5469.288992430998, 5522.91715624266, 5555.916661250085, 5557.305336832896, 5566.276384070085, 6676.4992625552795, 6684.030815531769, 6686.632235227061, 6687.832804179886, 6697.598144111369, 4571.6114130298965, 4578.473475550321, 4592.425946756655, 4595.793189306456, 4596.03483268514, 6823.863522729567, 6998.300169983012, 7022.332878376546, 7088.326608972139, 7094.1841688206005, 4723.598494128038, 4759.50025247351, 4762.357081793983, 4764.309175169581, 4772.5227477252, 4807.110684523374, 4819.855404337875, 4834.734089625034, 4838.274258861199, 4841.201201801734, 5545.140503222007, 5587.972060139755, 5589.524890384281, 5598.636088654224, 5599.692016939108, 6556.409923106943, 6767.1879374475375, 6781.11845460087, 6789.355011273921, 6792.21889482706, 1664.051490650342, 1695.8473737363697, 1698.8640908727273, 1705.556555295632, 1707.8804483686022, 1122.7080958950569, 1135.460656188304, 1136.6419577832955, 1141.5662048421714, 1158.8377627132209, 6285.434310911948, 6292.716827742763, 6297.086922396227, 6309.08518264849, 6315.684215789192, 6799.082123913208, 6808.319168083152, 6834.316568343126, 6871.244163142051, 6882.414994725505, 6244.063390491372, 6252.749890004349, 6303.6532990685955, 6306.810795676137, 6332.715027823759, 3758.248350329945, 3782.5650050244026, 3787.0910981364273, 3788.1666033472593, 3789.5642001169667, 7326.267373262738, 7329.74345897891, 7345.15530713964, 7437.405007599379, 7441.962790186014, 7067.82330441743, 7197.9640101800205, 7204.891926621105, 7211.278872112747, 7228.638568071576, 7277.417806575461, 7291.963540182265, 7311.0495635568095, 7318.780436586911, 7318.817029574303, 6983.790486285419, 6992.16094068715, 7033.577985320897, 7046.189688185924, 7064.258252883374, 6674.765168443853, 6907.89638155418, 6920.792376228721, 6963.651817409211, 6965.233824279427, 7283.417326613964, 7311.195768465358, 7332.120145582564, 7348.265173482609, 7359.889601656087, 4762.6189904808225, 4808.3989501312335, 4809.254565542346, 4822.300766388784, 4833.540813622701, 6853.0, 6866.519343645897, 7059.294070593105, 7059.752908648173, 7072.681729322296, 6801.2858649841055, 6820.283870193757, 6844.076049733222, 6866.965665171842, 6880.105586273752, 6778.220504641832, 6807.081044059187, 6827.010083537959, 6835.7949261522235, 6845.0, 6505.60966342021, 6684.364985326386, 6702.0, 6709.966450167718, 6716.018774461448, 6805.149356330458, 6815.727370905108, 6863.794086177422, 6864.828379290558, 6890.793276201722, 6649.534532582867, 6672.799816005528, 6680.565763225375, 6695.296993815774, 6702.865942681022], "unit": "score", "name": "prototype.html", "value": 5076.410064431488}, {"lowerIsBetter": false, "replicates": [826.3389288569143, 826.7767702720265, 828.5484410996006, 851.2934264560415, 874.0603850860326, 13833.654158646026, 13855.099418537788, 13951.651208719763, 13952.302384880753, 13977.790333144998, 12866.099373043891, 13061.93469032656, 13062.477500899977, 13070.542531011417, 13086.280254585994, 662.1160750398224, 666.014298837718, 805.3275514944999, 814.6293436486415, 815.8735396013627, 815.8164413007086, 819.9795005124889, 823.390690888744, 824.2869917521331, 824.3034635732796, 859.1537335724306, 861.8621020636699, 865.074370423647, 866.8873046503945, 868.3747701654798, 857.3869683176558, 857.6012154348196, 858.2919091749332, 862.7153039496951, 864.4683519635411, 630.6531407725778, 633.1009965848506, 634.9301576826546, 634.9714262858182, 636.2810024672091, 13618.18290902549, 13665.453381864714, 13665.931670341584, 13689.589312320646, 13695.452181912711, 12808.6797830055, 13106.934465327708, 13238.27189504577, 13295.86704132956, 13369.259301843098, 9956.701298961043, 9989.650362237287, 9995.050470205319, 10114.747131321703, 10227.130693891027, 3520.559930008749, 3546.627604101558, 3549.112721819545, 3585.731070169748, 3606.495090687306, 46154.307685384745, 46166.30750538745, 46272.53727462716, 46429.30356044662, 46572.0, 9794.902050979541, 9948.701538953843, 9967.900320996698, 10042.246831487668, 10053.824404688225, 18639.81360186408, 18762.155702993397, 18796.248150074116, 18874.905625471783, 18923.243070277036, 7402.444816638774, 7494.962525187449, 7619.580923049175, 7687.154413014564, 7785.299323060838, 4238.533761286256, 4340.8697739067875, 4341.305391137403, 4377.9781101094295, 4529.048899731093, 3169.2869104451315, 3177.396294703999, 3192.058342788883, 3214.4053350130303, 3242.8054316741072, 537.2907761754525, 541.0315535192041, 552.7927027364739, 561.332014902265, 566.1140315406376, 563.4956713741178, 603.7253049862389, 636.9458596019298, 674.5917076038495, 677.2584020497547, 8488.618012189343, 8577.185167409087, 8659.52372619512, 8685.609147588248, 8744.912550874536, 528.5269683633204, 550.0620798480413, 618.8978818494988, 624.3662682377391, 646.9611823290618, 3832.2143960488033, 4050.959490405058, 4086.0, 4181.686373521937, 4489.483709373399, 53746.73126634342, 54166.72916635471, 54219.0, 54635.45364546383, 54980.72509637426, 46821.76589117101, 46834.0, 47511.52488475071, 48128.0, 51274.0, 44541.99999999935, 45764.771176144575, 46003.0, 46152.0, 46214.30678539824, 8668.486533154351, 8920.375573710038, 8937.0, 8938.24024957886, 9011.864822027806, 33379.165520862174, 34363.65636343604, 34565.82717086399, 35396.46905296371, 35503.28993420169, 39598.80200598978, 39626.40560391539, 40103.997400064065, 40268.395974061, 40412.0, 10366.896331036894, 10688.732781680521, 10829.891701083203, 11056.617922759655, 11118.833217501582, 11722.238054526428, 11778.705532361759, 11810.232334898204, 12007.75984480323, 12066.276023438622, 10536.994927409725, 10747.785044299226, 10866.456677165952, 10919.781604367708, 11053.11575073976, 11458.82811757841, 11618.0, 11641.941790290994, 11706.180567360203, 12013.219140755822, 11254.60608878718, 11379.032782213604, 11393.943030284796, 11421.257618254787, 11883.16817822744, 9283.814323713623, 9530.523473826419, 9777.022297770167, 9849.015098490094, 10112.595496180365, 8844.819334769156, 9645.228381729585, 9698.27262955267, 9738.269629777653, 9740.951295243478], "unit": "score", "name": "yui.html", "value": 6268.510170111657}], "name": "dromaeo_css", "value": 6915.248066121028}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 112.0, 111.0, 122.0, 111.0, 112.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [157.0, 126.0, 165.0, 159.0, 128.0, 167.0, 155.0, 130.0, 169.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 165.0, 163.0, 165.0, 164.0, 175.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 71.0, 75.0, 75.0, 131.0, 73.0, 73.0, 70.0, 76.0], "unit": "score", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 95.0, 97.0, 97.0, 146.0, 97.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 149.0, 149.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 58.0, 57.0, 60.0, 60.0, 56.0, 57.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 85.0, 82.0, 85.0, 86.0, 84.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [117.0, 123.0, 126.0, 121.0, 123.0, 125.0, 121.0, 122.0, 122.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [140.0, 154.0, 152.0, 150.0, 150.0, 149.0, 149.0, 148.0, 150.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 67.0, 68.0, 67.0, 66.0, 68.0, 67.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1516.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9449081803005], "unit": "score", "name": "Richards", "value": 211.45897999999997}, {"lowerIsBetter": false, "replicates": [191.49751053236307], "unit": "score", "name": "DeltaBlue", "value": 345.26819599999993}, {"lowerIsBetter": false, "replicates": [281.37310073157005], "unit": "score", "name": "Encrypt", "value": 946.0072739999998}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [1077.5862068965516], "unit": "score", "name": "RayTrace", "value": 686.7097920000001}, {"lowerIsBetter": false, "replicates": [755.8578987150415], "unit": "score", "name": "Earley", "value": 881.7305489999999}, {"lowerIsBetter": false, "replicates": [12047.619047619048], "unit": "score", "name": "Boyer", "value": 55.31906324110671}, {"lowerIsBetter": false, "replicates": [42041.666666666664], "unit": "score", "name": "RegExp", "value": 21.668622398414268}, {"lowerIsBetter": false, "replicates": [608.6427267194157], "unit": "score", "name": "Splay", "value": 133.88971299999997}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20163.41162595564}]} 16:38:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20163.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1516.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6915.25"}}} 16:38:27 INFO - Return code: 0 16:38:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:38:27 INFO - # TBPL SUCCESS # 16:38:27 INFO - Running post-action listener: _resource_record_post_action 16:38:27 INFO - Running post-run listener: _resource_record_post_run 16:38:28 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 558174208; Read time: 0; Write time: 899464 16:38:28 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 241381376; Read time: 0; Write time: 554904 16:38:28 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 309567488; Read time: 0; Write time: 344004 16:38:28 INFO - Running post-run listener: _upload_blobber_files 16:38:28 INFO - Blob upload gear active. 16:38:28 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:38:28 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 16:38:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:38:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:38:28 INFO - (blobuploader) - INFO - Open directory for files ... 16:38:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:38:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:38:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:38:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:38:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:38:29 INFO - (blobuploader) - INFO - Done attempting. 16:38:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:38:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:38:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:38:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:38:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:38:30 INFO - (blobuploader) - INFO - Done attempting. 16:38:30 INFO - (blobuploader) - INFO - Iteration through files over. 16:38:30 INFO - Return code: 0 16:38:30 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:38:30 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:38:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2eb5e3ecf53192b39230019666e982615a796a4d5164761c7489e358adb8170f2d8144f0ff87a5a75f0d98d4b35334569cbadb24334c0ee76e967e9b940ddee7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3cd3a209516b91339a8b83292e8e448e0b63533e2541bef4e80878b139460d78fe98379ea0d0b902585461a520fa774d6875be20f1850722117d9c242f9022b3"} 16:38:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:38:30 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:38:30 INFO - Contents: 16:38:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2eb5e3ecf53192b39230019666e982615a796a4d5164761c7489e358adb8170f2d8144f0ff87a5a75f0d98d4b35334569cbadb24334c0ee76e967e9b940ddee7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3cd3a209516b91339a8b83292e8e448e0b63533e2541bef4e80878b139460d78fe98379ea0d0b902585461a520fa774d6875be20f1850722117d9c242f9022b3"} 16:38:30 INFO - Copying logs to upload dir... 16:38:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.096240 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-14 16:38:30.008692) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 16:38:30.011968) ========= 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=1861a34ebfea852630dec091000001fa-1452817035.874978-103113873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2eb5e3ecf53192b39230019666e982615a796a4d5164761c7489e358adb8170f2d8144f0ff87a5a75f0d98d4b35334569cbadb24334c0ee76e967e9b940ddee7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3cd3a209516b91339a8b83292e8e448e0b63533e2541bef4e80878b139460d78fe98379ea0d0b902585461a520fa774d6875be20f1850722117d9c242f9022b3"} build_url:https://queue.taskcluster.net/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011521 build_url: 'https://queue.taskcluster.net/v1/task/WAF0RO5tTA6BAo8cnfpGfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2eb5e3ecf53192b39230019666e982615a796a4d5164761c7489e358adb8170f2d8144f0ff87a5a75f0d98d4b35334569cbadb24334c0ee76e967e9b940ddee7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3cd3a209516b91339a8b83292e8e448e0b63533e2541bef4e80878b139460d78fe98379ea0d0b902585461a520fa774d6875be20f1850722117d9c242f9022b3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 16:38:30.037668) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:38:30.038358) ========= 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=1861a34ebfea852630dec091000001fa-1452817035.874978-103113873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004680 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:38:30.119928) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 16:38:30.120268) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 16:38:30.120581) ========= ========= Total master_lag: 0.21 =========