builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1451695877.65 results: success (0) buildid: 20160101143006 builduid: e0aae2e9655f4c428a046f49bcd2c53e revision: c9ed86a8b757e783fa14c2afcfff4a61e0d7b574 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:17.654287) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:17.655359) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:17.655930) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006397 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:17.686719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:17.687112) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:17.719181) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:17.719648) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024939 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:17.769201) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:17.769542) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:17.769965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:17.773134) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-01 16:51: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-01-01 16:51:17 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185607 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:18.132807) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:18.133208) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.044774 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:18.189522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:18.189916) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev c9ed86a8b757e783fa14c2afcfff4a61e0d7b574 --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/b2g-inbound --rev c9ed86a8b757e783fa14c2afcfff4a61e0d7b574 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-01 16:51:18,254 truncating revision to first 12 chars 2016-01-01 16:51:18,254 Setting DEBUG logging. 2016-01-01 16:51:18,254 attempt 1/10 2016-01-01 16:51:18,254 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/c9ed86a8b757?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-01 16:51:18,503 unpacking tar archive at: b2g-inbound-c9ed86a8b757/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565360 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:18.768789) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:18.769207) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:18.778780) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:18.779090) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 16:51:18.779575) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-01 16:51:18.779915) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:51:18 INFO - MultiFileLogger online at 20160101 16:51:18 in /builds/slave/test-pgo 16:51:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 16:51:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:51:18 INFO - {'append_to_log': False, 16:51:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:51:18 INFO - 'blob_upload_branch': 'B2G-Inbound', 16:51:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:51:18 INFO - 'branch': 'B2G-Inbound', 16:51:18 INFO - 'buildbot_json_path': 'buildprops.json', 16:51:18 INFO - 'config_files': ('talos/linux_config.py',), 16:51:18 INFO - 'default_actions': ('clobber', 16:51:18 INFO - 'read-buildbot-config', 16:51:18 INFO - 'download-and-extract', 16:51:18 INFO - 'populate-webroot', 16:51:18 INFO - 'create-virtualenv', 16:51:18 INFO - 'install', 16:51:18 INFO - 'run-tests'), 16:51:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:51:18 INFO - 'download_minidump_stackwalk': True, 16:51:18 INFO - 'download_symbols': 'ondemand', 16:51:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:51:18 INFO - 'tooltool.py': '/tools/tooltool.py', 16:51:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:51:18 INFO - '/tools/misc-python/virtualenv.py')}, 16:51:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:51:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:51:18 INFO - 'installer_path': 'installer.exe', 16:51:18 INFO - 'log_level': 'info', 16:51:18 INFO - 'log_name': 'talos', 16:51:18 INFO - 'log_to_console': True, 16:51:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:51:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:51:18 INFO - 'opt_config_files': (), 16:51:18 INFO - 'pip_index': False, 16:51:18 INFO - 'sps_profile': False, 16:51:18 INFO - 'sps_profile_interval': 0, 16:51:18 INFO - 'suite': 'dromaeojs', 16:51:18 INFO - 'system_bits': '32', 16:51:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:51:18 INFO - 'title': 'talos-linux64-ix-026', 16:51:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:51:18 INFO - 'use_talos_json': True, 16:51:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:51:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:51:18 INFO - 'work_dir': 'build'} 16:51:18 INFO - ##### 16:51:18 INFO - ##### Running clobber step. 16:51:18 INFO - ##### 16:51:18 INFO - Running pre-action listener: _resource_record_pre_action 16:51:18 INFO - Running main action method: clobber 16:51:18 INFO - rmtree: /builds/slave/test-pgo/build 16:51:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:51:23 INFO - Running post-action listener: _resource_record_post_action 16:51:23 INFO - ##### 16:51:23 INFO - ##### Running read-buildbot-config step. 16:51:23 INFO - ##### 16:51:23 INFO - Running pre-action listener: _resource_record_pre_action 16:51:23 INFO - Running main action method: read_buildbot_config 16:51:23 INFO - Using buildbot properties: 16:51:23 INFO - { 16:51:23 INFO - "project": "", 16:51:23 INFO - "product": "firefox", 16:51:23 INFO - "script_repo_revision": "production", 16:51:23 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 16:51:23 INFO - "repository": "", 16:51:23 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 16:51:23 INFO - "buildid": "20160101143006", 16:51:23 INFO - "pgo_build": "True", 16:51:23 INFO - "basedir": "/builds/slave/test-pgo", 16:51:23 INFO - "buildnumber": 1082, 16:51:23 INFO - "slavename": "talos-linux64-ix-026", 16:51:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:51:23 INFO - "platform": "ubuntu64_hw", 16:51:23 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 16:51:23 INFO - "branch": "b2g-inbound", 16:51:23 INFO - "repo_path": "integration/b2g-inbound", 16:51:23 INFO - "revision": "c9ed86a8b757e783fa14c2afcfff4a61e0d7b574", 16:51:23 INFO - "stage_platform": "linux64-pgo", 16:51:23 INFO - "builduid": "e0aae2e9655f4c428a046f49bcd2c53e", 16:51:23 INFO - "slavebuilddir": "test" 16:51:23 INFO - } 16:51:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:51:23 INFO - Running post-action listener: _resource_record_post_action 16:51:23 INFO - ##### 16:51:23 INFO - ##### Running download-and-extract step. 16:51:23 INFO - ##### 16:51:23 INFO - Running pre-action listener: _resource_record_pre_action 16:51:23 INFO - Running main action method: download_and_extract 16:51:23 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:51: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:51:23 INFO - https://queue.taskcluster.net/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/test_packages.json 16:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/test_packages.json 16:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:51:24 INFO - Downloaded 1302 bytes. 16:51:24 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:51:24 INFO - Using the following test package requirements: 16:51:24 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:51:24 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:51:24 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:24 INFO - u'jsshell-linux-x86_64.zip'], 16:51:24 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:51:24 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:51:24 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:51:24 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:51:24 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:51:24 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:51:24 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:51:24 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:51:24 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:51:24 INFO - https://queue.taskcluster.net/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/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:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/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:51:25 INFO - Downloaded 23195186 bytes. 16:51:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:51:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:51:26 INFO - Return code: 0 16:51:26 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:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:26 INFO - https://queue.taskcluster.net/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:51:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/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:51:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/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:51:27 INFO - Downloaded 23195186 bytes. 16:51:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:51:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:51:29 INFO - Return code: 0 16:51: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:51:29 INFO - https://queue.taskcluster.net/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:51:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:51:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:51:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/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:51:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/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:51:30 INFO - Downloaded 11132285 bytes. 16:51:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:51:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:51:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:51:30 INFO - Return code: 0 16:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:30 INFO - https://queue.taskcluster.net/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:51:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/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:51:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJOVg79QS9OJ3iO-eXDd_A/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:51:31 INFO - Downloaded 54941983 bytes. 16:51:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:31 INFO - mkdir: /builds/slave/test-pgo/properties 16:51:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:51:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:51:31 INFO - Contents: 16:51:31 INFO - build_url:https://queue.taskcluster.net/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:31 INFO - Running post-action listener: _resource_record_post_action 16:51:31 INFO - Running post-action listener: set_extra_try_arguments 16:51:31 INFO - ##### 16:51:31 INFO - ##### Running populate-webroot step. 16:51:31 INFO - ##### 16:51:31 INFO - Running pre-action listener: _resource_record_pre_action 16:51:31 INFO - Running main action method: populate_webroot 16:51:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:51:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:51:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:51:31 INFO - '--tppagecycles', 16:51:31 INFO - '7'], 16:51:31 INFO - 'tests': ['tsvgm']}}, 16:51:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:51:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:51:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:51:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:51:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:51:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:51:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:51:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:31 INFO - 'talos_options': ['--e10s'], 16:51:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:51:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:31 INFO - 'tests': ['damp', 'tps']}, 16:51:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:31 INFO - 'talos_options': ['--e10s'], 16:51:31 INFO - 'tests': ['damp', 'tps']}, 16:51:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:51:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:51:31 INFO - 'other': {'tests': ['a11yr', 16:51:31 INFO - 'ts_paint', 16:51:31 INFO - 'tpaint', 16:51:31 INFO - 'sessionrestore', 16:51:31 INFO - 'sessionrestore_no_auto_restore']}, 16:51:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:51:31 INFO - 'tests': ['a11yr', 16:51:31 INFO - 'ts_paint', 16:51:31 INFO - 'tpaint', 16:51:31 INFO - 'sessionrestore', 16:51:31 INFO - 'sessionrestore_no_auto_restore']}, 16:51:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:51:31 INFO - 'tests': ['a11yr', 16:51:31 INFO - 'ts_paint', 16:51:31 INFO - 'tpaint', 16:51:31 INFO - 'sessionrestore', 16:51:31 INFO - 'sessionrestore_no_auto_restore']}, 16:51:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:51:31 INFO - 'tests': ['a11yr', 16:51:31 INFO - 'ts_paint', 16:51:31 INFO - 'tpaint', 16:51:31 INFO - 'sessionrestore', 16:51:31 INFO - 'sessionrestore_no_auto_restore']}, 16:51:31 INFO - 'other_l64': {'tests': ['a11yr', 16:51:31 INFO - 'ts_paint', 16:51:31 INFO - 'tpaint', 16:51:31 INFO - 'sessionrestore', 16:51:31 INFO - 'sessionrestore_no_auto_restore']}, 16:51:31 INFO - 'other_nol64': {'tests': ['a11yr', 16:51:31 INFO - 'ts_paint', 16:51:31 INFO - 'tpaint', 16:51:31 INFO - 'sessionrestore', 16:51:31 INFO - 'sessionrestore_no_auto_restore']}, 16:51:31 INFO - 'svgr': {'tests': ['tsvgx', 16:51:31 INFO - 'tsvgr_opacity', 16:51:31 INFO - 'tart', 16:51:31 INFO - 'tscrollx', 16:51:31 INFO - 'cart']}, 16:51:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:51:31 INFO - 'tests': ['tsvgx', 16:51:31 INFO - 'tsvgr_opacity', 16:51:31 INFO - 'tart', 16:51:31 INFO - 'tscrollx', 16:51:31 INFO - 'cart']}, 16:51:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:31 INFO - 'tests': ['tp5o']}, 16:51:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:31 INFO - 'talos_options': ['--e10s'], 16:51:31 INFO - 'tests': ['tp5o']}, 16:51:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:31 INFO - 'talos_options': ['--xperf_path', 16:51:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:51:31 INFO - 'tests': ['tp5n']}, 16:51:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:31 INFO - 'talos_options': ['--e10s', 16:51:31 INFO - '--xperf_path', 16:51:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:51:31 INFO - 'tests': ['tp5n']}}, 16:51:31 INFO - 'talos.zip': {'path': '', 16:51:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:51:31 INFO - Running post-action listener: _resource_record_post_action 16:51:31 INFO - ##### 16:51:31 INFO - ##### Running create-virtualenv step. 16:51:31 INFO - ##### 16:51:31 INFO - Running pre-action listener: _resource_record_pre_action 16:51:31 INFO - Running main action method: create_virtualenv 16:51:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:51:31 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:51:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:51:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:51:31 INFO - Using real prefix '/usr' 16:51:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:51:32 INFO - Installing distribute.............................................................................................................................................................................................done. 16:51:34 INFO - Installing pip.................done. 16:51:34 INFO - Return code: 0 16:51:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:34 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 0x7fddb68b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1179480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208660>, '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 0x1209560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1209a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', '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:51:34 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:51:34 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:51:34 INFO - Using env: {'DISPLAY': ':0', 16:51:34 INFO - 'HOME': '/home/cltbld', 16:51:34 INFO - 'LANG': 'en_US.UTF-8', 16:51:34 INFO - 'LANGUAGE': 'en_US:en', 16:51:34 INFO - 'LOGNAME': 'cltbld', 16:51:34 INFO - 'MAIL': '/var/mail/cltbld', 16:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:34 INFO - 'MOZ_NO_REMOTE': '1', 16:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:34 INFO - 'NO_EM_RESTART': '1', 16:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:34 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:34 INFO - 'SHELL': '/bin/bash', 16:51:34 INFO - 'SHLVL': '1', 16:51:34 INFO - 'TERM': 'linux', 16:51:34 INFO - 'TMOUT': '86400', 16:51:34 INFO - 'USER': 'cltbld', 16:51:34 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', 16:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:34 INFO - '_': '/tools/buildbot/bin/python'} 16:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:34 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:51:34 INFO - Cleaning up... 16:51:34 INFO - Return code: 0 16:51:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:34 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 0x7fddb68b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1179480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208660>, '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 0x1209560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1209a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', '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:51:34 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:51:34 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:51:34 INFO - Using env: {'DISPLAY': ':0', 16:51:34 INFO - 'HOME': '/home/cltbld', 16:51:34 INFO - 'LANG': 'en_US.UTF-8', 16:51:34 INFO - 'LANGUAGE': 'en_US:en', 16:51:34 INFO - 'LOGNAME': 'cltbld', 16:51:34 INFO - 'MAIL': '/var/mail/cltbld', 16:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:34 INFO - 'MOZ_NO_REMOTE': '1', 16:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:34 INFO - 'NO_EM_RESTART': '1', 16:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:34 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:34 INFO - 'SHELL': '/bin/bash', 16:51:34 INFO - 'SHLVL': '1', 16:51:34 INFO - 'TERM': 'linux', 16:51:34 INFO - 'TMOUT': '86400', 16:51:34 INFO - 'USER': 'cltbld', 16:51:34 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', 16:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:34 INFO - '_': '/tools/buildbot/bin/python'} 16:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:34 INFO - Downloading/unpacking psutil>=0.7.1 16:51:34 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:51:34 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:51:34 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:51:34 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:51:34 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:51:34 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:51:36 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:51:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:51:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:51:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:36 INFO - Installing collected packages: psutil 16:51:36 INFO - Running setup.py install for psutil 16:51:36 INFO - building 'psutil._psutil_linux' extension 16:51:36 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:51:36 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:51:36 INFO - building 'psutil._psutil_posix' extension 16:51:36 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:51:36 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:51:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:36 INFO - Successfully installed psutil 16:51:36 INFO - Cleaning up... 16:51:37 INFO - Return code: 0 16:51:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:37 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 0x7fddb68b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1179480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208660>, '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 0x1209560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1209a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', '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:51:37 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:51:37 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:51:37 INFO - Using env: {'DISPLAY': ':0', 16:51:37 INFO - 'HOME': '/home/cltbld', 16:51:37 INFO - 'LANG': 'en_US.UTF-8', 16:51:37 INFO - 'LANGUAGE': 'en_US:en', 16:51:37 INFO - 'LOGNAME': 'cltbld', 16:51:37 INFO - 'MAIL': '/var/mail/cltbld', 16:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:37 INFO - 'MOZ_NO_REMOTE': '1', 16:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:37 INFO - 'NO_EM_RESTART': '1', 16:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:37 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:37 INFO - 'SHELL': '/bin/bash', 16:51:37 INFO - 'SHLVL': '1', 16:51:37 INFO - 'TERM': 'linux', 16:51:37 INFO - 'TMOUT': '86400', 16:51:37 INFO - 'USER': 'cltbld', 16:51:37 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', 16:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:37 INFO - '_': '/tools/buildbot/bin/python'} 16:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:51:37 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:51:37 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:51:37 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:51:37 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:51:37 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:51:37 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:51:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:51:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:51:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:51:39 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:51:39 INFO - Installing collected packages: mozsystemmonitor 16:51:39 INFO - Running setup.py install for mozsystemmonitor 16:51:39 INFO - Successfully installed mozsystemmonitor 16:51:39 INFO - Cleaning up... 16:51:39 INFO - Return code: 0 16:51:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:51: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:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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', '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 0x7fddb68b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1179480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208660>, '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 0x1209560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1209a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', '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:51: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:51: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 blobuploader==1.2.4 16:51:39 INFO - Using env: {'DISPLAY': ':0', 16:51:39 INFO - 'HOME': '/home/cltbld', 16:51:39 INFO - 'LANG': 'en_US.UTF-8', 16:51:39 INFO - 'LANGUAGE': 'en_US:en', 16:51:39 INFO - 'LOGNAME': 'cltbld', 16:51:39 INFO - 'MAIL': '/var/mail/cltbld', 16:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:39 INFO - 'MOZ_NO_REMOTE': '1', 16:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:39 INFO - 'NO_EM_RESTART': '1', 16:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:39 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:39 INFO - 'SHELL': '/bin/bash', 16:51:39 INFO - 'SHLVL': '1', 16:51:39 INFO - 'TERM': 'linux', 16:51:39 INFO - 'TMOUT': '86400', 16:51:39 INFO - 'USER': 'cltbld', 16:51:39 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', 16:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:39 INFO - '_': '/tools/buildbot/bin/python'} 16:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:40 INFO - Downloading/unpacking blobuploader==1.2.4 16:51:40 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:51:40 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:51:40 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:51:40 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:51:40 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:51:40 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:51:42 INFO - Downloading blobuploader-1.2.4.tar.gz 16:51:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:51:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:51:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:51:42 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:51:42 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:51:42 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:51:42 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:51:42 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:51:42 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:51:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:51:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:51:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:51:42 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:51:42 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:51:42 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:51:42 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:51:42 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:51:42 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:51:42 INFO - Downloading docopt-0.6.1.tar.gz 16:51:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:51:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:51:42 INFO - Installing collected packages: blobuploader, requests, docopt 16:51:42 INFO - Running setup.py install for blobuploader 16:51:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:51:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:51:43 INFO - Running setup.py install for requests 16:51:43 INFO - Running setup.py install for docopt 16:51:43 INFO - Successfully installed blobuploader requests docopt 16:51:43 INFO - Cleaning up... 16:51:43 INFO - Return code: 0 16:51:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:43 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 0x7fddb68b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1179480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208660>, '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 0x1209560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1209a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', '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:51:43 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:51:43 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:51:43 INFO - Using env: {'DISPLAY': ':0', 16:51:43 INFO - 'HOME': '/home/cltbld', 16:51:43 INFO - 'LANG': 'en_US.UTF-8', 16:51:43 INFO - 'LANGUAGE': 'en_US:en', 16:51:43 INFO - 'LOGNAME': 'cltbld', 16:51:43 INFO - 'MAIL': '/var/mail/cltbld', 16:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:43 INFO - 'MOZ_NO_REMOTE': '1', 16:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:43 INFO - 'NO_EM_RESTART': '1', 16:51:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:43 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:43 INFO - 'SHELL': '/bin/bash', 16:51:43 INFO - 'SHLVL': '1', 16:51:43 INFO - 'TERM': 'linux', 16:51:43 INFO - 'TMOUT': '86400', 16:51:43 INFO - 'USER': 'cltbld', 16:51:43 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', 16:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:43 INFO - '_': '/tools/buildbot/bin/python'} 16:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:43 INFO - Running setup.py (path:/tmp/pip-ZjXtwR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:43 INFO - Running setup.py (path:/tmp/pip-uLxk8b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:43 INFO - Running setup.py (path:/tmp/pip-mqEJ7z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:43 INFO - Running setup.py (path:/tmp/pip-dKGnsf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:44 INFO - Running setup.py (path:/tmp/pip-MfYKFm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:44 INFO - Running setup.py (path:/tmp/pip-Gv0BqQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:44 INFO - Running setup.py (path:/tmp/pip-ZZPP6f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:44 INFO - Running setup.py (path:/tmp/pip-fSelM7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:44 INFO - Running setup.py (path:/tmp/pip-K8wib4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:44 INFO - Running setup.py (path:/tmp/pip-s_XMde-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:44 INFO - Running setup.py (path:/tmp/pip-2J6S6b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:44 INFO - Running setup.py (path:/tmp/pip-sbL89B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:44 INFO - Running setup.py (path:/tmp/pip-6RcFrz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:44 INFO - Running setup.py (path:/tmp/pip-eiTSoa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:44 INFO - Running setup.py (path:/tmp/pip-_J5mI_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:44 INFO - Running setup.py (path:/tmp/pip-iQjkei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:44 INFO - Running setup.py (path:/tmp/pip-_44ZoZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:51:45 INFO - Running setup.py install for manifestparser 16:51:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:51:45 INFO - Running setup.py install for mozcrash 16:51:45 INFO - Running setup.py install for mozdebug 16:51:45 INFO - Running setup.py install for mozdevice 16:51:45 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:51:45 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:51:45 INFO - Running setup.py install for mozfile 16:51:45 INFO - Running setup.py install for mozhttpd 16:51:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:51:45 INFO - Running setup.py install for mozinfo 16:51:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:51:45 INFO - Running setup.py install for mozInstall 16:51:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:51:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:51:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:51:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:51:45 INFO - Running setup.py install for mozleak 16:51:45 INFO - Running setup.py install for mozlog 16:51:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:51:46 INFO - Running setup.py install for moznetwork 16:51:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:51:46 INFO - Running setup.py install for mozprocess 16:51:46 INFO - Running setup.py install for mozprofile 16:51:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:51:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:51:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:51:46 INFO - Running setup.py install for mozrunner 16:51:46 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:51:46 INFO - Running setup.py install for mozscreenshot 16:51:46 INFO - Running setup.py install for moztest 16:51:46 INFO - Running setup.py install for mozversion 16:51:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:51:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:51:46 INFO - Cleaning up... 16:51:46 INFO - Return code: 0 16:51:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fddb68b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1179480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208660>, '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 0x1209560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1209a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', '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:51:46 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:51:46 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:51:46 INFO - Using env: {'DISPLAY': ':0', 16:51:46 INFO - 'HOME': '/home/cltbld', 16:51:46 INFO - 'LANG': 'en_US.UTF-8', 16:51:46 INFO - 'LANGUAGE': 'en_US:en', 16:51:46 INFO - 'LOGNAME': 'cltbld', 16:51:46 INFO - 'MAIL': '/var/mail/cltbld', 16:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:46 INFO - 'MOZ_NO_REMOTE': '1', 16:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:46 INFO - 'NO_EM_RESTART': '1', 16:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:46 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:46 INFO - 'SHELL': '/bin/bash', 16:51:46 INFO - 'SHLVL': '1', 16:51:46 INFO - 'TERM': 'linux', 16:51:46 INFO - 'TMOUT': '86400', 16:51:46 INFO - 'USER': 'cltbld', 16:51:46 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', 16:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:46 INFO - '_': '/tools/buildbot/bin/python'} 16:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:47 INFO - Running setup.py (path:/tmp/pip-0b6MOf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:47 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:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:47 INFO - Running setup.py (path:/tmp/pip-FRmjrR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:47 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:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:47 INFO - Running setup.py (path:/tmp/pip-DmHfb0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:47 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:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:47 INFO - Running setup.py (path:/tmp/pip-_ORwDE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:47 INFO - Running setup.py (path:/tmp/pip-l_xkcF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:47 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:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:47 INFO - Running setup.py (path:/tmp/pip-5TNWdC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:47 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:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:47 INFO - Running setup.py (path:/tmp/pip-ULqokE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:47 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:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:47 INFO - Running setup.py (path:/tmp/pip-8WDXn9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:47 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:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:47 INFO - Running setup.py (path:/tmp/pip-USam6I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:47 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:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:47 INFO - Running setup.py (path:/tmp/pip-wcvSra-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:47 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:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:47 INFO - Running setup.py (path:/tmp/pip-NcOxTA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:47 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:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:47 INFO - Running setup.py (path:/tmp/pip-Ht7gy5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:47 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:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:47 INFO - Running setup.py (path:/tmp/pip-gg_HQS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:47 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:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:47 INFO - Running setup.py (path:/tmp/pip-umw4YV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:48 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:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:48 INFO - Running setup.py (path:/tmp/pip-Jas7uw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:48 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:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:48 INFO - Running setup.py (path:/tmp/pip-iOk_9D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:48 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:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:48 INFO - Running setup.py (path:/tmp/pip-rE21nL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:48 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:51:48 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:51:48 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:51:48 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:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:51:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:49 INFO - Downloading blessings-1.5.1.tar.gz 16:51:49 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:51:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:51:49 INFO - Installing collected packages: blessings 16:51:49 INFO - Running setup.py install for blessings 16:51:50 INFO - Successfully installed blessings 16:51:50 INFO - Cleaning up... 16:51:50 INFO - Return code: 0 16:51:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:51:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:51:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:51:50 INFO - Reading from file tmpfile_stdout 16:51:50 INFO - Current package versions: 16:51:50 INFO - argparse == 1.2.1 16:51:50 INFO - blessings == 1.5.1 16:51:50 INFO - blobuploader == 1.2.4 16:51:50 INFO - docopt == 0.6.1 16:51:50 INFO - manifestparser == 1.1 16:51:50 INFO - mozInstall == 1.12 16:51:50 INFO - mozcrash == 0.16 16:51:50 INFO - mozdebug == 0.1 16:51:50 INFO - mozdevice == 0.47 16:51:50 INFO - mozfile == 1.2 16:51:50 INFO - mozhttpd == 0.7 16:51:50 INFO - mozinfo == 0.9 16:51:50 INFO - mozleak == 0.1 16:51:50 INFO - mozlog == 3.1 16:51:50 INFO - moznetwork == 0.27 16:51:50 INFO - mozprocess == 0.22 16:51:50 INFO - mozprofile == 0.28 16:51:50 INFO - mozrunner == 6.11 16:51:50 INFO - mozscreenshot == 0.1 16:51:50 INFO - mozsystemmonitor == 0.0 16:51:50 INFO - moztest == 0.7 16:51:50 INFO - mozversion == 1.4 16:51:50 INFO - psutil == 3.1.1 16:51:50 INFO - requests == 1.2.3 16:51:50 INFO - wsgiref == 0.1.2 16:51:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:50 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 0x7fddb68b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1179480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208660>, '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 0x1209560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1209a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', '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:51:50 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:51:50 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:51:50 INFO - Using env: {'DISPLAY': ':0', 16:51:50 INFO - 'HOME': '/home/cltbld', 16:51:50 INFO - 'LANG': 'en_US.UTF-8', 16:51:50 INFO - 'LANGUAGE': 'en_US:en', 16:51:50 INFO - 'LOGNAME': 'cltbld', 16:51:50 INFO - 'MAIL': '/var/mail/cltbld', 16:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:50 INFO - 'MOZ_NO_REMOTE': '1', 16:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:50 INFO - 'NO_EM_RESTART': '1', 16:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:50 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:50 INFO - 'SHELL': '/bin/bash', 16:51:50 INFO - 'SHLVL': '1', 16:51:50 INFO - 'TERM': 'linux', 16:51:50 INFO - 'TMOUT': '86400', 16:51:50 INFO - 'USER': 'cltbld', 16:51:50 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', 16:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:50 INFO - '_': '/tools/buildbot/bin/python'} 16:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:50 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:51:50 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:51:50 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:51:50 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:51:50 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:51:50 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:51:50 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:51:50 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:51:50 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:51:50 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:51:50 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:51:50 INFO - Cleaning up... 16:51:50 INFO - Return code: 0 16:51:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:50 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 0x7fddb68b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1179480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208660>, '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 0x1209560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1209a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', '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:51:50 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:51:50 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:51:50 INFO - Using env: {'DISPLAY': ':0', 16:51:50 INFO - 'HOME': '/home/cltbld', 16:51:50 INFO - 'LANG': 'en_US.UTF-8', 16:51:50 INFO - 'LANGUAGE': 'en_US:en', 16:51:50 INFO - 'LOGNAME': 'cltbld', 16:51:50 INFO - 'MAIL': '/var/mail/cltbld', 16:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:50 INFO - 'MOZ_NO_REMOTE': '1', 16:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:50 INFO - 'NO_EM_RESTART': '1', 16:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:50 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:50 INFO - 'SHELL': '/bin/bash', 16:51:50 INFO - 'SHLVL': '1', 16:51:50 INFO - 'TERM': 'linux', 16:51:50 INFO - 'TMOUT': '86400', 16:51:50 INFO - 'USER': 'cltbld', 16:51:50 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', 16:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:50 INFO - '_': '/tools/buildbot/bin/python'} 16:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:50 INFO - Downloading/unpacking jsonschema 16:51:50 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:51:50 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:51:50 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:51:50 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:51:50 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:51:50 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:51:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:51:52 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:51:52 INFO - Downloading/unpacking functools32 (from jsonschema) 16:51: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:51: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:51: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:51: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:51: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:51: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:51:52 INFO - Downloading functools32-3.2.3-2.tar.gz 16:51:52 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:51:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:51:52 INFO - warning: no files found matching '*.txt' 16:51:52 INFO - no previously-included directories found matching 'build' 16:51:52 INFO - no previously-included directories found matching 'dist' 16:51:52 INFO - no previously-included directories found matching '.git*' 16:51:52 INFO - Installing collected packages: jsonschema, functools32 16:51:52 INFO - Running setup.py install for functools32 16:51:52 INFO - warning: no files found matching '*.txt' 16:51:52 INFO - no previously-included directories found matching 'build' 16:51:52 INFO - no previously-included directories found matching 'dist' 16:51:52 INFO - no previously-included directories found matching '.git*' 16:51:52 INFO - Successfully installed jsonschema functools32 16:51:52 INFO - Cleaning up... 16:51:52 INFO - Return code: 0 16:51:52 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fddb68b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1179480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208660>, '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 0x1209560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1209a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', '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:51:52 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:51:52 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:51:52 INFO - Using env: {'DISPLAY': ':0', 16:51:52 INFO - 'HOME': '/home/cltbld', 16:51:52 INFO - 'LANG': 'en_US.UTF-8', 16:51:52 INFO - 'LANGUAGE': 'en_US:en', 16:51:52 INFO - 'LOGNAME': 'cltbld', 16:51:52 INFO - 'MAIL': '/var/mail/cltbld', 16:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:52 INFO - 'MOZ_NO_REMOTE': '1', 16:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:52 INFO - 'NO_EM_RESTART': '1', 16:51:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:52 INFO - 'SHELL': '/bin/bash', 16:51:52 INFO - 'SHLVL': '1', 16:51:52 INFO - 'TERM': 'linux', 16:51:52 INFO - 'TMOUT': '86400', 16:51:52 INFO - 'USER': 'cltbld', 16:51:52 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', 16:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:52 INFO - '_': '/tools/buildbot/bin/python'} 16:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:53 INFO - Downloading/unpacking flake8 16:51: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:51: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:51: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:51: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:51: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:51: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:51:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:51:54 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:51:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:51: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:51: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:51: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:51: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:51: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:51: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:51:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:51:54 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:51:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:51: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:51: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:51: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:51: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:51: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:51: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:51:55 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:51:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:51:55 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:51:55 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:51:55 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:51:55 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:51:55 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:51:55 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:51:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:51:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:51:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:51:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:51:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:51:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:51:55 INFO - no previously-included directories found matching 'docs/_build' 16:51:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:51:55 INFO - Running setup.py install for pep8 16:51:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:51:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:51:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:51:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:51:55 INFO - no previously-included directories found matching 'docs/_build' 16:51:55 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:51:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:51:55 INFO - Cleaning up... 16:51:55 INFO - Return code: 0 16:51:55 INFO - Running post-action listener: _resource_record_post_action 16:51:55 INFO - Running post-action listener: _start_resource_monitoring 16:51:55 INFO - Starting resource monitoring. 16:51:55 INFO - ##### 16:51:55 INFO - ##### Running install step. 16:51:55 INFO - ##### 16:51:55 INFO - Running pre-action listener: _resource_record_pre_action 16:51:55 INFO - Running main action method: install 16:51:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:51:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:51:55 INFO - Reading from file tmpfile_stdout 16:51:55 INFO - Detecting whether we're running mozinstall >=1.0... 16:51:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:51:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:51:55 INFO - Reading from file tmpfile_stdout 16:51:55 INFO - Output received: 16:51:55 INFO - Usage: mozinstall [options] installer 16:51:55 INFO - Options: 16:51:55 INFO - -h, --help show this help message and exit 16:51:55 INFO - -d DEST, --destination=DEST 16:51:55 INFO - Directory to install application into. [default: 16:51:55 INFO - "/builds/slave/test-pgo"] 16:51:55 INFO - --app=APP Application being installed. [default: firefox] 16:51:55 INFO - mkdir: /builds/slave/test-pgo/build/application 16:51:55 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:51:55 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:52:11 INFO - Reading from file tmpfile_stdout 16:52:11 INFO - Output received: 16:52:11 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:52:11 INFO - Running post-action listener: _resource_record_post_action 16:52:11 INFO - ##### 16:52:11 INFO - ##### Running run-tests step. 16:52:11 INFO - ##### 16:52:11 INFO - Running pre-action listener: _resource_record_pre_action 16:52:11 INFO - Running main action method: run_tests 16:52:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:52:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:52:11 INFO - Python 2.7.3 16:52:11 INFO - Return code: 0 16:52:11 INFO - grabbing minidump binary from tooltool 16:52:11 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:52:11 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 0x1208660>, '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 0x1209560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1209a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:52:11 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:52:11 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:52:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:52:11 INFO - Return code: 0 16:52:11 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:52:11 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:52:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:52:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:52:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:52:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:52:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:52:12 INFO - Return code: 0 16:52:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 16:52:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 16:52:12 INFO - Using env: {'DISPLAY': ':0', 16:52:12 INFO - 'HOME': '/home/cltbld', 16:52:12 INFO - 'LANG': 'en_US.UTF-8', 16:52:12 INFO - 'LANGUAGE': 'en_US:en', 16:52:12 INFO - 'LOGNAME': 'cltbld', 16:52:12 INFO - 'MAIL': '/var/mail/cltbld', 16:52:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:52:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:12 INFO - 'MOZ_NO_REMOTE': '1', 16:52:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:12 INFO - 'NO_EM_RESTART': '1', 16:52:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:52:12 INFO - 'PWD': '/builds/slave/test-pgo', 16:52:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:52:12 INFO - 'SHELL': '/bin/bash', 16:52:12 INFO - 'SHLVL': '1', 16:52:12 INFO - 'TERM': 'linux', 16:52:12 INFO - 'TMOUT': '86400', 16:52:12 INFO - 'USER': 'cltbld', 16:52:12 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282', 16:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:12 INFO - '_': '/tools/buildbot/bin/python'} 16:52:12 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:52:12 INFO - mozversion application_buildid: 20160101143006 16:52:12 INFO - mozversion application_changeset: c9ed86a8b757e783fa14c2afcfff4a61e0d7b574 16:52:12 INFO - mozversion application_display_name: Nightly 16:52:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:52:12 INFO - mozversion application_name: Firefox 16:52:12 INFO - mozversion application_remotingname: firefox 16:52:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 16:52:12 INFO - mozversion application_vendor: Mozilla 16:52:12 INFO - mozversion application_version: 46.0a1 16:52:12 INFO - mozversion platform_buildid: 20160101143006 16:52:12 INFO - mozversion platform_changeset: c9ed86a8b757e783fa14c2afcfff4a61e0d7b574 16:52:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 16:52:12 INFO - mozversion platform_version: 46.0a1 16:52:12 INFO - using testdate: 1451695932 16:52:12 INFO - actual date: 1451695932 16:52:13 INFO - starting webserver on 'localhost:42102' 16:52:13 INFO - SUITE-START | Running 3 tests 16:52:13 INFO - TEST-START | dromaeo_css 16:52:13 INFO - operating with platform_type : linux_ 16:52:13 INFO - Initialising browser for dromaeo_css test... 16:52:13 INFO - TEST-INFO | started process 6336 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpj9RtZe/profile http://localhost:42102/getInfo.html) 16:52:17 INFO - PROCESS | 6336 | __metrics Screen width/height:1600/1200 16:52:17 INFO - PROCESS | 6336 | colorDepth:24 16:52:17 INFO - PROCESS | 6336 | Browser inner width/height: 1024/697 16:52:17 INFO - PROCESS | 6336 | __metrics 16:52:17 INFO - PROCESS | 6336 | 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:52:17 INFO - PROCESS | 6336 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:52:18 INFO - TEST-INFO | 6336: exit 0 16:52:18 INFO - Browser initialized. 16:52:18 INFO - Running cycle 1/1 for dromaeo_css test... 16:52:18 INFO - TEST-INFO | started process 6429 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpj9RtZe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:52:30 INFO - PROCESS | 6429 | RSS: Main: 149516288 16:52:30 INFO - PROCESS | 6429 | 16:53:21 INFO - PROCESS | 6429 | 1451696001781 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:55:30 INFO - PROCESS | 6429 | Cycle 1(1): loaded http://localhost:42102/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42102/tests/dromaeo/cssquery-ext.html) 16:55:31 INFO - PROCESS | 6429 | RSS: Main: 265338880 16:55:31 INFO - PROCESS | 6429 | 16:58:33 INFO - PROCESS | 6429 | Cycle 1(1): loaded http://localhost:42102/tests/dromaeo/cssquery-ext.html (next: http://localhost:42102/tests/dromaeo/cssquery-jquery.html) 16:58:34 INFO - PROCESS | 6429 | RSS: Main: 234975232 16:58:34 INFO - PROCESS | 6429 | 17:01:36 INFO - PROCESS | 6429 | Cycle 1(1): loaded http://localhost:42102/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42102/tests/dromaeo/cssquery-mootools.html) 17:01:37 INFO - PROCESS | 6429 | RSS: Main: 235003904 17:01:37 INFO - PROCESS | 6429 | 17:04:38 INFO - PROCESS | 6429 | Cycle 1(1): loaded http://localhost:42102/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42102/tests/dromaeo/cssquery-prototype.html) 17:04:39 INFO - PROCESS | 6429 | RSS: Main: 216002560 17:04:39 INFO - PROCESS | 6429 | 17:07:42 INFO - PROCESS | 6429 | Cycle 1(1): loaded http://localhost:42102/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42102/tests/dromaeo/cssquery-yui.html) 17:07:42 INFO - PROCESS | 6429 | RSS: Main: 197505024 17:07:42 INFO - PROCESS | 6429 | 17:10:45 INFO - PROCESS | 6429 | Cycle 1(1): loaded http://localhost:42102/tests/dromaeo/cssquery-yui.html (next: http://localhost:42102/tests/dromaeo/cssquery-dojo.html) 17:10:45 INFO - PROCESS | 6429 | RSS: Main: 237064192 17:10:45 INFO - PROCESS | 6429 | 17:10:45 INFO - PROCESS | 6429 | __start_tp_report 17:10:45 INFO - PROCESS | 6429 | _x_x_mozilla_page_load 17:10:45 INFO - PROCESS | 6429 | _x_x_mozilla_page_load_details 17:10:45 INFO - PROCESS | 6429 | |i|pagename|runs| 17:10:45 INFO - PROCESS | 6429 | |0;dojo.html;3067.29452225988;3143.6227652681655;3184.124365799405;3195.5845740053787;3208.1819136120293;5224.21636754487;5237.162054071349;5251.86870328242;5298.682079075254;5313.760880760366;5207.166853303473;5304.549113325372;5357.866053348658;5359.758810853511;5472.699001554923;4879.975600121995;4911.975440122803;4978.178600530908;5077.060743762416;5083;4938.135826230413;5011.84964451067;5037.093323201822;5060.240963855433;5072.163093089635;4832.275158726184;4892.779824907852;4924.162892308298;5021.648484606079;5028.924566131511;4953.529414705597;4967.379077615298;4974.577160941324;4993.0263598598285;5017.5985921126585;4897;4935.35840340757;4948.1093403187415;4964.503549645043;4970.130227210224;5136.280920671109;5169.819056333048;5256.710880901549;5302.761375738101;5357.08929481989;5807.390224026501;5808.186853840466;5810.360860305363;5814.418558144194;5825.242718446575;5812.709364531756;5861.736221869984;5868.4424979626865;5893.499052580536;5896.823095307148;5230.686158830483;5353.9196912046355;5361.437049109865;5362.034833729927;5490.972545137249;5992.460678538952;6004.54965877561;6014.278286605635;6016.127661489059;6019.337872833985;5745.3105627324985;5759.366469688331;5761.711914404263;5765.1640512125505;5822.70886455684;5667.263255776723;5670.659760414388;5819.563532735062;5827.650340979555;5847.415258474119;5875.823725288248;5885.087811389241;5891.05743081105;5893.941060589339;5894.764209431574;5883.646981181143;5887.852803679943;5891.793787217427;5897;5905.881882362329;4346.130773845243;4421.845235416745;4446.044100518339;4528.343390208402;4532.637389008872;3985.1830374773103;4002.039510517513;4005.839766409311;4019.8191081401405;4046.7976601169826;5404.108322126884;5408.45915408456;5413.675179489164;5415;5433.2936718227165;5758.74085666146;5783.306003279549;5815.273090863642;5879.441453061952;5880.235569375954;5369;5375.408705042442;5398.785273313473;5424.864378390572;5427.402985671573;5004.749762511859;5012.072766538202;5024.171011783015;5028.220625803006;5058.671186372874;5761.48146666802;5879.470847623735;5880.941190588125;6028.186194863637;6041.335453100155;5610.85972850682;5620.4660557247;5622.8313150605545;5629.7748090077575;5708.885822283614;5916.556258280732;5929.555283353679;5931.3178984417345;5939.613925094855;5987.880242395215;5632.324121105494;5680.886382272249;5732.742026608729;5736.541076713769;5740.1102829061565;5814.505767009851;5825.446582574648;5851.21008663842;5871.735771890189;5911.674857882857;5693.658380497183;5704.229928959703;5706.828795136153;5743.569232307677;5745.166950792028;5554.305711786027;5661.320641523043;5669.4047125051275;5703.230063941481;5729.169270455677;5579.609427340048;5673.205751194919;5676.403977582295;5678.3186017678145;5721.256236689203;5623.662580245198;5638.802641907513;5641.576881733804;5648.350439699487;5655.7454914528125;5469.288992430958;5530.5022547970875;5531.944680553143;5625.409332020243;5637.098064309691 17:10:45 INFO - PROCESS | 6429 | |1;ext.html;538.1846502548639;541.2638811216747;555.9520304226533;567.3843879390861;567.9574031947604;28966.565501517467;29430.70569294309;38742.22515549691;39379.015524611896;39437;43570.56429435705;44182.33726494097;44299.557004429946;44300.77849610747;44323.33514997278;7602.125755538101;8726.738197854074;8900.065493123226;8904.643814247422;8915.108489151098;7767.6116194190345;7867;10125.24060695447;10333.431661258628;10344.327618704798;10139.290249682525;10239.692809215736;10240.078392944633;10247.077763001329;10261.486925653724;7705.922940770577;7887.290143887078;10016.699499015042;10169.745756356077;10192.235582331356;7563.810904727371;10147.847782283272;10349.327293725884;10380.11768999636;10382.9480852596;37063.81468092669;37289.81355093234;37506.24987500262;37528;37549.81225093884;3284.458064419368;3299.3566254580364;3327.5008748687646;3376.6116896556964;3705.184859330943;27925.441491170266;28268.151955441368;28383.57424638632;29015.12954611365;29626;3930.5872883347124;3964.444977703124;4003.819828107742;4007.6593489553425;4102.651274641659;278438;278910;280809;280837;281961;53183.20225196625;54139.45860541344;58750;59256.11115833266;59462.70268648629;53321.73339133357;53368;53615;53626.73186634042;53702.19446708303;14993.550193494213;15301.923490382476;15308.387664493519;15321.540353789404;15329.770053449207;11697.356645384416;11824.11319151067;11827.349495777642;11829.231099978473;11838.289702617698;19099.331523396613;19276;19347.903260483607;19348.516287092934;19433.22267109328;7358.153812311546;7750.534967901944;7754.3796496280165;7764.456488045896;7766.728164514215;928.2620316847987;994.9652361543913;1043.4834756795435;1059.9046085852156;1104.8232282834708;27986.300342491195;28377.164467252063;28469.430611387656;28588.857055714587;29082.27294317659;1064.499685147979;1078.9749737749169;1096.950637221327;1115.6708770912437;1193.1111322064944;14647.853521464649;14702.411903523953;14738.410463581336;14876.479323223635;14923.701525969636;336194;341086;341445;341823;342673;52680.47319526756;53091.46908530942;53285.7335713319;53342;53391.73304133532;1330.567565541203;1341.9798703019462;1361.1288775183693;1362.6184668292894;1366.8906487480979;25949.48101037931;27759.861200693867;27831.860840695666;28251.293717657223;28323.43353132967;40557.52473416169;41622.37566436567;41664.3750343739;41683.166336673705;41702.582974171084;277567;285918;384122;393192;394557;29165.562516561844;29409.55885661674;29414.705852942054;29417.11748647544;29429.117126485384;39317;40810.38784418296;41236.38145427881;41264.381034283906;41568.376474352306;33496.83251583727;34137;34205.14487137841;34401;34737.65262347344;34989;35054.29891402209;35563;35698.8215058923;35742.285154296245;34959.65040349666;35075.473867891495;35244.823775880956;35942.28115437729;36854.26291474102;27627.309317266427;30459.390812184076;30757.846210768803;30789.69210307958;30792.23019424443;24541.509169816145;24734.876325618257;24984.875075624506;25635.871820640776;26264.34339141537 17:10:45 INFO - PROCESS | 6429 | |2;jquery.html;355.7260909099993;360.9675129238368;361.17651754000855;363.5292296476063;366.92111196092833;14187.574372768808;14539.78190327146;16117.516474505768;16211.75682364764;16904.323827046905;14389.64025899353;15051.473198438056;15079;15087.170205638686;16682.499525014267;5388.865278368033;5502.064649009658;5507.4767897049915;5511.22842802008;5520.696361700105;4045;4176.644985176264;5382.165764306539;5436.103042997901;5961.076033214837;5974.701264936757;6006.519478441714;6046.727897244635;6052.848678783043;6068.969655151718;5207.661502002357;5333.626646134772;5382.0312343778105;5393.622446428752;6013.1581578579035;5132.923006154911;5138.922916156261;5140.691558506502;5159.2003239497935;5179.456157103526;12583.119181657288;12709.618711438672;16445.93101448414;18917.24331026757;19539.706904396444;2036.775954644988;2068.596623658387;2151.019940293741;2166.6100101981638;2187.7702841201603;9167.908320916773;9289.30330225229;9301.209397201179;9586.90413095867;9601.327907046509;1765.8145894681002;1780.563761878335;1799.379214171109;1816.5277027972822;1827.7349784281205;59125.791791861666;59693;60318.69840650768;62810.37189628091;63750;10407.895921040845;10408.5836566538;10436.947815261026;10451.372917624967;10481.580736770597;13636.113652612548;13650.863491365159;13675.31623418825;13681.315934203449;13682.384292706853;6870.31296870309;7086.822829429202;7096.787096387116;7102.644867756695;7152.713891444284;6738.427233685192;6764;6776.728930842711;6812.046313516112;6816.386525212754;4130.504339479222;4164.8542301019315;4275.40144379787;4276.187524370422;4279.871603851827;1771.4419957713278;1802.1347904918346;1807.8068474806828;1815.872888897791;1842.9039214120407;921.4931787516839;923.1460898668705;937.386012162035;957.8323793336139;993.1806259835664;15854.44509442187;16966.491005269614;17631.911840440716;17950.730739038925;18031.63936721258;877.3156937588691;970.2819913264275;982.0719420148034;1054.3357684658615;1058.2486434631344;9534.809303814023;9863.40819550815;10117.494125293706;10125.544350504246;10147.492625368703;591929;604956;609434;618886;619286;78575;80040.5997970018;80100;80477;82876.58561707153;1172.8006238939402;1176.300101439642;1207.3600991474532;1209.25026483579;1232.6302109367155;15739.68520629558;15833.366665333719;15876.603084922508;16096.27566759522;16106;36052.27895442129;36326.818365908;36358.636413635526;36859.44710829286;37152.44271335986;47362;49192.508074920224;49492.50507494879;49497;50462.2430663533;9170.44977301364;9265.166135047879;9293.210077143518;9313.25493960495;9392.154706076486;11261.380624065756;11340.149488788538;11486;12388.938055309665;17546.73679894828;11072.501737421675;12627.431765570755;14017.439302427789;14363.353649085608;14494.05788623736;11416.600418985296;13672.316384180951;13942.302884855513;14223.431062757787;15011.924940375666;13981.161130332213;14440.711185776436;14450.927745361627;14583.270836457923;14740.11559306445;9314.44113353201;9456.432614043179;9489.810203795747;9625.807483850424;9679.758006049906;10670.253082284165;13208.73582528325;13255.337233138498;14499.347529360994;14957.551273461813 17:10:45 INFO - PROCESS | 6429 | |3;mootools.html;1286.1575667937493;1429.806976058232;1431.6635590636201;1567.8980866243694;1728.0927513055651;6577.210734711835;7070.222275549691;7218.025566548515;7233.493655444121;7235.204127545966;6896.137982752156;7036.753713620024;7079.221285658587;7091.468139889503;7105.253948335428;1950.3076407875212;1994.8902810345426;1995.3315639260866;2195.1438938813835;2237.429455488848;2000.3298894870236;2007.317512045904;2197.4726065744267;2246.4833088389682;2248.4940888300166;2180.3785921012513;2211.9115235390564;2213.8893055347166;2215.1360969222014;2231.0072017952016;1947.4157752674141;1991.541945352577;2237.7202849643795;2262.513559584689;2264.30938563738;2203.305958623029;2257.683924250606;2259.9322020339414;2261.231181398316;2261.457250259942;7081.61051142187;7147.749828755968;7160.534565253294;7161.176464706573;7161.462890283197;4327.3725309830215;4418.779061046935;4421.65139632412;4429.047754732748;4439.356293337481;2772.6848081851676;2884.278930267433;2890.508613535704;2898.811577247472;2910.3306239565018;928.6099838068028;934.6261495401826;941.3833938770116;942.006183476432;979.3976704326788;9608.231341492663;9624.181944534723;9661.46861922594;9675.854862177073;9715.36850104741;3971.62269584389;4006.819693113817;4036.051527891002;4046.2109888572036;4153.646940010072;8105.513669179868;8124;8142.307903828122;8147.348212143014;8157.1842815717955;4551.249043907785;4585.862424127282;4591.747453890068;4592.931106033412;4596.057808149321;4148.502179738391;4173.457450531411;4188.560201178832;4199.853005144866;4211.894702632459;3320.9169770755925;3332.5669961916124;3354;3366.057503898863;3386.407378708716;1045.4354648489882;1061.601899287767;1064.302881612545;1065.2277099103244;1079.2121751121724;1111.899929006377;1136.63059505661;1140.5437824870119;1164.545827127421;1212.7877621416217;6905.861882762317;6954.9304506955295;6980.197277313073;6986.54587451814;6987.336203060701;1094.6825420628088;1119.1438549509633;1137.9715507112223;1139.566964553481;1140.321508702321;5259.237410575522;5343.946560534345;5361.276227709287;5617.662940223599;5728.914066289009;8173.754787356389;8181.877271840927;8361.874571881426;8375.20435558621;8400.159984001551;8540.402171848034;8546;8588.269997050196;8643.876296081595;8672.826543469095;6932.133483314586;6961.686724097428;6989.0215369848265;7029.789106326818;7039.542429742153;6855.965720171367;7007.159140903124;7018.754343598154;7020.719171233093;7032.753853615099;7656.885146722692;7891.921080789119;7898.842023159619;7922.643481043252;7955.363570914429;7939.483933544532;8138.064122625737;8146.470479419056;8166.979127609049;8295.294899933573;6340;6348.143000694847;6425;6426.325235850169;6433.356664333529;6861.588304701734;6878.071460352789;6956.2695916928;6963.7562685305775;7181.892271616034;6573.901391479228;6626.768063117768;6681.1314529110905;6722.899156512754;6743.662816859235;6389.9041514376395;6560.376764207393;6626.635535045619;6655.334466553306;6736.02327662496;6603.141591593062;6639.336066393322;6640.900386494303;6647;6650.467962562887;6080.48315893154;6128.417800309142;6134.754609815736;6135.815925522242;6136.079588061826;6158.291796443287;6302.653354065387;6311.147995020613;6312.210973628296;6312.684365781601 17:10:45 INFO - PROCESS | 6429 | |4;prototype.html;347.7687337920283;349.8076058168008;352.202261876849;352.9594096678883;353.1154458082503;5903.173555702199;5930.911036334458;5988.431099045589;5994.370591087938;6058.545609079315;5616.185653080301;5735.397783232763;5764.769409223626;5927.229460170182;5929.525637948965;4543.1140927519145;4550.499445061049;4579.358889755437;4586.656000799937;4589.495155532889;4549.021960278539;4558.156741002925;4570.97714511427;4615.561521655437;4616.492185859553;4324.048709283952;4444.444444444444;4444.71109377891;4551.9985603167415;4552.08958208358;4521.321801729734;4524.2082635538645;4525.072360166158;4526.3210518422175;4546.499885012646;4048.068944142834;4065.5527891931865;4067.7559346439307;4069.369247766601;4083.509978802533;5684.488396044335;5691.886162276773;5695.45893140151;5701.230333904911;5703.914441283384;5224.451432599599;5392.2181283714035;5395.946040539584;5407.270018547524;5408.2698835657075;6328.398802113792;6338.668879535303;6343.873122537523;6347.96826015867;6353.078803573502;4547.840825571089;4549.954500454986;4552.590266875997;4556.04323092151;4557.840475583339;6444.001179817136;6532.738690452376;6596.868062638769;6601.63690996995;6613.305602911673;4656.3946686930485;4660.5106463821485;4664.720116793003;4668;4668.066386722669;4728.976355118271;4731.408573928259;4731.621470282369;4732.148213321566;4737.170995075848;5363.812266570651;5380.78476860929;5386.542143917733;5387.111126664056;5393.002294575437;6102.267727872683;6356.491480681534;6358.713857876407;6375.904361434582;6377.808665740035;1647.3163637090472;1670.2650833633163;1670.6241095753358;1671.1393632279385;1671.607172314505;1134.2513940799197;1137.1016896651552;1140.4183866228118;1150.9942450287863;1168.3106966889407;5854.590178687451;5870.060790273621;5877.588568800228;5881.529477641864;5901.793437229677;6486.643234622141;6496.740130394825;6504.642244676588;6508.60948343101;6511.0558968949235;5735.254416925773;5848.385919478478;5850.4788754923175;5887.4701276884425;5895.086261629454;3295.736341092707;3472.409690352646;3507.8246087696025;3520.4543295789194;3521.3837578423672;6632.905570580897;6646.169228846395;6798.626075565891;6812.284710105368;6816.863662726718;6750.291219421988;6752.324767523307;6755.459563234929;6755.560888542229;6756.020377045399;6615.676864627094;6784.728610855609;6786.558873673195;6788.694508747119;6807.115075040312;6546.803595892131;6547.803565893031;6553.574017688835;6555.967220163869;6556.967215163893;6445.1943507061615;6460;6485.189351331083;6486.967565162144;6499.3175716549085;6571.934280657323;6716.731330746716;6757.594544327356;6761.391474767294;6767.560108592926;4589.426321709786;4590.678652494427;4593.632509399307;4598;4599.724016559017;6546.803595892131;6553.049807777941;6556.2788093308745;6558.8360290993105;6564.704588293443;6219.844503887258;6362.713677884599;6390.52071094679;6391.137196478416;6396.968015159894;6369.299377068426;6380.393862583047;6383.1382763326355;6383.712732926937;6388.96805515988;6253.093301471352;6256.718447669775;6263.937360626335;6272.6236425814595;6274.278457977391;6149.538784591263;6203.193584833943;6252.812415627538;6341.90487142684;6409.935900640934;6244.313125556276;6244.812655620339;6292.748290068529;6297.590656607306;6299.905501417574 17:10:45 INFO - PROCESS | 6429 | |5;yui.html;745.3440971944688;760.5550752809606;812.854817579102;815.7348861619975;829.2826704900264;13330.800037999437;13489.39297731602;13522.797158042637;13529.323533823293;13539.729205415886;12553.937230313835;12651.683707907285;14095.577132686036;14610;14650.633734156652;677.9525433219677;683.6308393467522;805.6012273924416;816.6570040582969;817.8037271054934;789.6249281591226;798.7084714079377;804.9195080491933;805.005817814998;805.3919290935336;848.9872651910226;854.4659587757651;855.1961156512858;855.9743207703779;856.2850020233113;682.1575354437266;688.1845013658831;823.4812068396872;838.8951381077366;839.6641343462634;613.7268915332679;614.3089024847047;614.6496496996714;614.7694614519555;614.8401415631968;13280.867191328156;13477.393517291745;13479.258640774753;13525.59423217305;13559.118657287343;11612.07103431732;12123.93938030313;12212.57255996036;12416;12581.709145427287;10295.837376527143;10453.47732613374;10465.790684186273;10591.205659575486;10719.678409647722;3593.389123848952;3642.8907132786057;3651.99570118217;3693.169036966661;3763.41667041609;47545.76227118877;47622.761886190696;47816.28275575869;48162.51837481615;48378.75810620959;9017.188453039258;9065.41074830147;9282.850956083084;9294.488803115893;9343.766405839908;17342.479725608253;17356.47930562085;17386.65226695459;17391.391301304393;17401.65196696059;6897.310268973062;7164.140303163654;7186;7239.420846332281;7242.49302548827;3976.721629485966;4016.7389119707127;4054.2904991626347;4158.875233742992;4166.854160104382;2917.329014326717;2938.985305073461;2947.4547208766016;2973.717496837797;2976.0922918510064;549.4395716369281;551.6745120378915;568.9630174038674;577.3591313641854;578.8668606220593;540.7647673262144;547.3814589513823;552.7402121003122;612.6936531734133;623.4077626255075;7375.88936165958;7865.528068315919;8034.638441270157;8059.153788852203;8183.83632327362;598.0849300570135;635.2345423764353;637.7831537277256;641.5092454272485;679.3512195852949;3618.108453696498;3624.9456258156147;3737.3085979093953;3772.07584141887;3801.923961520754;56359;61513.69243153756;61803.6909815448;61821.38178618156;62001.37998620046;51569.48430515722;52289.215661765105;52820;52936.47063529315;52938.73530632322;45072.54927450683;45966.540334596226;48078.759606202446;48269.75865120722;48446.5155348442;8277.675571908465;8291.709790157316;8512.637977923503;8515.659373624985;8615.655373784979;36184;36830;36841.447378289886;36876.631233687316;37953.81023094867;45901;46900.29649555191;46953.2957005652;47441;48104.759476202395;10639.361638301727;10897;10924.2899211551;11132.944335278597;11465.484053217791;11444.713882153013;11537.365444900612;11541.653750387502;11899.286042837457;12089.697757556132;10763.838542422027;10832.837507437238;10961.725956851142;11031.558737650725;11348.917904308848;11239.775204496027;11456.255343402652;11557.653270401901;11842;11904.16670833068;6641.601503909781;9914.20686345105;10470.633527826489;10512.526936287732;11170.553177872795;9692.273079519206;9900.504974751379;10044.698659040241;10200.28597998133;10200.693979180636;9193.402428842372;9365.969743328365;9521.333506654744;9557.330986830855;9725.708228753148 17:10:45 INFO - PROCESS | 6429 | __end_tp_report 17:10:45 INFO - PROCESS | 6429 | __start_cc_report 17:10:45 INFO - PROCESS | 6429 | _x_x_mozilla_cycle_collect,888 17:10:45 INFO - PROCESS | 6429 | __end_cc_report 17:10:45 INFO - PROCESS | 6429 | __startTimestamp1451697045570__endTimestamp 17:10:45 INFO - PROCESS | 6429 | 17:10:45 INFO - PROCESS | 6429 | ------- Summary: start ------- 17:10:45 INFO - PROCESS | 6429 | Number of tests: 6 17:10:45 INFO - PROCESS | 6429 | 17:10:45 INFO - PROCESS | 6429 | [#0] dojo.html Cycles:165 Average:5384.46 Median:5622.83 stddev:603.51 (10.7%) stddev-sans-first:577.34 17:10:45 INFO - PROCESS | 6429 | Values: 3067.3 3143.6 3184.1 3195.6 3208.2 5224.2 5237.2 5251.9 5298.7 5313.8 5207.2 5304.5 5357.9 5359.8 5472.7 4880.0 4912.0 4978.2 5077.1 5083.0 4938.1 5011.8 5037.1 5060.2 5072.2 4832.3 4892.8 4924.2 5021.6 5028.9 4953.5 4967.4 4974.6 4993.0 5017.6 4897.0 4935.4 4948.1 4964.5 4970.1 5136.3 5169.8 5256.7 5302.8 5357.1 5807.4 5808.2 5810.4 5814.4 5825.2 5812.7 5861.7 5868.4 5893.5 5896.8 5230.7 5353.9 5361.4 5362.0 5491.0 5992.5 6004.5 6014.3 6016.1 6019.3 5745.3 5759.4 5761.7 5765.2 5822.7 5667.3 5670.7 5819.6 5827.7 5847.4 5875.8 5885.1 5891.1 5893.9 5894.8 5883.6 5887.9 5891.8 5897.0 5905.9 4346.1 4421.8 4446.0 4528.3 4532.6 3985.2 4002.0 4005.8 4019.8 4046.8 5404.1 5408.5 5413.7 5415.0 5433.3 5758.7 5783.3 5815.3 5879.4 5880.2 5369.0 5375.4 5398.8 5424.9 5427.4 5004.7 5012.1 5024.2 5028.2 5058.7 5761.5 5879.5 5880.9 6028.2 6041.3 5610.9 5620.5 5622.8 5629.8 5708.9 5916.6 5929.6 5931.3 5939.6 5987.9 5632.3 5680.9 5732.7 5736.5 5740.1 5814.5 5825.4 5851.2 5871.7 5911.7 5693.7 5704.2 5706.8 5743.6 5745.2 5554.3 5661.3 5669.4 5703.2 5729.2 5579.6 5673.2 5676.4 5678.3 5721.3 5623.7 5638.8 5641.6 5648.4 5655.7 5469.3 5530.5 5531.9 5625.4 5637.1 17:10:45 INFO - PROCESS | 6429 | 17:10:45 INFO - PROCESS | 6429 | [#1] ext.html Cycles:180 Average:48126.64 Median:184845.42 stddev:85454.68 (46.2%) stddev-sans-first:85619.71 17:10:45 INFO - PROCESS | 6429 | Values: 538.2 541.3 556.0 567.4 568.0 28966.6 29430.7 38742.2 39379.0 39437.0 43570.6 44182.3 44299.6 44300.8 44323.3 7602.1 8726.7 8900.1 8904.6 8915.1 7767.6 7867.0 10125.2 10333.4 10344.3 10139.3 10239.7 10240.1 10247.1 10261.5 7705.9 7887.3 10016.7 10169.7 10192.2 7563.8 10147.8 10349.3 10380.1 10382.9 37063.8 37289.8 37506.2 37528.0 37549.8 3284.5 3299.4 3327.5 3376.6 3705.2 27925.4 28268.2 28383.6 29015.1 29626.0 3930.6 3964.4 4003.8 4007.7 4102.7 278438.0 278910.0 280809.0 280837.0 281961.0 53183.2 54139.5 58750.0 59256.1 59462.7 53321.7 53368.0 53615.0 53626.7 53702.2 14993.6 15301.9 15308.4 15321.5 15329.8 11697.4 11824.1 11827.3 11829.2 11838.3 19099.3 19276.0 19347.9 19348.5 19433.2 7358.2 7750.5 7754.4 7764.5 7766.7 928.3 995.0 1043.5 1059.9 1104.8 27986.3 28377.2 28469.4 28588.9 29082.3 1064.5 1079.0 1097.0 1115.7 1193.1 14647.9 14702.4 14738.4 14876.5 14923.7 336194.0 341086.0 341445.0 341823.0 342673.0 52680.5 53091.5 53285.7 53342.0 53391.7 1330.6 1342.0 1361.1 1362.6 1366.9 25949.5 27759.9 27831.9 28251.3 28323.4 40557.5 41622.4 41664.4 41683.2 41702.6 277567.0 285918.0 384122.0 393192.0 394557.0 29165.6 29409.6 29414.7 29417.1 29429.1 39317.0 40810.4 41236.4 41264.4 41568.4 33496.8 34137.0 34205.1 34401.0 34737.7 34989.0 35054.3 35563.0 35698.8 35742.3 34959.7 35075.5 35244.8 35942.3 36854.3 27627.3 30459.4 30757.8 30789.7 30792.2 24541.5 24734.9 24984.9 25635.9 26264.3 17:10:45 INFO - PROCESS | 6429 | 17:10:45 INFO - PROCESS | 6429 | [#2] jquery.html Cycles:180 Average:30569.87 Median:36342.73 stddev:99487.85 (273.7%) stddev-sans-first:99741.07 17:10:45 INFO - PROCESS | 6429 | Values: 355.7 361.0 361.2 363.5 366.9 14187.6 14539.8 16117.5 16211.8 16904.3 14389.6 15051.5 15079.0 15087.2 16682.5 5388.9 5502.1 5507.5 5511.2 5520.7 4045.0 4176.6 5382.2 5436.1 5961.1 5974.7 6006.5 6046.7 6052.8 6069.0 5207.7 5333.6 5382.0 5393.6 6013.2 5132.9 5138.9 5140.7 5159.2 5179.5 12583.1 12709.6 16445.9 18917.2 19539.7 2036.8 2068.6 2151.0 2166.6 2187.8 9167.9 9289.3 9301.2 9586.9 9601.3 1765.8 1780.6 1799.4 1816.5 1827.7 59125.8 59693.0 60318.7 62810.4 63750.0 10407.9 10408.6 10436.9 10451.4 10481.6 13636.1 13650.9 13675.3 13681.3 13682.4 6870.3 7086.8 7096.8 7102.6 7152.7 6738.4 6764.0 6776.7 6812.0 6816.4 4130.5 4164.9 4275.4 4276.2 4279.9 1771.4 1802.1 1807.8 1815.9 1842.9 921.5 923.1 937.4 957.8 993.2 15854.4 16966.5 17631.9 17950.7 18031.6 877.3 970.3 982.1 1054.3 1058.2 9534.8 9863.4 10117.5 10125.5 10147.5 591929.0 604956.0 609434.0 618886.0 619286.0 78575.0 80040.6 80100.0 80477.0 82876.6 1172.8 1176.3 1207.4 1209.3 1232.6 15739.7 15833.4 15876.6 16096.3 16106.0 36052.3 36326.8 36358.6 36859.4 37152.4 47362.0 49192.5 49492.5 49497.0 50462.2 9170.4 9265.2 9293.2 9313.3 9392.2 11261.4 11340.1 11486.0 12388.9 17546.7 11072.5 12627.4 14017.4 14363.4 14494.1 11416.6 13672.3 13942.3 14223.4 15011.9 13981.2 14440.7 14450.9 14583.3 14740.1 9314.4 9456.4 9489.8 9625.8 9679.8 10670.3 13208.7 13255.3 14499.3 14957.6 17:10:45 INFO - PROCESS | 6429 | 17:10:45 INFO - PROCESS | 6429 | [#3] mootools.html Cycles:180 Average:5112.30 Median:6344.07 stddev:2581.78 (40.7%) stddev-sans-first:2573.00 17:10:45 INFO - PROCESS | 6429 | Values: 1286.2 1429.8 1431.7 1567.9 1728.1 6577.2 7070.2 7218.0 7233.5 7235.2 6896.1 7036.8 7079.2 7091.5 7105.3 1950.3 1994.9 1995.3 2195.1 2237.4 2000.3 2007.3 2197.5 2246.5 2248.5 2180.4 2211.9 2213.9 2215.1 2231.0 1947.4 1991.5 2237.7 2262.5 2264.3 2203.3 2257.7 2259.9 2261.2 2261.5 7081.6 7147.7 7160.5 7161.2 7161.5 4327.4 4418.8 4421.7 4429.0 4439.4 2772.7 2884.3 2890.5 2898.8 2910.3 928.6 934.6 941.4 942.0 979.4 9608.2 9624.2 9661.5 9675.9 9715.4 3971.6 4006.8 4036.1 4046.2 4153.6 8105.5 8124.0 8142.3 8147.3 8157.2 4551.2 4585.9 4591.7 4592.9 4596.1 4148.5 4173.5 4188.6 4199.9 4211.9 3320.9 3332.6 3354.0 3366.1 3386.4 1045.4 1061.6 1064.3 1065.2 1079.2 1111.9 1136.6 1140.5 1164.5 1212.8 6905.9 6954.9 6980.2 6986.5 6987.3 1094.7 1119.1 1138.0 1139.6 1140.3 5259.2 5343.9 5361.3 5617.7 5728.9 8173.8 8181.9 8361.9 8375.2 8400.2 8540.4 8546.0 8588.3 8643.9 8672.8 6932.1 6961.7 6989.0 7029.8 7039.5 6856.0 7007.2 7018.8 7020.7 7032.8 7656.9 7891.9 7898.8 7922.6 7955.4 7939.5 8138.1 8146.5 8167.0 8295.3 6340.0 6348.1 6425.0 6426.3 6433.4 6861.6 6878.1 6956.3 6963.8 7181.9 6573.9 6626.8 6681.1 6722.9 6743.7 6389.9 6560.4 6626.6 6655.3 6736.0 6603.1 6639.3 6640.9 6647.0 6650.5 6080.5 6128.4 6134.8 6135.8 6136.1 6158.3 6302.7 6311.1 6312.2 6312.7 17:10:45 INFO - PROCESS | 6429 | 17:10:45 INFO - PROCESS | 6429 | [#4] prototype.html Cycles:180 Average:5309.04 Median:5891.28 stddev:1573.50 (26.7%) stddev-sans-first:1533.22 17:10:45 INFO - PROCESS | 6429 | Values: 347.8 349.8 352.2 353.0 353.1 5903.2 5930.9 5988.4 5994.4 6058.5 5616.2 5735.4 5764.8 5927.2 5929.5 4543.1 4550.5 4579.4 4586.7 4589.5 4549.0 4558.2 4571.0 4615.6 4616.5 4324.0 4444.4 4444.7 4552.0 4552.1 4521.3 4524.2 4525.1 4526.3 4546.5 4048.1 4065.6 4067.8 4069.4 4083.5 5684.5 5691.9 5695.5 5701.2 5703.9 5224.5 5392.2 5395.9 5407.3 5408.3 6328.4 6338.7 6343.9 6348.0 6353.1 4547.8 4550.0 4552.6 4556.0 4557.8 6444.0 6532.7 6596.9 6601.6 6613.3 4656.4 4660.5 4664.7 4668.0 4668.1 4729.0 4731.4 4731.6 4732.1 4737.2 5363.8 5380.8 5386.5 5387.1 5393.0 6102.3 6356.5 6358.7 6375.9 6377.8 1647.3 1670.3 1670.6 1671.1 1671.6 1134.3 1137.1 1140.4 1151.0 1168.3 5854.6 5870.1 5877.6 5881.5 5901.8 6486.6 6496.7 6504.6 6508.6 6511.1 5735.3 5848.4 5850.5 5887.5 5895.1 3295.7 3472.4 3507.8 3520.5 3521.4 6632.9 6646.2 6798.6 6812.3 6816.9 6750.3 6752.3 6755.5 6755.6 6756.0 6615.7 6784.7 6786.6 6788.7 6807.1 6546.8 6547.8 6553.6 6556.0 6557.0 6445.2 6460.0 6485.2 6487.0 6499.3 6571.9 6716.7 6757.6 6761.4 6767.6 4589.4 4590.7 4593.6 4598.0 4599.7 6546.8 6553.0 6556.3 6558.8 6564.7 6219.8 6362.7 6390.5 6391.1 6397.0 6369.3 6380.4 6383.1 6383.7 6389.0 6253.1 6256.7 6263.9 6272.6 6274.3 6149.5 6203.2 6252.8 6341.9 6409.9 6244.3 6244.8 6292.7 6297.6 6299.9 17:10:45 INFO - PROCESS | 6429 | 17:10:45 INFO - PROCESS | 6429 | [#5] yui.html Cycles:180 Average:13916.89 Median:48091.76 stddev:16559.33 (34.4%) stddev-sans-first:16576.24 17:10:45 INFO - PROCESS | 6429 | Values: 745.3 760.6 812.9 815.7 829.3 13330.8 13489.4 13522.8 13529.3 13539.7 12553.9 12651.7 14095.6 14610.0 14650.6 678.0 683.6 805.6 816.7 817.8 789.6 798.7 804.9 805.0 805.4 849.0 854.5 855.2 856.0 856.3 682.2 688.2 823.5 838.9 839.7 613.7 614.3 614.6 614.8 614.8 13280.9 13477.4 13479.3 13525.6 13559.1 11612.1 12123.9 12212.6 12416.0 12581.7 10295.8 10453.5 10465.8 10591.2 10719.7 3593.4 3642.9 3652.0 3693.2 3763.4 47545.8 47622.8 47816.3 48162.5 48378.8 9017.2 9065.4 9282.9 9294.5 9343.8 17342.5 17356.5 17386.7 17391.4 17401.7 6897.3 7164.1 7186.0 7239.4 7242.5 3976.7 4016.7 4054.3 4158.9 4166.9 2917.3 2939.0 2947.5 2973.7 2976.1 549.4 551.7 569.0 577.4 578.9 540.8 547.4 552.7 612.7 623.4 7375.9 7865.5 8034.6 8059.2 8183.8 598.1 635.2 637.8 641.5 679.4 3618.1 3624.9 3737.3 3772.1 3801.9 56359.0 61513.7 61803.7 61821.4 62001.4 51569.5 52289.2 52820.0 52936.5 52938.7 45072.5 45966.5 48078.8 48269.8 48446.5 8277.7 8291.7 8512.6 8515.7 8615.7 36184.0 36830.0 36841.4 36876.6 37953.8 45901.0 46900.3 46953.3 47441.0 48104.8 10639.4 10897.0 10924.3 11132.9 11465.5 11444.7 11537.4 11541.7 11899.3 12089.7 10763.8 10832.8 10961.7 11031.6 11348.9 11239.8 11456.3 11557.7 11842.0 11904.2 6641.6 9914.2 10470.6 10512.5 11170.6 9692.3 9900.5 10044.7 10200.3 10200.7 9193.4 9366.0 9521.3 9557.3 9725.7 17:10:45 INFO - PROCESS | 6429 | -------- Summary: end -------- 17:10:45 INFO - PROCESS | 6429 | 17:10:46 INFO - TEST-INFO | 6429: exit 0 17:10:46 INFO - TEST-OK | dromaeo_css | took 1113267ms 17:10:46 INFO - TEST-START | kraken 17:10:46 INFO - operating with platform_type : linux_ 17:10:46 INFO - Initialising browser for kraken test... 17:10:46 INFO - TEST-INFO | started process 6615 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ9YFCl/profile http://localhost:42102/getInfo.html) 17:10:49 INFO - PROCESS | 6615 | __metrics Screen width/height:1600/1200 17:10:49 INFO - PROCESS | 6615 | colorDepth:24 17:10:49 INFO - PROCESS | 6615 | Browser inner width/height: 1024/697 17:10:49 INFO - PROCESS | 6615 | __metrics 17:10:50 INFO - PROCESS | 6615 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:10:50 INFO - PROCESS | 6615 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:10:51 INFO - TEST-INFO | 6615: exit 0 17:10:51 INFO - Browser initialized. 17:10:51 INFO - Running cycle 1/1 for kraken test... 17:10:51 INFO - TEST-INFO | started process 6696 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ9YFCl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:02 INFO - PROCESS | 6696 | RSS: Main: 149987328 17:11:02 INFO - PROCESS | 6696 | 17:11:05 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42102/tests/kraken/driver.html?testName=audio-beat-detection) 17:11:06 INFO - PROCESS | 6696 | RSS: Main: 183529472 17:11:06 INFO - PROCESS | 6696 | 17:11:08 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42102/tests/kraken/driver.html?testName=audio-dft) 17:11:09 INFO - PROCESS | 6696 | RSS: Main: 172736512 17:11:09 INFO - PROCESS | 6696 | 17:11:12 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42102/tests/kraken/driver.html?testName=audio-fft) 17:11:12 INFO - PROCESS | 6696 | RSS: Main: 159383552 17:11:12 INFO - PROCESS | 6696 | 17:11:14 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42102/tests/kraken/driver.html?testName=audio-oscillator) 17:11:15 INFO - PROCESS | 6696 | RSS: Main: 161648640 17:11:15 INFO - PROCESS | 6696 | 17:11:17 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42102/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:11:18 INFO - PROCESS | 6696 | RSS: Main: 165498880 17:11:18 INFO - PROCESS | 6696 | 17:11:20 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42102/tests/kraken/driver.html?testName=imaging-darkroom) 17:11:21 INFO - PROCESS | 6696 | RSS: Main: 165629952 17:11:21 INFO - PROCESS | 6696 | 17:11:24 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42102/tests/kraken/driver.html?testName=imaging-desaturate) 17:11:25 INFO - PROCESS | 6696 | RSS: Main: 164077568 17:11:25 INFO - PROCESS | 6696 | 17:11:28 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42102/tests/kraken/driver.html?testName=json-parse-financial) 17:11:28 INFO - PROCESS | 6696 | RSS: Main: 164810752 17:11:28 INFO - PROCESS | 6696 | 17:11:30 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42102/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:11:30 INFO - PROCESS | 6696 | RSS: Main: 176517120 17:11:30 INFO - PROCESS | 6696 | 17:11:32 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42102/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:11:33 INFO - PROCESS | 6696 | RSS: Main: 172142592 17:11:33 INFO - PROCESS | 6696 | 17:11:35 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42102/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:11:35 INFO - PROCESS | 6696 | RSS: Main: 181354496 17:11:35 INFO - PROCESS | 6696 | 17:11:38 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:11:38 INFO - PROCESS | 6696 | RSS: Main: 190287872 17:11:38 INFO - PROCESS | 6696 | 17:11:41 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:11:42 INFO - PROCESS | 6696 | RSS: Main: 187752448 17:11:42 INFO - PROCESS | 6696 | 17:11:43 INFO - PROCESS | 6696 | Cycle 1(1): loaded http://localhost:42102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42102/tests/kraken/driver.html?testName=ai-astar) 17:11:44 INFO - PROCESS | 6696 | RSS: Main: 244719616 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | __start_tp_report 17:11:44 INFO - PROCESS | 6696 | _x_x_mozilla_page_load 17:11:44 INFO - PROCESS | 6696 | _x_x_mozilla_page_load_details 17:11:44 INFO - PROCESS | 6696 | |i|pagename|runs| 17:11:44 INFO - PROCESS | 6696 | |0;ai-astar;109;110;104;109;110;110;99;110;112;110 17:11:44 INFO - PROCESS | 6696 | |1;audio-beat-detection;152;123;152;162;132;145;149;128;170;135 17:11:44 INFO - PROCESS | 6696 | |2;audio-dft;162;159;160;161;161;163;160;163;161;161 17:11:44 INFO - PROCESS | 6696 | |3;audio-fft;74;74;85;101;71;71;71;95;90;72 17:11:44 INFO - PROCESS | 6696 | |4;audio-oscillator;97;96;140;96;97;96;141;96;96;139 17:11:44 INFO - PROCESS | 6696 | |5;imaging-gaussian-blur;109;114;109;110;110;109;110;109;109;109 17:11:44 INFO - PROCESS | 6696 | |6;imaging-darkroom;146;146;145;152;145;146;145;146;145;146 17:11:44 INFO - PROCESS | 6696 | |7;imaging-desaturate;95;96;96;95;95;96;95;96;96;95 17:11:44 INFO - PROCESS | 6696 | |8;json-parse-financial;60;58;58;58;59;59;59;68;57;58 17:11:44 INFO - PROCESS | 6696 | |9;json-stringify-tinderbox;69;70;67;69;69;70;68;68;68;68 17:11:44 INFO - PROCESS | 6696 | |10;stanford-crypto-aes;85;85;86;92;85;85;87;86;87;84 17:11:44 INFO - PROCESS | 6696 | |11;stanford-crypto-ccm;115;119;115;124;133;122;124;122;117;127 17:11:44 INFO - PROCESS | 6696 | |12;stanford-crypto-pbkdf2;151;144;164;152;151;150;155;153;151;141 17:11:44 INFO - PROCESS | 6696 | |13;stanford-crypto-sha256-iterative;66;67;66;67;68;68;67;68;68;66 17:11:44 INFO - PROCESS | 6696 | __end_tp_report 17:11:44 INFO - PROCESS | 6696 | __start_cc_report 17:11:44 INFO - PROCESS | 6696 | _x_x_mozilla_cycle_collect,932 17:11:44 INFO - PROCESS | 6696 | __end_cc_report 17:11:44 INFO - PROCESS | 6696 | __startTimestamp1451697104023__endTimestamp 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | ------- Summary: start ------- 17:11:44 INFO - PROCESS | 6696 | Number of tests: 14 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.86 (3.5%) stddev-sans-first:4.09 17:11:44 INFO - PROCESS | 6696 | Values: 109.0 110.0 104.0 109.0 110.0 110.0 99.0 110.0 112.0 110.0 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:150.50 stddev:15.16 (10.1%) stddev-sans-first:15.86 17:11:44 INFO - PROCESS | 6696 | Values: 152.0 123.0 152.0 162.0 132.0 145.0 149.0 128.0 170.0 135.0 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 17:11:44 INFO - PROCESS | 6696 | Values: 162.0 159.0 160.0 161.0 161.0 163.0 160.0 163.0 161.0 161.0 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#3] audio-fft Cycles:10 Average:80.40 Median:74.00 stddev:11.39 (15.4%) stddev-sans-first:11.85 17:11:44 INFO - PROCESS | 6696 | Values: 74.0 74.0 85.0 101.0 71.0 71.0 71.0 95.0 90.0 72.0 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:96.00 stddev:21.13 (22.0%) stddev-sans-first:21.92 17:11:44 INFO - PROCESS | 6696 | Values: 97.0 96.0 140.0 96.0 97.0 96.0 141.0 96.0 96.0 139.0 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:109.50 stddev:1.55 (1.4%) stddev-sans-first:1.62 17:11:44 INFO - PROCESS | 6696 | Values: 109.0 114.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:2.10 (1.4%) stddev-sans-first:2.22 17:11:44 INFO - PROCESS | 6696 | Values: 146.0 146.0 145.0 152.0 145.0 146.0 145.0 146.0 145.0 146.0 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:11:44 INFO - PROCESS | 6696 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:59.00 stddev:3.13 (5.3%) stddev-sans-first:3.32 17:11:44 INFO - PROCESS | 6696 | Values: 60.0 58.0 58.0 58.0 59.0 59.0 59.0 68.0 57.0 58.0 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 17:11:44 INFO - PROCESS | 6696 | Values: 69.0 70.0 67.0 69.0 69.0 70.0 68.0 68.0 68.0 68.0 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:2.25 (2.6%) stddev-sans-first:2.35 17:11:44 INFO - PROCESS | 6696 | Values: 85.0 85.0 86.0 92.0 85.0 85.0 87.0 86.0 87.0 84.0 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:123.00 stddev:5.63 (4.6%) stddev-sans-first:5.41 17:11:44 INFO - PROCESS | 6696 | Values: 115.0 119.0 115.0 124.0 133.0 122.0 124.0 122.0 117.0 127.0 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:151.50 stddev:6.14 (4.1%) stddev-sans-first:6.51 17:11:44 INFO - PROCESS | 6696 | Values: 151.0 144.0 164.0 152.0 151.0 150.0 155.0 153.0 151.0 141.0 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - PROCESS | 6696 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:0.88 (1.3%) stddev-sans-first:0.83 17:11:44 INFO - PROCESS | 6696 | Values: 66.0 67.0 66.0 67.0 68.0 68.0 67.0 68.0 68.0 66.0 17:11:44 INFO - PROCESS | 6696 | -------- Summary: end -------- 17:11:44 INFO - PROCESS | 6696 | 17:11:44 INFO - TEST-INFO | 6696: exit 0 17:11:44 INFO - TEST-OK | kraken | took 58593ms 17:11:44 INFO - TEST-START | v8_7 17:11:44 INFO - operating with platform_type : linux_ 17:11:44 INFO - Initialising browser for v8_7 test... 17:11:44 INFO - TEST-INFO | started process 6947 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnm0VRP/profile http://localhost:42102/getInfo.html) 17:11:48 INFO - PROCESS | 6947 | __metrics Screen width/height:1600/1200 17:11:48 INFO - PROCESS | 6947 | colorDepth:24 17:11:48 INFO - PROCESS | 6947 | Browser inner width/height: 1024/697 17:11:48 INFO - PROCESS | 6947 | __metrics 17:11:49 INFO - PROCESS | 6947 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:11:49 INFO - PROCESS | 6947 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:11:50 INFO - TEST-INFO | 6947: exit 0 17:11:50 INFO - Browser initialized. 17:11:50 INFO - Running cycle 1/1 for v8_7 test... 17:11:50 INFO - TEST-INFO | started process 7030 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnm0VRP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:01 INFO - PROCESS | 7030 | RSS: Main: 148918272 17:12:01 INFO - PROCESS | 7030 | 17:12:23 INFO - PROCESS | 7030 | Cycle 1(1): loaded http://localhost:42102/tests/v8_7/run.html (next: http://localhost:42102/tests/v8_7/run.html) 17:12:23 INFO - PROCESS | 7030 | RSS: Main: 613699584 17:12:23 INFO - PROCESS | 7030 | 17:12:23 INFO - PROCESS | 7030 | __start_tp_report 17:12:23 INFO - PROCESS | 7030 | _x_x_mozilla_page_load 17:12:23 INFO - PROCESS | 7030 | _x_x_mozilla_page_load_details 17:12:23 INFO - PROCESS | 7030 | |i|pagename|runs| 17:12:23 INFO - PROCESS | 7030 | |0;Richards;166.61112962345885 17:12:23 INFO - PROCESS | 7030 | |1;DeltaBlue;197.35543714229328 17:12:23 INFO - PROCESS | 7030 | |2;Encrypt;284.1716396703609 17:12:23 INFO - PROCESS | 7030 | |3;Decrypt;5159.79381443299 17:12:23 INFO - PROCESS | 7030 | |4;RayTrace;1138.9521640091116 17:12:23 INFO - PROCESS | 7030 | |5;Earley;798.2456140350877 17:12:23 INFO - PROCESS | 7030 | |6;Boyer;12292.682926829268 17:12:23 INFO - PROCESS | 7030 | |7;RegExp;25794.871794871793 17:12:23 INFO - PROCESS | 7030 | |8;Splay;655.5555555555555 17:12:23 INFO - PROCESS | 7030 | |9;NavierStokes;4854.368932038835 17:12:23 INFO - PROCESS | 7030 | __end_tp_report 17:12:23 INFO - PROCESS | 7030 | __startTimestamp1451697143469__endTimestamp 17:12:23 INFO - PROCESS | 7030 | 17:12:23 INFO - PROCESS | 7030 | ------- Summary: start ------- 17:12:23 INFO - PROCESS | 7030 | Number of tests: 10 17:12:23 INFO - PROCESS | 7030 | 17:12:23 INFO - PROCESS | 7030 | [#0] Richards Cycles:1 Average:166.61 Median:166.61 stddev:0.00 (0.0%) 17:12:23 INFO - PROCESS | 7030 | Values: 166.6 17:12:23 INFO - PROCESS | 7030 | 17:12:23 INFO - PROCESS | 7030 | [#1] DeltaBlue Cycles:1 Average:197.36 Median:197.36 stddev:0.00 (0.0%) 17:12:23 INFO - PROCESS | 7030 | Values: 197.4 17:12:23 INFO - PROCESS | 7030 | 17:12:23 INFO - PROCESS | 7030 | [#2] Encrypt Cycles:1 Average:284.17 Median:284.17 stddev:0.00 (0.0%) 17:12:23 INFO - PROCESS | 7030 | Values: 284.2 17:12:23 INFO - PROCESS | 7030 | 17:12:23 INFO - PROCESS | 7030 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 17:12:23 INFO - PROCESS | 7030 | Values: 5159.8 17:12:23 INFO - PROCESS | 7030 | 17:12:23 INFO - PROCESS | 7030 | [#4] RayTrace Cycles:1 Average:1138.95 Median:1138.95 stddev:0.00 (0.0%) 17:12:23 INFO - PROCESS | 7030 | Values: 1139.0 17:12:23 INFO - PROCESS | 7030 | 17:12:23 INFO - PROCESS | 7030 | [#5] Earley Cycles:1 Average:798.25 Median:798.25 stddev:0.00 (0.0%) 17:12:23 INFO - PROCESS | 7030 | Values: 798.2 17:12:23 INFO - PROCESS | 7030 | 17:12:23 INFO - PROCESS | 7030 | [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 17:12:23 INFO - PROCESS | 7030 | Values: 12292.7 17:12:23 INFO - PROCESS | 7030 | 17:12:23 INFO - PROCESS | 7030 | [#7] RegExp Cycles:1 Average:25794.87 Median:25794.87 stddev:0.00 (0.0%) 17:12:23 INFO - PROCESS | 7030 | Values: 25794.9 17:12:23 INFO - PROCESS | 7030 | 17:12:23 INFO - PROCESS | 7030 | [#8] Splay Cycles:1 Average:655.56 Median:655.56 stddev:0.00 (0.0%) 17:12:23 INFO - PROCESS | 7030 | Values: 655.6 17:12:23 INFO - PROCESS | 7030 | 17:12:23 INFO - PROCESS | 7030 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 17:12:23 INFO - PROCESS | 7030 | Values: 4854.4 17:12:23 INFO - PROCESS | 7030 | -------- Summary: end -------- 17:12:23 INFO - PROCESS | 7030 | 17:12:24 INFO - TEST-INFO | 7030: exit 0 17:12:24 INFO - TEST-OK | v8_7 | took 39470ms 17:12:24 INFO - SUITE-END | took 1211s 17:12:24 INFO - Completed test suite (00:20:11) 17:12:24 INFO - Working with test: dromaeo_css 17:12:24 INFO - Generating results file: dromaeo_css 17:12:24 INFO - Working with test: kraken 17:12:24 INFO - Generating results file: kraken 17:12:24 INFO - javascript benchmark 17:12:24 INFO - Working with test: v8_7 17:12:24 INFO - Generating results file: v8_7 17:12:24 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:12:24 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 17:12:24 INFO - process_Request line: dromaeo_css 6907.18 graph.html#tests=[[72,201,35]] 17:12:24 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:12:24 INFO - process_Request line: kraken 1509.80 graph.html#tests=[[232,201,35]] 17:12:24 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:12:24 INFO - process_Request line: v8_7 20648.49 graph.html#tests=[[230,201,35]] 17:12:24 INFO - RETURN: dromaeo_css: 6907.18 17:12:24 INFO - RETURN: kraken: 1509.80 17:12:24 INFO - RETURN: v8_7: 20648.49 17:12:24 INFO - javascript benchmark 17:12:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3067.29452225988, 3143.6227652681655, 3184.124365799405, 3195.5845740053787, 3208.1819136120293, 5224.21636754487, 5237.162054071349, 5251.86870328242, 5298.682079075254, 5313.760880760366, 5207.166853303473, 5304.549113325372, 5357.866053348658, 5359.758810853511, 5472.699001554923, 4879.975600121995, 4911.975440122803, 4978.178600530908, 5077.060743762416, 5083.0, 4938.135826230413, 5011.84964451067, 5037.093323201822, 5060.240963855433, 5072.163093089635, 4832.275158726184, 4892.779824907852, 4924.162892308298, 5021.648484606079, 5028.924566131511, 4953.529414705597, 4967.379077615298, 4974.577160941324, 4993.0263598598285, 5017.5985921126585, 4897.0, 4935.35840340757, 4948.1093403187415, 4964.503549645043, 4970.130227210224, 5136.280920671109, 5169.819056333048, 5256.710880901549, 5302.761375738101, 5357.08929481989, 5807.390224026501, 5808.186853840466, 5810.360860305363, 5814.418558144194, 5825.242718446575, 5812.709364531756, 5861.736221869984, 5868.4424979626865, 5893.499052580536, 5896.823095307148, 5230.686158830483, 5353.9196912046355, 5361.437049109865, 5362.034833729927, 5490.972545137249, 5992.460678538952, 6004.54965877561, 6014.278286605635, 6016.127661489059, 6019.337872833985, 5745.3105627324985, 5759.366469688331, 5761.711914404263, 5765.1640512125505, 5822.70886455684, 5667.263255776723, 5670.659760414388, 5819.563532735062, 5827.650340979555, 5847.415258474119, 5875.823725288248, 5885.087811389241, 5891.05743081105, 5893.941060589339, 5894.764209431574, 5883.646981181143, 5887.852803679943, 5891.793787217427, 5897.0, 5905.881882362329, 4346.130773845243, 4421.845235416745, 4446.044100518339, 4528.343390208402, 4532.637389008872, 3985.1830374773103, 4002.039510517513, 4005.839766409311, 4019.8191081401405, 4046.7976601169826, 5404.108322126884, 5408.45915408456, 5413.675179489164, 5415.0, 5433.2936718227165, 5758.74085666146, 5783.306003279549, 5815.273090863642, 5879.441453061952, 5880.235569375954, 5369.0, 5375.408705042442, 5398.785273313473, 5424.864378390572, 5427.402985671573, 5004.749762511859, 5012.072766538202, 5024.171011783015, 5028.220625803006, 5058.671186372874, 5761.48146666802, 5879.470847623735, 5880.941190588125, 6028.186194863637, 6041.335453100155, 5610.85972850682, 5620.4660557247, 5622.8313150605545, 5629.7748090077575, 5708.885822283614, 5916.556258280732, 5929.555283353679, 5931.3178984417345, 5939.613925094855, 5987.880242395215, 5632.324121105494, 5680.886382272249, 5732.742026608729, 5736.541076713769, 5740.1102829061565, 5814.505767009851, 5825.446582574648, 5851.21008663842, 5871.735771890189, 5911.674857882857, 5693.658380497183, 5704.229928959703, 5706.828795136153, 5743.569232307677, 5745.166950792028, 5554.305711786027, 5661.320641523043, 5669.4047125051275, 5703.230063941481, 5729.169270455677, 5579.609427340048, 5673.205751194919, 5676.403977582295, 5678.3186017678145, 5721.256236689203, 5623.662580245198, 5638.802641907513, 5641.576881733804, 5648.350439699487, 5655.7454914528125, 5469.288992430958, 5530.5022547970875, 5531.944680553143, 5625.409332020243, 5637.098064309691], "unit": "score", "name": "dojo.html", "value": 5344.503952703433}, {"lowerIsBetter": false, "replicates": [538.1846502548639, 541.2638811216747, 555.9520304226533, 567.3843879390861, 567.9574031947604, 28966.565501517467, 29430.70569294309, 38742.22515549691, 39379.015524611896, 39437.0, 43570.56429435705, 44182.33726494097, 44299.557004429946, 44300.77849610747, 44323.33514997278, 7602.125755538101, 8726.738197854074, 8900.065493123226, 8904.643814247422, 8915.108489151098, 7767.6116194190345, 7867.0, 10125.24060695447, 10333.431661258628, 10344.327618704798, 10139.290249682525, 10239.692809215736, 10240.078392944633, 10247.077763001329, 10261.486925653724, 7705.922940770577, 7887.290143887078, 10016.699499015042, 10169.745756356077, 10192.235582331356, 7563.810904727371, 10147.847782283272, 10349.327293725884, 10380.11768999636, 10382.9480852596, 37063.81468092669, 37289.81355093234, 37506.24987500262, 37528.0, 37549.81225093884, 3284.458064419368, 3299.3566254580364, 3327.5008748687646, 3376.6116896556964, 3705.184859330943, 27925.441491170266, 28268.151955441368, 28383.57424638632, 29015.12954611365, 29626.0, 3930.5872883347124, 3964.444977703124, 4003.819828107742, 4007.6593489553425, 4102.651274641659, 278438.0, 278910.0, 280809.0, 280837.0, 281961.0, 53183.20225196625, 54139.45860541344, 58750.0, 59256.11115833266, 59462.70268648629, 53321.73339133357, 53368.0, 53615.0, 53626.73186634042, 53702.19446708303, 14993.550193494213, 15301.923490382476, 15308.387664493519, 15321.540353789404, 15329.770053449207, 11697.356645384416, 11824.11319151067, 11827.349495777642, 11829.231099978473, 11838.289702617698, 19099.331523396613, 19276.0, 19347.903260483607, 19348.516287092934, 19433.22267109328, 7358.153812311546, 7750.534967901944, 7754.3796496280165, 7764.456488045896, 7766.728164514215, 928.2620316847987, 994.9652361543913, 1043.4834756795435, 1059.9046085852156, 1104.8232282834708, 27986.300342491195, 28377.164467252063, 28469.430611387656, 28588.857055714587, 29082.27294317659, 1064.499685147979, 1078.9749737749169, 1096.950637221327, 1115.6708770912437, 1193.1111322064944, 14647.853521464649, 14702.411903523953, 14738.410463581336, 14876.479323223635, 14923.701525969636, 336194.0, 341086.0, 341445.0, 341823.0, 342673.0, 52680.47319526756, 53091.46908530942, 53285.7335713319, 53342.0, 53391.73304133532, 1330.567565541203, 1341.9798703019462, 1361.1288775183693, 1362.6184668292894, 1366.8906487480979, 25949.48101037931, 27759.861200693867, 27831.860840695666, 28251.293717657223, 28323.43353132967, 40557.52473416169, 41622.37566436567, 41664.3750343739, 41683.166336673705, 41702.582974171084, 277567.0, 285918.0, 384122.0, 393192.0, 394557.0, 29165.562516561844, 29409.55885661674, 29414.705852942054, 29417.11748647544, 29429.117126485384, 39317.0, 40810.38784418296, 41236.38145427881, 41264.381034283906, 41568.376474352306, 33496.83251583727, 34137.0, 34205.14487137841, 34401.0, 34737.65262347344, 34989.0, 35054.29891402209, 35563.0, 35698.8215058923, 35742.285154296245, 34959.65040349666, 35075.473867891495, 35244.823775880956, 35942.28115437729, 36854.26291474102, 27627.309317266427, 30459.390812184076, 30757.846210768803, 30789.69210307958, 30792.23019424443, 24541.509169816145, 24734.876325618257, 24984.875075624506, 25635.871820640776, 26264.34339141537], "unit": "score", "name": "ext.html", "value": 18462.915922900236}, {"lowerIsBetter": false, "replicates": [355.7260909099993, 360.9675129238368, 361.17651754000855, 363.5292296476063, 366.92111196092833, 14187.574372768808, 14539.78190327146, 16117.516474505768, 16211.75682364764, 16904.323827046905, 14389.64025899353, 15051.473198438056, 15079.0, 15087.170205638686, 16682.499525014267, 5388.865278368033, 5502.064649009658, 5507.4767897049915, 5511.22842802008, 5520.696361700105, 4045.0, 4176.644985176264, 5382.165764306539, 5436.103042997901, 5961.076033214837, 5974.701264936757, 6006.519478441714, 6046.727897244635, 6052.848678783043, 6068.969655151718, 5207.661502002357, 5333.626646134772, 5382.0312343778105, 5393.622446428752, 6013.1581578579035, 5132.923006154911, 5138.922916156261, 5140.691558506502, 5159.2003239497935, 5179.456157103526, 12583.119181657288, 12709.618711438672, 16445.93101448414, 18917.24331026757, 19539.706904396444, 2036.775954644988, 2068.596623658387, 2151.019940293741, 2166.6100101981638, 2187.7702841201603, 9167.908320916773, 9289.30330225229, 9301.209397201179, 9586.90413095867, 9601.327907046509, 1765.8145894681002, 1780.563761878335, 1799.379214171109, 1816.5277027972822, 1827.7349784281205, 59125.791791861666, 59693.0, 60318.69840650768, 62810.37189628091, 63750.0, 10407.895921040845, 10408.5836566538, 10436.947815261026, 10451.372917624967, 10481.580736770597, 13636.113652612548, 13650.863491365159, 13675.31623418825, 13681.315934203449, 13682.384292706853, 6870.31296870309, 7086.822829429202, 7096.787096387116, 7102.644867756695, 7152.713891444284, 6738.427233685192, 6764.0, 6776.728930842711, 6812.046313516112, 6816.386525212754, 4130.504339479222, 4164.8542301019315, 4275.40144379787, 4276.187524370422, 4279.871603851827, 1771.4419957713278, 1802.1347904918346, 1807.8068474806828, 1815.872888897791, 1842.9039214120407, 921.4931787516839, 923.1460898668705, 937.386012162035, 957.8323793336139, 993.1806259835664, 15854.44509442187, 16966.491005269614, 17631.911840440716, 17950.730739038925, 18031.63936721258, 877.3156937588691, 970.2819913264275, 982.0719420148034, 1054.3357684658615, 1058.2486434631344, 9534.809303814023, 9863.40819550815, 10117.494125293706, 10125.544350504246, 10147.492625368703, 591929.0, 604956.0, 609434.0, 618886.0, 619286.0, 78575.0, 80040.5997970018, 80100.0, 80477.0, 82876.58561707153, 1172.8006238939402, 1176.300101439642, 1207.3600991474532, 1209.25026483579, 1232.6302109367155, 15739.68520629558, 15833.366665333719, 15876.603084922508, 16096.27566759522, 16106.0, 36052.27895442129, 36326.818365908, 36358.636413635526, 36859.44710829286, 37152.44271335986, 47362.0, 49192.508074920224, 49492.50507494879, 49497.0, 50462.2430663533, 9170.44977301364, 9265.166135047879, 9293.210077143518, 9313.25493960495, 9392.154706076486, 11261.380624065756, 11340.149488788538, 11486.0, 12388.938055309665, 17546.73679894828, 11072.501737421675, 12627.431765570755, 14017.439302427789, 14363.353649085608, 14494.05788623736, 11416.600418985296, 13672.316384180951, 13942.302884855513, 14223.431062757787, 15011.924940375666, 13981.161130332213, 14440.711185776436, 14450.927745361627, 14583.270836457923, 14740.11559306445, 9314.44113353201, 9456.432614043179, 9489.810203795747, 9625.807483850424, 9679.758006049906, 10670.253082284165, 13208.73582528325, 13255.337233138498, 14499.347529360994, 14957.551273461813], "unit": "score", "name": "jquery.html", "value": 8742.41645600696}, {"lowerIsBetter": false, "replicates": [1286.1575667937493, 1429.806976058232, 1431.6635590636201, 1567.8980866243694, 1728.0927513055651, 6577.210734711835, 7070.222275549691, 7218.025566548515, 7233.493655444121, 7235.204127545966, 6896.137982752156, 7036.753713620024, 7079.221285658587, 7091.468139889503, 7105.253948335428, 1950.3076407875212, 1994.8902810345426, 1995.3315639260866, 2195.1438938813835, 2237.429455488848, 2000.3298894870236, 2007.317512045904, 2197.4726065744267, 2246.4833088389682, 2248.4940888300166, 2180.3785921012513, 2211.9115235390564, 2213.8893055347166, 2215.1360969222014, 2231.0072017952016, 1947.4157752674141, 1991.541945352577, 2237.7202849643795, 2262.513559584689, 2264.30938563738, 2203.305958623029, 2257.683924250606, 2259.9322020339414, 2261.231181398316, 2261.457250259942, 7081.61051142187, 7147.749828755968, 7160.534565253294, 7161.176464706573, 7161.462890283197, 4327.3725309830215, 4418.779061046935, 4421.65139632412, 4429.047754732748, 4439.356293337481, 2772.6848081851676, 2884.278930267433, 2890.508613535704, 2898.811577247472, 2910.3306239565018, 928.6099838068028, 934.6261495401826, 941.3833938770116, 942.006183476432, 979.3976704326788, 9608.231341492663, 9624.181944534723, 9661.46861922594, 9675.854862177073, 9715.36850104741, 3971.62269584389, 4006.819693113817, 4036.051527891002, 4046.2109888572036, 4153.646940010072, 8105.513669179868, 8124.0, 8142.307903828122, 8147.348212143014, 8157.1842815717955, 4551.249043907785, 4585.862424127282, 4591.747453890068, 4592.931106033412, 4596.057808149321, 4148.502179738391, 4173.457450531411, 4188.560201178832, 4199.853005144866, 4211.894702632459, 3320.9169770755925, 3332.5669961916124, 3354.0, 3366.057503898863, 3386.407378708716, 1045.4354648489882, 1061.601899287767, 1064.302881612545, 1065.2277099103244, 1079.2121751121724, 1111.899929006377, 1136.63059505661, 1140.5437824870119, 1164.545827127421, 1212.7877621416217, 6905.861882762317, 6954.9304506955295, 6980.197277313073, 6986.54587451814, 6987.336203060701, 1094.6825420628088, 1119.1438549509633, 1137.9715507112223, 1139.566964553481, 1140.321508702321, 5259.237410575522, 5343.946560534345, 5361.276227709287, 5617.662940223599, 5728.914066289009, 8173.754787356389, 8181.877271840927, 8361.874571881426, 8375.20435558621, 8400.159984001551, 8540.402171848034, 8546.0, 8588.269997050196, 8643.876296081595, 8672.826543469095, 6932.133483314586, 6961.686724097428, 6989.0215369848265, 7029.789106326818, 7039.542429742153, 6855.965720171367, 7007.159140903124, 7018.754343598154, 7020.719171233093, 7032.753853615099, 7656.885146722692, 7891.921080789119, 7898.842023159619, 7922.643481043252, 7955.363570914429, 7939.483933544532, 8138.064122625737, 8146.470479419056, 8166.979127609049, 8295.294899933573, 6340.0, 6348.143000694847, 6425.0, 6426.325235850169, 6433.356664333529, 6861.588304701734, 6878.071460352789, 6956.2695916928, 6963.7562685305775, 7181.892271616034, 6573.901391479228, 6626.768063117768, 6681.1314529110905, 6722.899156512754, 6743.662816859235, 6389.9041514376395, 6560.376764207393, 6626.635535045619, 6655.334466553306, 6736.02327662496, 6603.141591593062, 6639.336066393322, 6640.900386494303, 6647.0, 6650.467962562887, 6080.48315893154, 6128.417800309142, 6134.754609815736, 6135.815925522242, 6136.079588061826, 6158.291796443287, 6302.653354065387, 6311.147995020613, 6312.210973628296, 6312.684365781601], "unit": "score", "name": "mootools.html", "value": 4231.720174363703}, {"lowerIsBetter": false, "replicates": [347.7687337920283, 349.8076058168008, 352.202261876849, 352.9594096678883, 353.1154458082503, 5903.173555702199, 5930.911036334458, 5988.431099045589, 5994.370591087938, 6058.545609079315, 5616.185653080301, 5735.397783232763, 5764.769409223626, 5927.229460170182, 5929.525637948965, 4543.1140927519145, 4550.499445061049, 4579.358889755437, 4586.656000799937, 4589.495155532889, 4549.021960278539, 4558.156741002925, 4570.97714511427, 4615.561521655437, 4616.492185859553, 4324.048709283952, 4444.444444444444, 4444.71109377891, 4551.9985603167415, 4552.08958208358, 4521.321801729734, 4524.2082635538645, 4525.072360166158, 4526.3210518422175, 4546.499885012646, 4048.068944142834, 4065.5527891931865, 4067.7559346439307, 4069.369247766601, 4083.509978802533, 5684.488396044335, 5691.886162276773, 5695.45893140151, 5701.230333904911, 5703.914441283384, 5224.451432599599, 5392.2181283714035, 5395.946040539584, 5407.270018547524, 5408.2698835657075, 6328.398802113792, 6338.668879535303, 6343.873122537523, 6347.96826015867, 6353.078803573502, 4547.840825571089, 4549.954500454986, 4552.590266875997, 4556.04323092151, 4557.840475583339, 6444.001179817136, 6532.738690452376, 6596.868062638769, 6601.63690996995, 6613.305602911673, 4656.3946686930485, 4660.5106463821485, 4664.720116793003, 4668.0, 4668.066386722669, 4728.976355118271, 4731.408573928259, 4731.621470282369, 4732.148213321566, 4737.170995075848, 5363.812266570651, 5380.78476860929, 5386.542143917733, 5387.111126664056, 5393.002294575437, 6102.267727872683, 6356.491480681534, 6358.713857876407, 6375.904361434582, 6377.808665740035, 1647.3163637090472, 1670.2650833633163, 1670.6241095753358, 1671.1393632279385, 1671.607172314505, 1134.2513940799197, 1137.1016896651552, 1140.4183866228118, 1150.9942450287863, 1168.3106966889407, 5854.590178687451, 5870.060790273621, 5877.588568800228, 5881.529477641864, 5901.793437229677, 6486.643234622141, 6496.740130394825, 6504.642244676588, 6508.60948343101, 6511.0558968949235, 5735.254416925773, 5848.385919478478, 5850.4788754923175, 5887.4701276884425, 5895.086261629454, 3295.736341092707, 3472.409690352646, 3507.8246087696025, 3520.4543295789194, 3521.3837578423672, 6632.905570580897, 6646.169228846395, 6798.626075565891, 6812.284710105368, 6816.863662726718, 6750.291219421988, 6752.324767523307, 6755.459563234929, 6755.560888542229, 6756.020377045399, 6615.676864627094, 6784.728610855609, 6786.558873673195, 6788.694508747119, 6807.115075040312, 6546.803595892131, 6547.803565893031, 6553.574017688835, 6555.967220163869, 6556.967215163893, 6445.1943507061615, 6460.0, 6485.189351331083, 6486.967565162144, 6499.3175716549085, 6571.934280657323, 6716.731330746716, 6757.594544327356, 6761.391474767294, 6767.560108592926, 4589.426321709786, 4590.678652494427, 4593.632509399307, 4598.0, 4599.724016559017, 6546.803595892131, 6553.049807777941, 6556.2788093308745, 6558.8360290993105, 6564.704588293443, 6219.844503887258, 6362.713677884599, 6390.52071094679, 6391.137196478416, 6396.968015159894, 6369.299377068426, 6380.393862583047, 6383.1382763326355, 6383.712732926937, 6388.96805515988, 6253.093301471352, 6256.718447669775, 6263.937360626335, 6272.6236425814595, 6274.278457977391, 6149.538784591263, 6203.193584833943, 6252.812415627538, 6341.90487142684, 6409.935900640934, 6244.313125556276, 6244.812655620339, 6292.748290068529, 6297.590656607306, 6299.905501417574], "unit": "score", "name": "prototype.html", "value": 4807.819730541535}, {"lowerIsBetter": false, "replicates": [745.3440971944688, 760.5550752809606, 812.854817579102, 815.7348861619975, 829.2826704900264, 13330.800037999437, 13489.39297731602, 13522.797158042637, 13529.323533823293, 13539.729205415886, 12553.937230313835, 12651.683707907285, 14095.577132686036, 14610.0, 14650.633734156652, 677.9525433219677, 683.6308393467522, 805.6012273924416, 816.6570040582969, 817.8037271054934, 789.6249281591226, 798.7084714079377, 804.9195080491933, 805.005817814998, 805.3919290935336, 848.9872651910226, 854.4659587757651, 855.1961156512858, 855.9743207703779, 856.2850020233113, 682.1575354437266, 688.1845013658831, 823.4812068396872, 838.8951381077366, 839.6641343462634, 613.7268915332679, 614.3089024847047, 614.6496496996714, 614.7694614519555, 614.8401415631968, 13280.867191328156, 13477.393517291745, 13479.258640774753, 13525.59423217305, 13559.118657287343, 11612.07103431732, 12123.93938030313, 12212.57255996036, 12416.0, 12581.709145427287, 10295.837376527143, 10453.47732613374, 10465.790684186273, 10591.205659575486, 10719.678409647722, 3593.389123848952, 3642.8907132786057, 3651.99570118217, 3693.169036966661, 3763.41667041609, 47545.76227118877, 47622.761886190696, 47816.28275575869, 48162.51837481615, 48378.75810620959, 9017.188453039258, 9065.41074830147, 9282.850956083084, 9294.488803115893, 9343.766405839908, 17342.479725608253, 17356.47930562085, 17386.65226695459, 17391.391301304393, 17401.65196696059, 6897.310268973062, 7164.140303163654, 7186.0, 7239.420846332281, 7242.49302548827, 3976.721629485966, 4016.7389119707127, 4054.2904991626347, 4158.875233742992, 4166.854160104382, 2917.329014326717, 2938.985305073461, 2947.4547208766016, 2973.717496837797, 2976.0922918510064, 549.4395716369281, 551.6745120378915, 568.9630174038674, 577.3591313641854, 578.8668606220593, 540.7647673262144, 547.3814589513823, 552.7402121003122, 612.6936531734133, 623.4077626255075, 7375.88936165958, 7865.528068315919, 8034.638441270157, 8059.153788852203, 8183.83632327362, 598.0849300570135, 635.2345423764353, 637.7831537277256, 641.5092454272485, 679.3512195852949, 3618.108453696498, 3624.9456258156147, 3737.3085979093953, 3772.07584141887, 3801.923961520754, 56359.0, 61513.69243153756, 61803.6909815448, 61821.38178618156, 62001.37998620046, 51569.48430515722, 52289.215661765105, 52820.0, 52936.47063529315, 52938.73530632322, 45072.54927450683, 45966.540334596226, 48078.759606202446, 48269.75865120722, 48446.5155348442, 8277.675571908465, 8291.709790157316, 8512.637977923503, 8515.659373624985, 8615.655373784979, 36184.0, 36830.0, 36841.447378289886, 36876.631233687316, 37953.81023094867, 45901.0, 46900.29649555191, 46953.2957005652, 47441.0, 48104.759476202395, 10639.361638301727, 10897.0, 10924.2899211551, 11132.944335278597, 11465.484053217791, 11444.713882153013, 11537.365444900612, 11541.653750387502, 11899.286042837457, 12089.697757556132, 10763.838542422027, 10832.837507437238, 10961.725956851142, 11031.558737650725, 11348.917904308848, 11239.775204496027, 11456.255343402652, 11557.653270401901, 11842.0, 11904.16670833068, 6641.601503909781, 9914.20686345105, 10470.633527826489, 10512.526936287732, 11170.553177872795, 9692.273079519206, 9900.504974751379, 10044.698659040241, 10200.28597998133, 10200.693979180636, 9193.402428842372, 9365.969743328365, 9521.333506654744, 9557.330986830855, 9725.708228753148], "unit": "score", "name": "yui.html", "value": 6186.68861136385}], "name": "dromaeo_css", "value": 6907.175409610279}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 109.0, 110.0, 110.0, 99.0, 110.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [152.0, 123.0, 152.0, 162.0, 132.0, 145.0, 149.0, 128.0, 170.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [162.0, 159.0, 160.0, 161.0, 161.0, 163.0, 160.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 85.0, 101.0, 71.0, 71.0, 71.0, 95.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 140.0, 96.0, 97.0, 96.0, 141.0, 96.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [109.0, 114.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 152.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 58.0, 58.0, 59.0, 59.0, 59.0, 68.0, 57.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 67.0, 69.0, 69.0, 70.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 92.0, 85.0, 85.0, 87.0, 86.0, 87.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [115.0, 119.0, 115.0, 124.0, 133.0, 122.0, 124.0, 122.0, 117.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [151.0, 144.0, 164.0, 152.0, 151.0, 150.0, 155.0, 153.0, 151.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 68.0, 68.0, 67.0, 68.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1509.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.61112962345885], "unit": "score", "name": "Richards", "value": 211.88260400000004}, {"lowerIsBetter": false, "replicates": [197.35543714229328], "unit": "score", "name": "DeltaBlue", "value": 335.019906}, {"lowerIsBetter": false, "replicates": [284.1716396703609], "unit": "score", "name": "Encrypt", "value": 936.6909390000004}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1138.9521640091116], "unit": "score", "name": "RayTrace", "value": 649.7103420000002}, {"lowerIsBetter": false, "replicates": [798.2456140350877], "unit": "score", "name": "Earley", "value": 834.909692307692}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [25794.871794871793], "unit": "score", "name": "RegExp", "value": 35.31651590457257}, {"lowerIsBetter": false, "replicates": [655.5555555555555], "unit": "score", "name": "Splay", "value": 124.30830508474578}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 20648.490127437246}]} 17:12:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20648.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1509.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6907.18"}}} 17:12:24 INFO - Return code: 0 17:12:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:12:24 INFO - # TBPL SUCCESS # 17:12:24 INFO - Running post-action listener: _resource_record_post_action 17:12:24 INFO - Running post-run listener: _resource_record_post_run 17:12:25 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 602112; Write bytes: 311123968; Read time: 120; Write time: 228596 17:12:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5500928; Read time: 0; Write time: 576 17:12:25 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 602112; Write bytes: 305623040; Read time: 120; Write time: 228020 17:12:25 INFO - Running post-run listener: _upload_blobber_files 17:12:25 INFO - Blob upload gear active. 17:12:25 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:12:25 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 17:12:25 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:12:25 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:12:26 INFO - (blobuploader) - INFO - Open directory for files ... 17:12:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:12:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:12:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:27 INFO - (blobuploader) - INFO - Done attempting. 17:12:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:12:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:12:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:27 INFO - (blobuploader) - INFO - Done attempting. 17:12:27 INFO - (blobuploader) - INFO - Iteration through files over. 17:12:27 INFO - Return code: 0 17:12:27 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:12:27 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:12:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5d5ff60fadfa8cb58c38dd8688d7820f80e90780816f3c21209fbdff504b2617294d724ad367c108d59fc1f304558229ff5c6cf9a936d86084f07e4eaefea0b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b2c42e2793878f4ea66761424384fb08ce62d6a2cd4964058aa0eea8fb0f0794c102b688f7415e91d7811286ead0da26cb6ce2eed9d6c61725ca907c4c0e485b"} 17:12:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:12:27 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:12:27 INFO - Contents: 17:12:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5d5ff60fadfa8cb58c38dd8688d7820f80e90780816f3c21209fbdff504b2617294d724ad367c108d59fc1f304558229ff5c6cf9a936d86084f07e4eaefea0b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b2c42e2793878f4ea66761424384fb08ce62d6a2cd4964058aa0eea8fb0f0794c102b688f7415e91d7811286ead0da26cb6ce2eed9d6c61725ca907c4c0e485b"} 17:12:27 INFO - Copying logs to upload dir... 17:12:27 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.095566 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-01 17:12:27.897951) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 17:12:27.901492) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5d5ff60fadfa8cb58c38dd8688d7820f80e90780816f3c21209fbdff504b2617294d724ad367c108d59fc1f304558229ff5c6cf9a936d86084f07e4eaefea0b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b2c42e2793878f4ea66761424384fb08ce62d6a2cd4964058aa0eea8fb0f0794c102b688f7415e91d7811286ead0da26cb6ce2eed9d6c61725ca907c4c0e485b"} build_url:https://queue.taskcluster.net/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/FJOVg79QS9OJ3iO-eXDd_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5d5ff60fadfa8cb58c38dd8688d7820f80e90780816f3c21209fbdff504b2617294d724ad367c108d59fc1f304558229ff5c6cf9a936d86084f07e4eaefea0b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b2c42e2793878f4ea66761424384fb08ce62d6a2cd4964058aa0eea8fb0f0794c102b688f7415e91d7811286ead0da26cb6ce2eed9d6c61725ca907c4c0e485b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 17:12:27.931050) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 17:12:27.931742) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1451695712.578593-797433282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 17:12:28.015119) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 17:12:28.015475) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 17:12:28.015790) ========= ========= Total master_lag: 0.37 =========