builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1451847929.16 results: success (0) buildid: 20160103083128 builduid: 61e94a1258974d3d882b532678ac008a revision: b260f4820958af1ed418c7e73cb47976f603a74a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.162605) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.163406) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.163936) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006307 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.221326) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.221920) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.270875) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.271498) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.325660) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.326229) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.327019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.327535) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-03 11:05:31-- 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% 220M=0s 2016-01-03 11:05:31 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177654 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.519195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.519564) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018301 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.569458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:29.569869) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev b260f4820958af1ed418c7e73cb47976f603a74a --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 b260f4820958af1ed418c7e73cb47976f603a74a --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=0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-03 11:05:31,699 truncating revision to first 12 chars 2016-01-03 11:05:31,699 Setting DEBUG logging. 2016-01-03 11:05:31,699 attempt 1/10 2016-01-03 11:05:31,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/b260f4820958?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-03 11:05:32,069 unpacking tar archive at: b2g-inbound-b260f4820958/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630800 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:30.217820) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:30.218334) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:30.239815) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:30.240085) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-03 11:05:30.240482) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-03 11:05:30.240828) ========= /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=0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:05:32 INFO - MultiFileLogger online at 20160103 11:05:32 in /builds/slave/test-pgo 11:05:32 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 11:05:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:05:32 INFO - {'append_to_log': False, 11:05:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:05:32 INFO - 'blob_upload_branch': 'B2G-Inbound', 11:05:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:05:32 INFO - 'branch': 'B2G-Inbound', 11:05:32 INFO - 'buildbot_json_path': 'buildprops.json', 11:05:32 INFO - 'config_files': ('talos/linux_config.py',), 11:05:32 INFO - 'default_actions': ('clobber', 11:05:32 INFO - 'read-buildbot-config', 11:05:32 INFO - 'download-and-extract', 11:05:32 INFO - 'populate-webroot', 11:05:32 INFO - 'create-virtualenv', 11:05:32 INFO - 'install', 11:05:32 INFO - 'run-tests'), 11:05:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:05:32 INFO - 'download_minidump_stackwalk': True, 11:05:32 INFO - 'download_symbols': 'ondemand', 11:05:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:05:32 INFO - 'tooltool.py': '/tools/tooltool.py', 11:05:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:05:32 INFO - '/tools/misc-python/virtualenv.py')}, 11:05:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:05:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:05:32 INFO - 'installer_path': 'installer.exe', 11:05:32 INFO - 'log_level': 'info', 11:05:32 INFO - 'log_name': 'talos', 11:05:32 INFO - 'log_to_console': True, 11:05:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:05:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:05:32 INFO - 'opt_config_files': (), 11:05:32 INFO - 'pip_index': False, 11:05:32 INFO - 'sps_profile': False, 11:05:32 INFO - 'sps_profile_interval': 0, 11:05:32 INFO - 'suite': 'dromaeojs', 11:05:32 INFO - 'system_bits': '32', 11:05:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:05:32 INFO - 'title': 'talos-linux64-ix-056', 11:05:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:05:32 INFO - 'use_talos_json': True, 11:05:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:05:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:05:32 INFO - 'work_dir': 'build'} 11:05:32 INFO - ##### 11:05:32 INFO - ##### Running clobber step. 11:05:32 INFO - ##### 11:05:32 INFO - Running pre-action listener: _resource_record_pre_action 11:05:32 INFO - Running main action method: clobber 11:05:32 INFO - rmtree: /builds/slave/test-pgo/build 11:05:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:05:32 INFO - Running post-action listener: _resource_record_post_action 11:05:32 INFO - ##### 11:05:32 INFO - ##### Running read-buildbot-config step. 11:05:32 INFO - ##### 11:05:32 INFO - Running pre-action listener: _resource_record_pre_action 11:05:32 INFO - Running main action method: read_buildbot_config 11:05:32 INFO - Using buildbot properties: 11:05:32 INFO - { 11:05:32 INFO - "project": "", 11:05:32 INFO - "product": "firefox", 11:05:32 INFO - "script_repo_revision": "production", 11:05:32 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 11:05:32 INFO - "repository": "", 11:05:32 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 11:05:32 INFO - "buildid": "20160103083128", 11:05:32 INFO - "pgo_build": "True", 11:05:32 INFO - "basedir": "/builds/slave/test-pgo", 11:05:32 INFO - "buildnumber": 177, 11:05:32 INFO - "slavename": "talos-linux64-ix-056", 11:05:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:05:32 INFO - "platform": "ubuntu64_hw", 11:05:32 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 11:05:32 INFO - "branch": "b2g-inbound", 11:05:32 INFO - "repo_path": "integration/b2g-inbound", 11:05:32 INFO - "revision": "b260f4820958af1ed418c7e73cb47976f603a74a", 11:05:32 INFO - "stage_platform": "linux64-pgo", 11:05:32 INFO - "builduid": "61e94a1258974d3d882b532678ac008a", 11:05:32 INFO - "slavebuilddir": "test" 11:05:32 INFO - } 11:05:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:05:32 INFO - Running post-action listener: _resource_record_post_action 11:05:32 INFO - ##### 11:05:32 INFO - ##### Running download-and-extract step. 11:05:32 INFO - ##### 11:05:32 INFO - Running pre-action listener: _resource_record_pre_action 11:05:32 INFO - Running main action method: download_and_extract 11:05:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:32 INFO - https://queue.taskcluster.net/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:05:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/test_packages.json 11:05:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/test_packages.json 11:05:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:05:34 INFO - Downloaded 1302 bytes. 11:05:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:05:34 INFO - Using the following test package requirements: 11:05:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:05:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:05:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:34 INFO - u'jsshell-linux-x86_64.zip'], 11:05:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:05:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:05:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:05:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:05:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:05:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:05:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:05:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:05: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')]} 11:05:34 INFO - https://queue.taskcluster.net/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:05:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:05:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:05:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/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 11:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/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 11:05:36 INFO - Downloaded 23197960 bytes. 11:05:36 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 11:05:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:05:36 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 11:05:37 INFO - Return code: 0 11:05:37 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 11:05: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')]} 11:05:37 INFO - https://queue.taskcluster.net/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:05:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:05:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:05:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/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 11:05:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/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 11:05:38 INFO - Downloaded 23197960 bytes. 11:05:38 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 11:05:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:05:38 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 11:05:40 INFO - Return code: 0 11:05:40 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')]} 11:05:40 INFO - https://queue.taskcluster.net/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:05:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:05:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:05:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/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 11:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/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 11:05:41 INFO - Downloaded 11132285 bytes. 11:05:41 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 11:05:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:05:41 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 11:05:41 INFO - Return code: 0 11:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:41 INFO - https://queue.taskcluster.net/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:05:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:05:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:05:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/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 11:05:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/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 11:05:44 INFO - Downloaded 54989533 bytes. 11:05:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:05:44 INFO - mkdir: /builds/slave/test-pgo/properties 11:05:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:05:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:05:44 INFO - Contents: 11:05:44 INFO - build_url:https://queue.taskcluster.net/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:05:44 INFO - Running post-action listener: _resource_record_post_action 11:05:44 INFO - Running post-action listener: set_extra_try_arguments 11:05:44 INFO - ##### 11:05:44 INFO - ##### Running populate-webroot step. 11:05:44 INFO - ##### 11:05:44 INFO - Running pre-action listener: _resource_record_pre_action 11:05:44 INFO - Running main action method: populate_webroot 11:05:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:05:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:05:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:05:44 INFO - '--tppagecycles', 11:05:44 INFO - '7'], 11:05:44 INFO - 'tests': ['tsvgm']}}, 11:05:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:05:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:05:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:05:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:05:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:05:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:05:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:44 INFO - 'talos_options': ['--e10s'], 11:05:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:44 INFO - 'tests': ['damp', 'tps']}, 11:05:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:44 INFO - 'talos_options': ['--e10s'], 11:05:44 INFO - 'tests': ['damp', 'tps']}, 11:05:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:05:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:05:44 INFO - 'other': {'tests': ['a11yr', 11:05:44 INFO - 'ts_paint', 11:05:44 INFO - 'tpaint', 11:05:44 INFO - 'sessionrestore', 11:05:44 INFO - 'sessionrestore_no_auto_restore']}, 11:05:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:05:44 INFO - 'tests': ['a11yr', 11:05:44 INFO - 'ts_paint', 11:05:44 INFO - 'tpaint', 11:05:44 INFO - 'sessionrestore', 11:05:44 INFO - 'sessionrestore_no_auto_restore']}, 11:05:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:05:44 INFO - 'tests': ['a11yr', 11:05:44 INFO - 'ts_paint', 11:05:44 INFO - 'tpaint', 11:05:44 INFO - 'sessionrestore', 11:05:44 INFO - 'sessionrestore_no_auto_restore']}, 11:05:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:05:44 INFO - 'tests': ['a11yr', 11:05:44 INFO - 'ts_paint', 11:05:44 INFO - 'tpaint', 11:05:44 INFO - 'sessionrestore', 11:05:44 INFO - 'sessionrestore_no_auto_restore']}, 11:05:44 INFO - 'other_l64': {'tests': ['a11yr', 11:05:44 INFO - 'ts_paint', 11:05:44 INFO - 'tpaint', 11:05:44 INFO - 'sessionrestore', 11:05:44 INFO - 'sessionrestore_no_auto_restore']}, 11:05:44 INFO - 'other_nol64': {'tests': ['a11yr', 11:05:44 INFO - 'ts_paint', 11:05:44 INFO - 'tpaint', 11:05:44 INFO - 'sessionrestore', 11:05:44 INFO - 'sessionrestore_no_auto_restore']}, 11:05:44 INFO - 'svgr': {'tests': ['tsvgx', 11:05:44 INFO - 'tsvgr_opacity', 11:05:44 INFO - 'tart', 11:05:44 INFO - 'tscrollx', 11:05:44 INFO - 'cart']}, 11:05:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:05:44 INFO - 'tests': ['tsvgx', 11:05:44 INFO - 'tsvgr_opacity', 11:05:44 INFO - 'tart', 11:05:44 INFO - 'tscrollx', 11:05:44 INFO - 'cart']}, 11:05:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:44 INFO - 'tests': ['tp5o']}, 11:05:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:44 INFO - 'talos_options': ['--e10s'], 11:05:44 INFO - 'tests': ['tp5o']}, 11:05:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:44 INFO - 'talos_options': ['--xperf_path', 11:05:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:44 INFO - 'tests': ['tp5n']}, 11:05:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:44 INFO - 'talos_options': ['--e10s', 11:05:44 INFO - '--xperf_path', 11:05:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:44 INFO - 'tests': ['tp5n']}}, 11:05:44 INFO - 'talos.zip': {'path': '', 11:05:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:05:44 INFO - Running post-action listener: _resource_record_post_action 11:05:44 INFO - ##### 11:05:44 INFO - ##### Running create-virtualenv step. 11:05:44 INFO - ##### 11:05:44 INFO - Running pre-action listener: _resource_record_pre_action 11:05:44 INFO - Running main action method: create_virtualenv 11:05:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:05:44 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 11:05:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:05:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:05:44 INFO - Using real prefix '/usr' 11:05:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:05:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:05:46 INFO - Installing pip.................done. 11:05:46 INFO - Return code: 0 11:05:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:05: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')]} 11:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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')]} 11:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a08060f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f840>, '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 0x158c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158cb60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', '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 11:05:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:05:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:05:46 INFO - Using env: {'DISPLAY': ':0', 11:05:46 INFO - 'HOME': '/home/cltbld', 11:05:46 INFO - 'LANG': 'en_US.UTF-8', 11:05:46 INFO - 'LANGUAGE': 'en_US:en', 11:05:46 INFO - 'LOGNAME': 'cltbld', 11:05:46 INFO - 'MAIL': '/var/mail/cltbld', 11:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:46 INFO - 'MOZ_NO_REMOTE': '1', 11:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:46 INFO - 'NO_EM_RESTART': '1', 11:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:05:46 INFO - 'PWD': '/builds/slave/test-pgo', 11:05:46 INFO - 'SHELL': '/bin/bash', 11:05:46 INFO - 'SHLVL': '1', 11:05:46 INFO - 'TERM': 'linux', 11:05:46 INFO - 'TMOUT': '86400', 11:05:46 INFO - 'USER': 'cltbld', 11:05:46 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', 11:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:46 INFO - '_': '/tools/buildbot/bin/python'} 11:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:47 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 11:05:47 INFO - Cleaning up... 11:05:47 INFO - Return code: 0 11:05:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f8a08060f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f840>, '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 0x158c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158cb60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', '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 11:05:47 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 11:05:47 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 11:05:47 INFO - Using env: {'DISPLAY': ':0', 11:05:47 INFO - 'HOME': '/home/cltbld', 11:05:47 INFO - 'LANG': 'en_US.UTF-8', 11:05:47 INFO - 'LANGUAGE': 'en_US:en', 11:05:47 INFO - 'LOGNAME': 'cltbld', 11:05:47 INFO - 'MAIL': '/var/mail/cltbld', 11:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:47 INFO - 'MOZ_NO_REMOTE': '1', 11:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:47 INFO - 'NO_EM_RESTART': '1', 11:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:05:47 INFO - 'PWD': '/builds/slave/test-pgo', 11:05:47 INFO - 'SHELL': '/bin/bash', 11:05:47 INFO - 'SHLVL': '1', 11:05:47 INFO - 'TERM': 'linux', 11:05:47 INFO - 'TMOUT': '86400', 11:05:47 INFO - 'USER': 'cltbld', 11:05:47 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', 11:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:47 INFO - '_': '/tools/buildbot/bin/python'} 11:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:47 INFO - Downloading/unpacking psutil>=0.7.1 11:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:05:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:05:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:05:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:49 INFO - Installing collected packages: psutil 11:05:49 INFO - Running setup.py install for psutil 11:05:49 INFO - building 'psutil._psutil_linux' extension 11:05:49 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 11:05:49 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 11:05:49 INFO - building 'psutil._psutil_posix' extension 11:05:49 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 11:05:49 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 11:05:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:49 INFO - Successfully installed psutil 11:05:49 INFO - Cleaning up... 11:05:49 INFO - Return code: 0 11:05:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:49 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 0x7f8a08060f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f840>, '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 0x158c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158cb60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', '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 11:05:49 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 11:05:49 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 11:05:49 INFO - Using env: {'DISPLAY': ':0', 11:05:49 INFO - 'HOME': '/home/cltbld', 11:05:49 INFO - 'LANG': 'en_US.UTF-8', 11:05:49 INFO - 'LANGUAGE': 'en_US:en', 11:05:49 INFO - 'LOGNAME': 'cltbld', 11:05:49 INFO - 'MAIL': '/var/mail/cltbld', 11:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:49 INFO - 'MOZ_NO_REMOTE': '1', 11:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:49 INFO - 'NO_EM_RESTART': '1', 11:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:05:49 INFO - 'PWD': '/builds/slave/test-pgo', 11:05:49 INFO - 'SHELL': '/bin/bash', 11:05:49 INFO - 'SHLVL': '1', 11:05:49 INFO - 'TERM': 'linux', 11:05:49 INFO - 'TMOUT': '86400', 11:05:49 INFO - 'USER': 'cltbld', 11:05:49 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', 11:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:49 INFO - '_': '/tools/buildbot/bin/python'} 11:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:05:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:05:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:05:51 INFO - Installing collected packages: mozsystemmonitor 11:05:51 INFO - Running setup.py install for mozsystemmonitor 11:05:52 INFO - Successfully installed mozsystemmonitor 11:05:52 INFO - Cleaning up... 11:05:52 INFO - Return code: 0 11:05:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:05: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')]} 11:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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')]} 11:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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', '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 0x7f8a08060f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f840>, '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 0x158c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158cb60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', '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 11:05: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:05: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 blobuploader==1.2.4 11:05:52 INFO - Using env: {'DISPLAY': ':0', 11:05:52 INFO - 'HOME': '/home/cltbld', 11:05:52 INFO - 'LANG': 'en_US.UTF-8', 11:05:52 INFO - 'LANGUAGE': 'en_US:en', 11:05:52 INFO - 'LOGNAME': 'cltbld', 11:05:52 INFO - 'MAIL': '/var/mail/cltbld', 11:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:52 INFO - 'MOZ_NO_REMOTE': '1', 11:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:52 INFO - 'NO_EM_RESTART': '1', 11:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:05:52 INFO - 'PWD': '/builds/slave/test-pgo', 11:05:52 INFO - 'SHELL': '/bin/bash', 11:05:52 INFO - 'SHLVL': '1', 11:05:52 INFO - 'TERM': 'linux', 11:05:52 INFO - 'TMOUT': '86400', 11:05:52 INFO - 'USER': 'cltbld', 11:05:52 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', 11:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:52 INFO - '_': '/tools/buildbot/bin/python'} 11:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:53 INFO - Downloading blobuploader-1.2.4.tar.gz 11:05:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:05:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:05:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:05:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:05:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:54 INFO - Downloading docopt-0.6.1.tar.gz 11:05:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:05:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:05:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:05:54 INFO - Running setup.py install for blobuploader 11:05:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:05:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:05:54 INFO - Running setup.py install for requests 11:05:55 INFO - Running setup.py install for docopt 11:05:55 INFO - Successfully installed blobuploader requests docopt 11:05:55 INFO - Cleaning up... 11:05:55 INFO - Return code: 0 11:05:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:05:55 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')]} 11:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:55 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')]} 11:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:55 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 0x7f8a08060f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f840>, '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 0x158c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158cb60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', '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 11:05:55 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 11:05:55 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 11:05:55 INFO - Using env: {'DISPLAY': ':0', 11:05:55 INFO - 'HOME': '/home/cltbld', 11:05:55 INFO - 'LANG': 'en_US.UTF-8', 11:05:55 INFO - 'LANGUAGE': 'en_US:en', 11:05:55 INFO - 'LOGNAME': 'cltbld', 11:05:55 INFO - 'MAIL': '/var/mail/cltbld', 11:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:55 INFO - 'MOZ_NO_REMOTE': '1', 11:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:55 INFO - 'NO_EM_RESTART': '1', 11:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:05:55 INFO - 'PWD': '/builds/slave/test-pgo', 11:05:55 INFO - 'SHELL': '/bin/bash', 11:05:55 INFO - 'SHLVL': '1', 11:05:55 INFO - 'TERM': 'linux', 11:05:55 INFO - 'TMOUT': '86400', 11:05:55 INFO - 'USER': 'cltbld', 11:05:55 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', 11:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:55 INFO - '_': '/tools/buildbot/bin/python'} 11:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:05:55 INFO - Running setup.py (path:/tmp/pip-eIjcye-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:05:55 INFO - Running setup.py (path:/tmp/pip-KMyduP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:05:55 INFO - Running setup.py (path:/tmp/pip-D29FUQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:05:55 INFO - Running setup.py (path:/tmp/pip-V5I8my-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:05:55 INFO - Running setup.py (path:/tmp/pip-A1Qq2m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:05:55 INFO - Running setup.py (path:/tmp/pip-B70zo9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:05:55 INFO - Running setup.py (path:/tmp/pip-odz2eX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:05:55 INFO - Running setup.py (path:/tmp/pip-GZrlhJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:05:56 INFO - Running setup.py (path:/tmp/pip-9WmB24-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:05:56 INFO - Running setup.py (path:/tmp/pip-j50pCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:05:56 INFO - Running setup.py (path:/tmp/pip-sIvQk7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:05:56 INFO - Running setup.py (path:/tmp/pip-hz7xTU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:05:56 INFO - Running setup.py (path:/tmp/pip-35wp3V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:05:56 INFO - Running setup.py (path:/tmp/pip-6qvcvV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:05:56 INFO - Running setup.py (path:/tmp/pip-8cR70h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:05:56 INFO - Running setup.py (path:/tmp/pip-P5AJkr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:05:56 INFO - Running setup.py (path:/tmp/pip-aB58gD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:05:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:05:56 INFO - Running setup.py install for manifestparser 11:05:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:05:56 INFO - Running setup.py install for mozcrash 11:05:56 INFO - Running setup.py install for mozdebug 11:05:57 INFO - Running setup.py install for mozdevice 11:05:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:05:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:05:57 INFO - Running setup.py install for mozfile 11:05:57 INFO - Running setup.py install for mozhttpd 11:05:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:05:57 INFO - Running setup.py install for mozinfo 11:05:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:05:57 INFO - Running setup.py install for mozInstall 11:05:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:05:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:05:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:05:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:05:57 INFO - Running setup.py install for mozleak 11:05:57 INFO - Running setup.py install for mozlog 11:05:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:05:57 INFO - Running setup.py install for moznetwork 11:05:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:05:57 INFO - Running setup.py install for mozprocess 11:05:57 INFO - Running setup.py install for mozprofile 11:05:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:05:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:05:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:05:58 INFO - Running setup.py install for mozrunner 11:05:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:05:58 INFO - Running setup.py install for mozscreenshot 11:05:58 INFO - Running setup.py install for moztest 11:05:58 INFO - Running setup.py install for mozversion 11:05:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:05:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:05:58 INFO - Cleaning up... 11:05:58 INFO - Return code: 0 11:05:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f8a08060f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f840>, '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 0x158c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158cb60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', '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 11:05:58 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 11:05:58 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 11:05:58 INFO - Using env: {'DISPLAY': ':0', 11:05:58 INFO - 'HOME': '/home/cltbld', 11:05:58 INFO - 'LANG': 'en_US.UTF-8', 11:05:58 INFO - 'LANGUAGE': 'en_US:en', 11:05:58 INFO - 'LOGNAME': 'cltbld', 11:05:58 INFO - 'MAIL': '/var/mail/cltbld', 11:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:58 INFO - 'MOZ_NO_REMOTE': '1', 11:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:58 INFO - 'NO_EM_RESTART': '1', 11:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:05:58 INFO - 'PWD': '/builds/slave/test-pgo', 11:05:58 INFO - 'SHELL': '/bin/bash', 11:05:58 INFO - 'SHLVL': '1', 11:05:58 INFO - 'TERM': 'linux', 11:05:58 INFO - 'TMOUT': '86400', 11:05:58 INFO - 'USER': 'cltbld', 11:05:58 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', 11:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:58 INFO - '_': '/tools/buildbot/bin/python'} 11:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:05:58 INFO - Running setup.py (path:/tmp/pip-ibR69S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:05:58 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)) 11:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:05:58 INFO - Running setup.py (path:/tmp/pip-E5_Mfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:05:58 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)) 11:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:05:58 INFO - Running setup.py (path:/tmp/pip-RtslNV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:05:58 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)) 11:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:05:58 INFO - Running setup.py (path:/tmp/pip-RfJNnc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:05:59 INFO - Running setup.py (path:/tmp/pip-xWm5nC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:05:59 INFO - Running setup.py (path:/tmp/pip-eEhuzC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:05:59 INFO - Running setup.py (path:/tmp/pip-su6ROv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:05:59 INFO - Running setup.py (path:/tmp/pip-6JGk1F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:05:59 INFO - Running setup.py (path:/tmp/pip-YRePjl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:05:59 INFO - Running setup.py (path:/tmp/pip-8EnETf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:05:59 INFO - Running setup.py (path:/tmp/pip-r5DSRT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:05:59 INFO - Running setup.py (path:/tmp/pip-8wzuuT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:05:59 INFO - Running setup.py (path:/tmp/pip-wpr3G1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:05:59 INFO - Running setup.py (path:/tmp/pip-LUm_Xp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:05:59 INFO - Running setup.py (path:/tmp/pip-i8GT4S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:05:59 INFO - Running setup.py (path:/tmp/pip-N3urf_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:05:59 INFO - Running setup.py (path:/tmp/pip-F5VEAX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:06:00 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)) 11:06:00 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)) 11:06:00 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)) 11:06:00 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)) 11:06:00 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)) 11:06:00 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)) 11:06:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:01 INFO - Downloading blessings-1.5.1.tar.gz 11:06:01 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 11:06:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:06:01 INFO - Installing collected packages: blessings 11:06:01 INFO - Running setup.py install for blessings 11:06:01 INFO - Successfully installed blessings 11:06:01 INFO - Cleaning up... 11:06:01 INFO - Return code: 0 11:06:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:06:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:06:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:06:02 INFO - Reading from file tmpfile_stdout 11:06:02 INFO - Current package versions: 11:06:02 INFO - argparse == 1.2.1 11:06:02 INFO - blessings == 1.5.1 11:06:02 INFO - blobuploader == 1.2.4 11:06:02 INFO - docopt == 0.6.1 11:06:02 INFO - manifestparser == 1.1 11:06:02 INFO - mozInstall == 1.12 11:06:02 INFO - mozcrash == 0.16 11:06:02 INFO - mozdebug == 0.1 11:06:02 INFO - mozdevice == 0.47 11:06:02 INFO - mozfile == 1.2 11:06:02 INFO - mozhttpd == 0.7 11:06:02 INFO - mozinfo == 0.9 11:06:02 INFO - mozleak == 0.1 11:06:02 INFO - mozlog == 3.1 11:06:02 INFO - moznetwork == 0.27 11:06:02 INFO - mozprocess == 0.22 11:06:02 INFO - mozprofile == 0.28 11:06:02 INFO - mozrunner == 6.11 11:06:02 INFO - mozscreenshot == 0.1 11:06:02 INFO - mozsystemmonitor == 0.0 11:06:02 INFO - moztest == 0.7 11:06:02 INFO - mozversion == 1.4 11:06:02 INFO - psutil == 3.1.1 11:06:02 INFO - requests == 1.2.3 11:06:02 INFO - wsgiref == 0.1.2 11:06:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f8a08060f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f840>, '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 0x158c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158cb60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', '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 11:06:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 11:06:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 11:06:02 INFO - Using env: {'DISPLAY': ':0', 11:06:02 INFO - 'HOME': '/home/cltbld', 11:06:02 INFO - 'LANG': 'en_US.UTF-8', 11:06:02 INFO - 'LANGUAGE': 'en_US:en', 11:06:02 INFO - 'LOGNAME': 'cltbld', 11:06:02 INFO - 'MAIL': '/var/mail/cltbld', 11:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:02 INFO - 'MOZ_NO_REMOTE': '1', 11:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:02 INFO - 'NO_EM_RESTART': '1', 11:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:06:02 INFO - 'PWD': '/builds/slave/test-pgo', 11:06:02 INFO - 'SHELL': '/bin/bash', 11:06:02 INFO - 'SHLVL': '1', 11:06:02 INFO - 'TERM': 'linux', 11:06:02 INFO - 'TMOUT': '86400', 11:06:02 INFO - 'USER': 'cltbld', 11:06:02 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', 11:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:02 INFO - '_': '/tools/buildbot/bin/python'} 11:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:02 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)) 11:06:02 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)) 11:06:02 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)) 11:06:02 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)) 11:06:02 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)) 11:06:02 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)) 11:06:02 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)) 11:06:02 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)) 11:06:02 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)) 11:06:02 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)) 11:06:02 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)) 11:06:02 INFO - Cleaning up... 11:06:02 INFO - Return code: 0 11:06:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f8a08060f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f840>, '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 0x158c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158cb60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', '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 11:06:02 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 11:06:02 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 11:06:02 INFO - Using env: {'DISPLAY': ':0', 11:06:02 INFO - 'HOME': '/home/cltbld', 11:06:02 INFO - 'LANG': 'en_US.UTF-8', 11:06:02 INFO - 'LANGUAGE': 'en_US:en', 11:06:02 INFO - 'LOGNAME': 'cltbld', 11:06:02 INFO - 'MAIL': '/var/mail/cltbld', 11:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:02 INFO - 'MOZ_NO_REMOTE': '1', 11:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:02 INFO - 'NO_EM_RESTART': '1', 11:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:06:02 INFO - 'PWD': '/builds/slave/test-pgo', 11:06:02 INFO - 'SHELL': '/bin/bash', 11:06:02 INFO - 'SHLVL': '1', 11:06:02 INFO - 'TERM': 'linux', 11:06:02 INFO - 'TMOUT': '86400', 11:06:02 INFO - 'USER': 'cltbld', 11:06:02 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', 11:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:02 INFO - '_': '/tools/buildbot/bin/python'} 11:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:02 INFO - Downloading/unpacking jsonschema 11:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:06:04 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 11:06:04 INFO - Downloading/unpacking functools32 (from jsonschema) 11:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:06:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:06:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:06:04 INFO - warning: no files found matching '*.txt' 11:06:04 INFO - no previously-included directories found matching 'build' 11:06:04 INFO - no previously-included directories found matching 'dist' 11:06:04 INFO - no previously-included directories found matching '.git*' 11:06:04 INFO - Installing collected packages: jsonschema, functools32 11:06:04 INFO - Running setup.py install for functools32 11:06:04 INFO - warning: no files found matching '*.txt' 11:06:04 INFO - no previously-included directories found matching 'build' 11:06:04 INFO - no previously-included directories found matching 'dist' 11:06:04 INFO - no previously-included directories found matching '.git*' 11:06:04 INFO - Successfully installed jsonschema functools32 11:06:04 INFO - Cleaning up... 11:06:04 INFO - Return code: 0 11:06:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:06:04 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')]} 11:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:04 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')]} 11:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:04 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 0x7f8a08060f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f840>, '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 0x158c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158cb60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', '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 11:06:04 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 11:06:04 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 11:06:04 INFO - Using env: {'DISPLAY': ':0', 11:06:04 INFO - 'HOME': '/home/cltbld', 11:06:04 INFO - 'LANG': 'en_US.UTF-8', 11:06:04 INFO - 'LANGUAGE': 'en_US:en', 11:06:04 INFO - 'LOGNAME': 'cltbld', 11:06:04 INFO - 'MAIL': '/var/mail/cltbld', 11:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:04 INFO - 'MOZ_NO_REMOTE': '1', 11:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:04 INFO - 'NO_EM_RESTART': '1', 11:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:06:04 INFO - 'PWD': '/builds/slave/test-pgo', 11:06:04 INFO - 'SHELL': '/bin/bash', 11:06:04 INFO - 'SHLVL': '1', 11:06:04 INFO - 'TERM': 'linux', 11:06:04 INFO - 'TMOUT': '86400', 11:06:04 INFO - 'USER': 'cltbld', 11:06:04 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', 11:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:04 INFO - '_': '/tools/buildbot/bin/python'} 11:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:04 INFO - Downloading/unpacking flake8 11:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:06:06 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 11:06:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:06:06 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 11:06:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:07 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 11:06:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:06:07 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 11:06:07 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 11:06:07 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 11:06:07 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 11:06:07 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 11:06:07 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 11:06:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:06:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:06:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:06:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:06:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:06:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:06:07 INFO - no previously-included directories found matching 'docs/_build' 11:06:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:06:07 INFO - Running setup.py install for pep8 11:06:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:06:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:06:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:06:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:06:07 INFO - no previously-included directories found matching 'docs/_build' 11:06:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:06:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:06:07 INFO - Cleaning up... 11:06:07 INFO - Return code: 0 11:06:07 INFO - Running post-action listener: _resource_record_post_action 11:06:07 INFO - Running post-action listener: _start_resource_monitoring 11:06:07 INFO - Starting resource monitoring. 11:06:07 INFO - ##### 11:06:07 INFO - ##### Running install step. 11:06:07 INFO - ##### 11:06:07 INFO - Running pre-action listener: _resource_record_pre_action 11:06:07 INFO - Running main action method: install 11:06:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:06:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:06:07 INFO - Reading from file tmpfile_stdout 11:06:07 INFO - Detecting whether we're running mozinstall >=1.0... 11:06:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:06:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:06:07 INFO - Reading from file tmpfile_stdout 11:06:07 INFO - Output received: 11:06:07 INFO - Usage: mozinstall [options] installer 11:06:07 INFO - Options: 11:06:07 INFO - -h, --help show this help message and exit 11:06:07 INFO - -d DEST, --destination=DEST 11:06:07 INFO - Directory to install application into. [default: 11:06:07 INFO - "/builds/slave/test-pgo"] 11:06:07 INFO - --app=APP Application being installed. [default: firefox] 11:06:07 INFO - mkdir: /builds/slave/test-pgo/build/application 11:06:07 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'] 11:06:07 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 11:06:23 INFO - Reading from file tmpfile_stdout 11:06:23 INFO - Output received: 11:06:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:06:23 INFO - Running post-action listener: _resource_record_post_action 11:06:23 INFO - ##### 11:06:23 INFO - ##### Running run-tests step. 11:06:23 INFO - ##### 11:06:23 INFO - Running pre-action listener: _resource_record_pre_action 11:06:23 INFO - Running main action method: run_tests 11:06:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:06:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:06:23 INFO - Python 2.7.3 11:06:23 INFO - Return code: 0 11:06:23 INFO - grabbing minidump binary from tooltool 11:06: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')]} 11:06:23 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 0x161f840>, '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 0x158c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:06:23 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 11:06:23 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 11:06:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:06:23 INFO - Return code: 0 11:06:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:06:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:06:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:06:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:06:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:06:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:06:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:06:24 INFO - Return code: 0 11:06:24 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/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 11:06:24 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/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 11:06:24 INFO - Using env: {'DISPLAY': ':0', 11:06:24 INFO - 'HOME': '/home/cltbld', 11:06:24 INFO - 'LANG': 'en_US.UTF-8', 11:06:24 INFO - 'LANGUAGE': 'en_US:en', 11:06:24 INFO - 'LOGNAME': 'cltbld', 11:06:24 INFO - 'MAIL': '/var/mail/cltbld', 11:06:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:06:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:24 INFO - 'MOZ_NO_REMOTE': '1', 11:06:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:24 INFO - 'NO_EM_RESTART': '1', 11:06:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:06:24 INFO - 'PWD': '/builds/slave/test-pgo', 11:06:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:06:24 INFO - 'SHELL': '/bin/bash', 11:06:24 INFO - 'SHLVL': '1', 11:06:24 INFO - 'TERM': 'linux', 11:06:24 INFO - 'TMOUT': '86400', 11:06:24 INFO - 'USER': 'cltbld', 11:06:24 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759', 11:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:24 INFO - '_': '/tools/buildbot/bin/python'} 11:06:24 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/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 11:06:25 INFO - mozversion application_buildid: 20160103083128 11:06:25 INFO - mozversion application_changeset: b260f4820958af1ed418c7e73cb47976f603a74a 11:06:25 INFO - mozversion application_display_name: Nightly 11:06:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:06:25 INFO - mozversion application_name: Firefox 11:06:25 INFO - mozversion application_remotingname: firefox 11:06:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 11:06:25 INFO - mozversion application_vendor: Mozilla 11:06:25 INFO - mozversion application_version: 46.0a1 11:06:25 INFO - mozversion platform_buildid: 20160103083128 11:06:25 INFO - mozversion platform_changeset: b260f4820958af1ed418c7e73cb47976f603a74a 11:06:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 11:06:25 INFO - mozversion platform_version: 46.0a1 11:06:25 INFO - using testdate: 1451847985 11:06:25 INFO - actual date: 1451847985 11:06:25 INFO - starting webserver on 'localhost:42382' 11:06:25 INFO - SUITE-START | Running 3 tests 11:06:25 INFO - TEST-START | dromaeo_css 11:06:25 INFO - operating with platform_type : linux_ 11:06:25 INFO - Initialising browser for dromaeo_css test... 11:06:25 INFO - TEST-INFO | started process 4015 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUlsA9s/profile http://localhost:42382/getInfo.html) 11:06:29 INFO - PROCESS | 4015 | __metrics Screen width/height:1600/1200 11:06:29 INFO - PROCESS | 4015 | colorDepth:24 11:06:29 INFO - PROCESS | 4015 | Browser inner width/height: 1024/697 11:06:29 INFO - PROCESS | 4015 | __metrics 11:06:29 INFO - PROCESS | 4015 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:06:29 INFO - PROCESS | 4015 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:06:31 INFO - TEST-INFO | 4015: exit 0 11:06:31 INFO - Browser initialized. 11:06:31 INFO - Running cycle 1/1 for dromaeo_css test... 11:06:31 INFO - TEST-INFO | started process 4109 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUlsA9s/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:43 INFO - PROCESS | 4109 | RSS: Main: 149929984 11:06:43 INFO - PROCESS | 4109 | 11:07:34 INFO - PROCESS | 4109 | 1451848054799 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] 11:09:43 INFO - PROCESS | 4109 | Cycle 1(1): loaded http://localhost:42382/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42382/tests/dromaeo/cssquery-ext.html) 11:09:44 INFO - PROCESS | 4109 | RSS: Main: 279875584 11:09:44 INFO - PROCESS | 4109 | 11:12:47 INFO - PROCESS | 4109 | Cycle 1(1): loaded http://localhost:42382/tests/dromaeo/cssquery-ext.html (next: http://localhost:42382/tests/dromaeo/cssquery-jquery.html) 11:12:47 INFO - PROCESS | 4109 | RSS: Main: 236830720 11:12:47 INFO - PROCESS | 4109 | 11:15:49 INFO - PROCESS | 4109 | Cycle 1(1): loaded http://localhost:42382/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42382/tests/dromaeo/cssquery-mootools.html) 11:15:50 INFO - PROCESS | 4109 | RSS: Main: 230064128 11:15:50 INFO - PROCESS | 4109 | 11:18:52 INFO - PROCESS | 4109 | Cycle 1(1): loaded http://localhost:42382/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42382/tests/dromaeo/cssquery-prototype.html) 11:18:52 INFO - PROCESS | 4109 | RSS: Main: 217395200 11:18:52 INFO - PROCESS | 4109 | 11:21:55 INFO - PROCESS | 4109 | Cycle 1(1): loaded http://localhost:42382/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42382/tests/dromaeo/cssquery-yui.html) 11:21:55 INFO - PROCESS | 4109 | RSS: Main: 220676096 11:21:55 INFO - PROCESS | 4109 | 11:24:58 INFO - PROCESS | 4109 | Cycle 1(1): loaded http://localhost:42382/tests/dromaeo/cssquery-yui.html (next: http://localhost:42382/tests/dromaeo/cssquery-dojo.html) 11:24:58 INFO - PROCESS | 4109 | RSS: Main: 271945728 11:24:58 INFO - PROCESS | 4109 | 11:24:58 INFO - PROCESS | 4109 | __start_tp_report 11:24:58 INFO - PROCESS | 4109 | _x_x_mozilla_page_load 11:24:58 INFO - PROCESS | 4109 | _x_x_mozilla_page_load_details 11:24:58 INFO - PROCESS | 4109 | |i|pagename|runs| 11:24:58 INFO - PROCESS | 4109 | |0;dojo.html;3053.2672158681917;3118.8596513156904;3161.74706023518;3164.3671265746857;3182.5385319128736;5058.494150584949;5166.974165129169;5241.764120614572;5261.368635763713;5311.442298558649;5150.459201783806;5193.662411943221;5212.50481204285;5294.391145018324;5307.575393968483;4750.952490475085;4766.213574760169;4782.928256076144;4799.5680388765;4868.853934381974;4827.324174615556;4855.951440485603;4857.587105096053;4863.951360486385;4893.094777466163;4596.7931443085145;4693.718376897397;4723.385959825235;4775.880602984936;4777.307290442884;4783.856484305476;4813.638977076698;4817.759112044384;4825.806967721322;4852.320675105488;4751.691140075884;4781.474037855833;4797.040591881638;4800.3279540864305;4805.1590971579835;4893.632977526664;5030.798768049273;5045.142325804622;5101.948980510185;5157.896842063175;5580.107182850725;5647.858803529944;5654.03881340169;5657.9434205658235;5728.484436400744;5664.801731939362;5693.943060569382;5695.202671625976;5698.629589076697;5698.971505142447;5162.638615296931;5267.499587539178;5275.815346462856;5282.154855223146;5283.049051170826;5626.578006649518;5723.341815691166;5768.7692492300675;5772.076467765138;5778.508826749689;5538.75075621598;5539.889202215933;5543.7782488700805;5548.0845660465575;5549.667019978814;5463.945360546423;5523.7238138092935;5577.804776832872;5599.468050535193;5618.129189975561;5564.749586268627;5634.183043458757;5650.5479561634975;5651.265335506358;5682.602217844711;5514.393416724157;5589.860253493695;5598.356189038232;5599.80400685974;5601.159826026047;4316.827326906889;4333.111712099012;4370.759608221579;4371.431713877239;4396.098799746044;3895.0846551060476;3915.1973845362204;3923.4114882767244;3947.17109407022;3950.2692001979153;5263.631545791758;5270.7628156733035;5281.762320695578;5285.471452854761;5329.200619907045;5475.890482190334;5497.697626630574;5596.524295434933;5601.019821531216;5640.605157638925;5249.238860365225;5272.077386457355;5272.182811664198;5276.92084618731;5303.390110137307;4834.516548345207;4851.466338702739;4853.102176097434;4860.708357498491;4891.877703057381;5686.090225563973;5819.301683797971;5875.647461152259;5881.059030555176;5998.670073145931;5585.748641311232;5587.664740115606;5588;5588.888222235614;5608.495235428831;5801.3038435388025;5841.795537156179;5846.532277417711;5850.444207800252;5860;5444.8094316698725;5488.615796894179;5515;5560.610757246954;5611.410801865745;5616.494515493625;5625.409332020079;5627.268455100811;5629.549636029026;5633.267675202197;5393.43368946255;5432.782688692408;5479.506844384025;5485.369182543899;5535.308086489189;5456.372517160418;5458.235846981505;5475.09660905946;5572.024895643327;5572.91640625399;5388.488093631099;5399;5400.675959442446;5402.864928376822;5417.322834645669;5465.453454654503;5519.39286678457;5523.226748255167;5527.723613819373;5555.944440555542;5266.368035835724;5323.441038691037;5391.083515802245;5397.298351214317;5397.676139431646 11:24:58 INFO - PROCESS | 4109 | |1;ext.html;527.306591831741;530.4483337329177;543.8151028650258;562.344868228514;562.7298896529663;28736.13791586253;29452;35785;36408.453873191924;36465.63534364656;39380.60619393805;39775.80112099442;39819.800900995455;39890.40164397536;39959.20081598366;7353.411727061823;8362.665493380258;8517.446365986221;8518.148185181462;8542.402031857773;7362.300581444754;7469.887951680729;7470.178280389153;9943;10079.848802267936;9980.30137890348;10093.343932644391;10103.949480252588;10113.443760593165;10113.646022389217;9958.203343732484;10075.546600402999;10082.89917100827;10088.092071713545;10090.848637270446;7474.962625186839;7627.733029344002;10003.09972102507;10206.744831379201;10225.64210252645;36633.63366366329;36943.445848312294;37034.259314813826;37120.071998199994;37162.814185928895;3195.6325022622464;3208.1338038729414;3220.211048293183;3254.625718042432;3282.4419848625553;28057.29856753577;28437.289067773265;28512.28719282014;28600.998965036124;29266.8293268269;3715.1826598148364;3753.9812300938593;3783.5055153214325;3899.395593682984;3910.1202229498135;217614;219184;219305.90347048323;219342;219505;55176.172357414674;56890;58292.708536457896;60718;61821;57000;57128.42871571314;57372.71313643488;57408.71295643579;57433.42566574364;15843.287052082684;16116.919415402848;16129.258026135585;16130.838691613168;16137.757933631005;11360;11413.828792568118;11421.885781142248;11433;11547.884521154681;19975.101120449614;20017.099230534663;20241;20290.69563956542;20303.187872485232;7697.499662521918;7837.412194085467;7846.8430631387055;7953.2842044216295;7967.322777563972;975.9658411955547;1005.9698209053594;1018.9184865210914;1019.0777346501428;1040.7502199472071;28713.71286287152;28916.42167156645;29167.854160729486;29252.26869328241;30838.845805771278;942.0344147249125;961.5624890674726;962.485070487286;979.1579241852002;979.647326962293;13800;13933.860661393459;14099.295035248402;14105.294735263196;14176.787348189786;476577;483452;486481;487181;487423;49457.752711236215;49978.50021499811;50065.74967125141;50088.74955625198;50209.49790502121;1331.161368337941;1333.9132956358;1347.9326033698471;1348.4673553946136;1351.4526616720243;24282;30743.538846917763;30876.38247234998;30879.382412352075;31440;46204.53795462002;46937.76531117459;46960.7651961738;46961;46963.765181173876;227695;228933;229171;229459;229510;25974.350641233363;26288.737112628627;30331.545026825057;31101;31641.20896977594;37209.4418583716;37306.81346593249;38008.80995595004;38257.23485530218;38317.2336553273;33577;38852.41721374238;39025.8048709766;40446.59553404428;42718;32805.83597081999;37268.627313726516;37292.627073728916;37336.626633733315;38930.4160437588;36493.635063649024;37049.629503704615;37125.814370927976;38180.427293590066;38269.85190444291;31936.840315798272;32598.51102233516;33581;33680.15799605029;34724.47913281252;24063.759362406152;24115;24200.51598968046;24329.148479803123;26739.86630066837 11:24:58 INFO - PROCESS | 4109 | |2;jquery.html;357.7066805219719;360.8773017174161;363.282517028868;363.9581448133464;364.11520006384507;13577.117487363315;13701.862981370183;16458.91770541147;16601.833981660195;16973.40593079241;14637.853621463782;15408.84591154088;15708.293126809293;15722.213889305518;15742.685146297095;5154.793808247666;5274.05067087924;5279.234510995903;5283.577313814885;5286.762095705683;4014.9397759033636;4117.897052573695;5287.418383977779;5317.813876514323;5671.319441667006;5767.567432442563;5780.537556995451;5792.884142317151;5800.448957349066;5822.097574875901;5658.8019419320335;5777.653340799545;5821.796237131723;5830.096335068071;5836.766529338843;5134.691918484903;5139.871503212412;5151.716655583941;5155.175171972504;5158.948410515922;16831.579210519714;17691.557711057198;18275.360362387386;20144.194232230693;20145.697814532792;2152.418846911325;2209.2930262316067;2250.718660167479;2284.6001949658908;2300.988495057514;12468.376581170996;12663.176893501894;12681.492740290378;12681.93659031699;12754.936225318907;1802.315120254295;1830.2130084063847;1872.81271872813;1881.1252767463059;1927.4603111128765;54154.729226353615;57511;59113;59522.40477595212;59910;9394.577244024036;9531.952340238393;9671.951640241754;9722.513874306256;9858.929624778733;12633.873661263453;12678.492860285669;12681.175723577939;12689.682757931125;12690.746185076247;6994.4404447644065;7214.206437291894;7432.888506672404;7495.962520187364;7561.357284630758;7225.096862892138;7229.674664640103;7259.564426134449;7346.853062938818;7436.293552112541;4274.145170965757;4308.913821723548;4348.5216626171095;4375.212461756914;4381.627561657231;1704.1223769758585;1765.5409593505524;1770.8140645232322;1771.9911400443173;1823.3800507827136;746.9365103966115;832.1844592299459;838.5974732128491;952.3809523809579;967.2117224462041;15181.861360398014;15329.46346877854;15417.76657867368;15637.296321665552;15674.216289185495;852.4885068958575;854.5342788180333;884.2837301785574;885.4156256870434;964.1948972607951;9101.726948191565;9662.951685241529;9677.516124193902;9708.320417570701;9724.319297649237;493769;494452;529975.8826789722;530394;537932;74126.25873741193;75529.62235188788;76243.61878190574;76702.61648691833;78284;1103.051375816797;1113.2763703592568;1117.173291764105;1122.5341483284508;1148.3569201247328;14704.485343012942;14806.259687015821;15047.774283385977;15149.848501515286;15373.308201130752;31186.22034449157;31223.843880780452;32652.51021234636;32723.67276327206;36125.63874361328;38675.41986870143;38917.41623875701;39455.80272098621;39578.406323904586;41679.37480937849;9122;9215.400998935047;9443.905560944302;9542.188913942115;9545.904540954501;14940;16088;16280.18599070018;16752.078635675156;16811.159442028093;13501.324933753076;13820;13867.098638588459;14043.297835108;14398.928005359907;13477.78699917012;13503.662408439475;13675.658108547366;13693.520726774515;13994.580162595139;14218.217998010208;14230.92884535612;14663.340149693076;15056.397744090114;15112.715419189053;9269.67556135532;9426.434413935185;9460.148586627236;9551.0926461986;9561.569729362334;10075.09324160829;10786.838197426889;14352.56942291733;14418.639534011734;14586.854131458975 11:24:58 INFO - PROCESS | 4109 | |3;mootools.html;1311.8425788905333;1417.7944198091275;1424.5227848670695;1520.369046845559;1728.8703347248952;6415.871682566346;7280.4903656744045;7404.851902961937;7469.925300746991;7520.3983681305435;7278.708851645928;7497.437692173082;7510.136334321554;7511;7526.096868375803;2274.545090981806;2283.4177284792354;2291.9312420627407;2294.4149241943283;2302.0561569756405;2267.2971378872603;2309.8267629927736;2358.7523310052457;2366.2073205476186;2372.4424760181346;2260.9660855087186;2269.795718385345;2303.2399308228246;2313.479467119893;2324.837261391703;2283.931482055541;2286.771322867708;2314.826388020905;2314.93055208344;2319.431739223884;2327.0808030827898;2367.242482405631;2371.7272513660805;2372.3357459911253;2373.6202207646866;7496.437767167485;7534.8116297092465;7553.69785208591;7585.469017168801;7589.962050189769;4681.344611754357;4732.337472753818;4771.4512831024185;4771.522847715235;4772.6420518461255;2957.2902503399246;2967.9258018549494;3020.1694534003327;3026.530887712408;3044.360684256309;995.4375777685584;1002.1231422505308;1008.1229330482454;1013.4831236069584;1030.4487099401783;10549.578016879392;10594.576216951313;10609.681709548726;10612.787744245072;10628;4254.617084462413;4307.203167414038;4331.198728235287;4368.9126217476105;4369.4101296325225;8985.415947963493;9007.459552426875;9014;9033;9033.50315732641;4730.88172795676;4746;4752.310914917318;4779.259214821708;4781.043791241766;3833.252515759456;3883.4174873768598;4236.661067114624;4353.325234588644;4355.194289056535;3637.690796282293;3638.5451818522683;3678.5401824771902;3689.8339574719203;3725.5715592706642;1154.1689983212075;1183.148133343991;1183.1954271095738;1186.8160435132568;1196.246364790194;1302.6743314171458;1306.1640550047978;1332.094175960337;1332.593558964525;1336.4520546576052;7072.222055573883;7079.973403856412;7112.0754301940415;7173.426125910019;7179.353858152791;465.5786513205554;465.6786817096193;470.3368250766403;473.7157705376815;506.04357763826397;5474.945250547523;5519.448055194529;5549.472800083986;5551.694656793834;5561.054620714488;8977;9009.684661036832;9170.679026234184;9172.082791720775;9210.171084602283;9072.183503484586;9125.726228213165;9190.540472976325;9206.861897071549;9221.81556368869;7076.0801095857205;7108.289171082851;7134.821629459201;7154.069970903749;7189.281071892873;6923.5499692519825;6954.547954382949;7014.403775679124;7027.15674119109;7028.367446929801;8080.353571714131;8109.432339736398;8117.797055073434;8164.346852251687;8304.584770761317;8342.374321925758;8390.538520381439;8456.450330728483;8565.05784363707;8572.871406928776;6049.485793707584;6146.293176284606;6153.2000839890525;6368.87262254743;6708.295628959084;7162.176349719641;7190.388816950409;7201.531900426456;7249.275072492708;7256.383207427428;6674.666266686743;6808.761693340709;6850.828729281808;6877.793666190022;7070.116235470567;6797.048413222252;6809.319068093349;6850.520463567503;6884.5180837342905;6935.7225710971;6804.863902722017;6843.486738494533;6860.5197636164985;6873.072135261676;6934.687939042856;6334.398232167937;6366.77716279928;6369.45859601939;6370.203724534434;6375.458086062737;6384.3934826191435;6398.328175541501;6442.806715798533;6452.161219041494;6463.64449955257 11:24:58 INFO - PROCESS | 4109 | |4;prototype.html;342.547836855351;343.397337672385;346.0915097868098;349.4443834303457;350.9556831456764;5670.064439367499;5734.340550836655;5776.277965254343;5781.682007489587;5789.739461724222;5576.972115139429;5656.717164141797;5712.571557133211;5722.141678748179;5733.082706766918;4427.977860110703;4431.401760762305;4439.88900277494;4446.666500012496;4448.243798554237;4311.461067366579;4372.97813510932;4393.648508119359;4430.667699922503;4440.97779511102;4388.583084606973;4405.867823965286;4432.778361081949;4433.84481543146;4442.777861106948;4386.298192289234;4392.209402307567;4398.868033958986;4431.379606855043;4439.822407103712;3940.960590394088;3941.527016757979;3943.9014024649327;3948.1314110895555;3951.7826519541413;5343.225232341289;5465.699386533739;5466.699331536764;5487.890242195133;5537.058700021006;5126.410462796752;5127.461616530285;5130.51260130287;5137.792618734595;5150.716710580917;6095.207623009025;6101.511879049665;6102.786402475892;6102.8779424411705;6105.389461053904;3989.40158976153;4056.6146216109423;4156.023334516386;4220.514640816284;4246.596573325529;6237.750489980395;6299.464545513637;6300.149479820211;6305.180326557564;6306.842328941767;4319.416878721332;4328.350747387917;4332.1119170569955;4346.261135606955;4354.042110735633;4333.241682705514;4395.450568678915;4395.7362558246605;4395.890102747393;4402.691811573223;5008.398992120896;5047.924281135786;5050.873728156826;5056.165732654144;5081.771320290596;6055.697215139226;6061.030235162353;6062.545309101835;6063.120847477091;6073.605215661057;1542.367629271993;1548.2258870564717;1565.1704596563839;1565.2095691675631;1565.3190861975077;1016.4663551635302;1060.1995493402433;1060.48566445274;1064.584811923335;1089.8964598363143;5793.623414478046;5795.869805387909;5795.913061304083;5798.536117110621;5802.071668533014;6241.313455519889;6246.656433896089;6257.530685198537;6262.530310226751;6269.279032911182;5767.36558978512;5784.71076446176;5799.2460980073165;5802.65184088956;5804.65172089676;3264.0860559043504;3349.9665003349655;3362.7814192077435;3384.8476818543227;3392.6268110507826;6501.804945851632;6511.218653761579;6514.055461958084;6515.185601799775;6517.641529715911;6400.423961843457;6402.583832050902;6412.903806442907;6414.198225221848;6415.935840641627;6336.017917222838;6472.255690595548;6487.059376390397;6491.6954481159455;6501.2198536175965;6227.844303892439;6237.594556353823;6243.063540468785;6246.718897649707;6251.71867265965;6012.278526576839;6084.543659225487;6127.387261274015;6272.278687950761;6283.434490895841;6516.543841931209;6557;6560.8359791003695;6564.606123632598;6583;4393.428854248928;4397.472303323621;4397.692161548661;4399.142167277479;4399.626031787334;6189.597676151036;6240.7206522663655;6300.054991751274;6310.305866354605;6313.526485513513;6094.75620975156;6135.447809696971;6142.710030893562;6146.416090471398;6167;6137.877242455215;6139.877202456015;6148.231471066117;6152.630842149485;6161.537884658758;5837.591368604157;5964.105384192232;5984.1323008164445;5987.790427335022;5999.580029398075;6170.444659980623;6172.475339596184;6174.413430724074;6177;6190.2571691397325;5990.9700451497465;6022;6026.698665066817;6037.728302226498;6038.456538911519 11:24:58 INFO - PROCESS | 4109 | |5;yui.html;713.5718568858686;738.9889151662729;763.8510490454361;779.3657437860032;806.6732973145878;13564.593062208138;13769.449222031119;13817.723645527083;13825.516106936258;13839.930800345985;11406.973372396482;11547.422628868566;12841.101122921376;12933.805992910091;12947.676308092303;808.272554700771;814.5031530766228;814.9837003259961;816.5957850863831;818.1164342510075;822.1696086952192;822.761399194236;823.012385137834;825.2036784502953;826.6610689617258;863.8315528471951;865.1824026295153;865.5542395666206;867.1588559097696;867.7310033889482;856.6402111113347;858.4634603372892;862.0991064337782;863.3395452478859;873.1181506678237;626.9185005949244;630.2027934662656;632.0708558419162;638.0716058135401;642.7718160053207;12399.938000309941;12450.501979920793;12484.126111172221;12486.50053997839;12538.68653283666;10515.579376824919;10757.408342541157;11039.448027598668;11083.390413527253;11460.598879039277;10009.899901001043;10054.195664346835;10061.748456288578;10156.94921525395;10171.084602385821;3620.4207326827845;3643.398839191557;3648.21563363878;3680.392735198689;3785.867494637702;42944;43109.35335969963;44390.33414498785;46978.295325570485;47015.52984470146;9874;9913.752156196153;9926.602935882629;9943.502824858728;9992.700218993441;17352.47942561725;17422.56443588895;17633.118344083003;17838;17868.374606888698;6829.760958366433;6831.28271531492;6986;6989.685464154125;7028.578285302899;4173.31140361843;4187.330027195634;4197.664186865043;4217.97891010543;4240.279152544075;3051.969480305213;3084.722374986262;3086.1513083902105;3089;3089.1968088297203;554.5979165105347;560.4395604395604;561.1134407635925;563.9295088113986;566.6147020026422;539.3608573840012;548.9121740521498;595.1786534582335;631.766246488802;689.3726708695164;8257.669693212205;8310.958445207856;8523.872141917876;8586.87119693205;8988.10118988109;526.1896679114121;531.9707416092075;533.6184627991005;550.9366422861423;637.4740838808002;3860.613938606117;3913.471681323042;4005.679545636342;4096.672266218696;4127.938080928789;53849.1922621161;54589.727051365284;54650.45349546533;54812;55306.446935530934;45097.32354014692;46234;47421.762891185324;47795;48514.75742621264;48061.279080813816;48394.27408588874;48885;49742.25386619203;49973.25040124474;8248.670053197804;8505.23452889243;8625.223729864343;8953.28373730087;9062.365634405529;33711.22374511364;33719.325613487104;34524.654753452145;34822.30355392827;35276.29447411089;41607.79196104;42332.57667423409;42847.92880177896;45319.546804531536;45599;10774.784504309713;11015.889841101487;11078.279911806028;11127.944360278147;11544.249623774427;11077.390743509184;11565.768684626428;11608.30350178992;11975.580854670394;11989;10414.947925260325;10581.52383142745;10966.780664386828;11047;11352.602658906899;10900.890991089987;11316.15128865322;11381.772364552497;11415.143864210051;11760.823917608514;10579.36523808574;10996.23026388145;11028.22802403824;11413.885861141282;11540.192186546861;9619.951900240454;9678.370905891095;9745.561449734638;9769.755756106155;9808.264380171373;8517.403781735218;8997.32520060985;9052;9088.278147017167;9132 11:24:58 INFO - PROCESS | 4109 | __end_tp_report 11:24:58 INFO - PROCESS | 4109 | __start_cc_report 11:24:58 INFO - PROCESS | 4109 | _x_x_mozilla_cycle_collect,991 11:24:58 INFO - PROCESS | 4109 | __end_cc_report 11:24:58 INFO - PROCESS | 4109 | __startTimestamp1451849098494__endTimestamp 11:24:58 INFO - PROCESS | 4109 | 11:24:58 INFO - PROCESS | 4109 | ------- Summary: start ------- 11:24:58 INFO - PROCESS | 4109 | Number of tests: 6 11:24:58 INFO - PROCESS | 4109 | 11:24:58 INFO - PROCESS | 4109 | [#0] dojo.html Cycles:165 Average:5217.93 Median:5399.00 stddev:570.98 (10.6%) stddev-sans-first:546.90 11:24:58 INFO - PROCESS | 4109 | Values: 3053.3 3118.9 3161.7 3164.4 3182.5 5058.5 5167.0 5241.8 5261.4 5311.4 5150.5 5193.7 5212.5 5294.4 5307.6 4751.0 4766.2 4782.9 4799.6 4868.9 4827.3 4856.0 4857.6 4864.0 4893.1 4596.8 4693.7 4723.4 4775.9 4777.3 4783.9 4813.6 4817.8 4825.8 4852.3 4751.7 4781.5 4797.0 4800.3 4805.2 4893.6 5030.8 5045.1 5101.9 5157.9 5580.1 5647.9 5654.0 5657.9 5728.5 5664.8 5693.9 5695.2 5698.6 5699.0 5162.6 5267.5 5275.8 5282.2 5283.0 5626.6 5723.3 5768.8 5772.1 5778.5 5538.8 5539.9 5543.8 5548.1 5549.7 5463.9 5523.7 5577.8 5599.5 5618.1 5564.7 5634.2 5650.5 5651.3 5682.6 5514.4 5589.9 5598.4 5599.8 5601.2 4316.8 4333.1 4370.8 4371.4 4396.1 3895.1 3915.2 3923.4 3947.2 3950.3 5263.6 5270.8 5281.8 5285.5 5329.2 5475.9 5497.7 5596.5 5601.0 5640.6 5249.2 5272.1 5272.2 5276.9 5303.4 4834.5 4851.5 4853.1 4860.7 4891.9 5686.1 5819.3 5875.6 5881.1 5998.7 5585.7 5587.7 5588.0 5588.9 5608.5 5801.3 5841.8 5846.5 5850.4 5860.0 5444.8 5488.6 5515.0 5560.6 5611.4 5616.5 5625.4 5627.3 5629.5 5633.3 5393.4 5432.8 5479.5 5485.4 5535.3 5456.4 5458.2 5475.1 5572.0 5572.9 5388.5 5399.0 5400.7 5402.9 5417.3 5465.5 5519.4 5523.2 5527.7 5555.9 5266.4 5323.4 5391.1 5397.3 5397.7 11:24:58 INFO - PROCESS | 4109 | 11:24:58 INFO - PROCESS | 4109 | [#1] ext.html Cycles:180 Average:47413.44 Median:36096.73 stddev:88717.47 (245.8%) stddev-sans-first:88896.51 11:24:58 INFO - PROCESS | 4109 | Values: 527.3 530.4 543.8 562.3 562.7 28736.1 29452.0 35785.0 36408.5 36465.6 39380.6 39775.8 39819.8 39890.4 39959.2 7353.4 8362.7 8517.4 8518.1 8542.4 7362.3 7469.9 7470.2 9943.0 10079.8 9980.3 10093.3 10103.9 10113.4 10113.6 9958.2 10075.5 10082.9 10088.1 10090.8 7475.0 7627.7 10003.1 10206.7 10225.6 36633.6 36943.4 37034.3 37120.1 37162.8 3195.6 3208.1 3220.2 3254.6 3282.4 28057.3 28437.3 28512.3 28601.0 29266.8 3715.2 3754.0 3783.5 3899.4 3910.1 217614.0 219184.0 219305.9 219342.0 219505.0 55176.2 56890.0 58292.7 60718.0 61821.0 57000.0 57128.4 57372.7 57408.7 57433.4 15843.3 16116.9 16129.3 16130.8 16137.8 11360.0 11413.8 11421.9 11433.0 11547.9 19975.1 20017.1 20241.0 20290.7 20303.2 7697.5 7837.4 7846.8 7953.3 7967.3 976.0 1006.0 1018.9 1019.1 1040.8 28713.7 28916.4 29167.9 29252.3 30838.8 942.0 961.6 962.5 979.2 979.6 13800.0 13933.9 14099.3 14105.3 14176.8 476577.0 483452.0 486481.0 487181.0 487423.0 49457.8 49978.5 50065.7 50088.7 50209.5 1331.2 1333.9 1347.9 1348.5 1351.5 24282.0 30743.5 30876.4 30879.4 31440.0 46204.5 46937.8 46960.8 46961.0 46963.8 227695.0 228933.0 229171.0 229459.0 229510.0 25974.4 26288.7 30331.5 31101.0 31641.2 37209.4 37306.8 38008.8 38257.2 38317.2 33577.0 38852.4 39025.8 40446.6 42718.0 32805.8 37268.6 37292.6 37336.6 38930.4 36493.6 37049.6 37125.8 38180.4 38269.9 31936.8 32598.5 33581.0 33680.2 34724.5 24063.8 24115.0 24200.5 24329.1 26739.9 11:24:58 INFO - PROCESS | 4109 | 11:24:58 INFO - PROCESS | 4109 | [#2] jquery.html Cycles:180 Average:27598.28 Median:38796.42 stddev:84507.96 (217.8%) stddev-sans-first:84720.27 11:24:58 INFO - PROCESS | 4109 | Values: 357.7 360.9 363.3 364.0 364.1 13577.1 13701.9 16458.9 16601.8 16973.4 14637.9 15408.8 15708.3 15722.2 15742.7 5154.8 5274.1 5279.2 5283.6 5286.8 4014.9 4117.9 5287.4 5317.8 5671.3 5767.6 5780.5 5792.9 5800.4 5822.1 5658.8 5777.7 5821.8 5830.1 5836.8 5134.7 5139.9 5151.7 5155.2 5158.9 16831.6 17691.6 18275.4 20144.2 20145.7 2152.4 2209.3 2250.7 2284.6 2301.0 12468.4 12663.2 12681.5 12681.9 12754.9 1802.3 1830.2 1872.8 1881.1 1927.5 54154.7 57511.0 59113.0 59522.4 59910.0 9394.6 9532.0 9672.0 9722.5 9858.9 12633.9 12678.5 12681.2 12689.7 12690.7 6994.4 7214.2 7432.9 7496.0 7561.4 7225.1 7229.7 7259.6 7346.9 7436.3 4274.1 4308.9 4348.5 4375.2 4381.6 1704.1 1765.5 1770.8 1772.0 1823.4 746.9 832.2 838.6 952.4 967.2 15181.9 15329.5 15417.8 15637.3 15674.2 852.5 854.5 884.3 885.4 964.2 9101.7 9663.0 9677.5 9708.3 9724.3 493769.0 494452.0 529975.9 530394.0 537932.0 74126.3 75529.6 76243.6 76702.6 78284.0 1103.1 1113.3 1117.2 1122.5 1148.4 14704.5 14806.3 15047.8 15149.8 15373.3 31186.2 31223.8 32652.5 32723.7 36125.6 38675.4 38917.4 39455.8 39578.4 41679.4 9122.0 9215.4 9443.9 9542.2 9545.9 14940.0 16088.0 16280.2 16752.1 16811.2 13501.3 13820.0 13867.1 14043.3 14398.9 13477.8 13503.7 13675.7 13693.5 13994.6 14218.2 14230.9 14663.3 15056.4 15112.7 9269.7 9426.4 9460.1 9551.1 9561.6 10075.1 10786.8 14352.6 14418.6 14586.9 11:24:58 INFO - PROCESS | 4109 | 11:24:58 INFO - PROCESS | 4109 | [#3] mootools.html Cycles:180 Average:5335.44 Median:6149.75 stddev:2754.01 (44.8%) stddev-sans-first:2745.13 11:24:58 INFO - PROCESS | 4109 | Values: 1311.8 1417.8 1424.5 1520.4 1728.9 6415.9 7280.5 7404.9 7469.9 7520.4 7278.7 7497.4 7510.1 7511.0 7526.1 2274.5 2283.4 2291.9 2294.4 2302.1 2267.3 2309.8 2358.8 2366.2 2372.4 2261.0 2269.8 2303.2 2313.5 2324.8 2283.9 2286.8 2314.8 2314.9 2319.4 2327.1 2367.2 2371.7 2372.3 2373.6 7496.4 7534.8 7553.7 7585.5 7590.0 4681.3 4732.3 4771.5 4771.5 4772.6 2957.3 2967.9 3020.2 3026.5 3044.4 995.4 1002.1 1008.1 1013.5 1030.4 10549.6 10594.6 10609.7 10612.8 10628.0 4254.6 4307.2 4331.2 4368.9 4369.4 8985.4 9007.5 9014.0 9033.0 9033.5 4730.9 4746.0 4752.3 4779.3 4781.0 3833.3 3883.4 4236.7 4353.3 4355.2 3637.7 3638.5 3678.5 3689.8 3725.6 1154.2 1183.1 1183.2 1186.8 1196.2 1302.7 1306.2 1332.1 1332.6 1336.5 7072.2 7080.0 7112.1 7173.4 7179.4 465.6 465.7 470.3 473.7 506.0 5474.9 5519.4 5549.5 5551.7 5561.1 8977.0 9009.7 9170.7 9172.1 9210.2 9072.2 9125.7 9190.5 9206.9 9221.8 7076.1 7108.3 7134.8 7154.1 7189.3 6923.5 6954.5 7014.4 7027.2 7028.4 8080.4 8109.4 8117.8 8164.3 8304.6 8342.4 8390.5 8456.5 8565.1 8572.9 6049.5 6146.3 6153.2 6368.9 6708.3 7162.2 7190.4 7201.5 7249.3 7256.4 6674.7 6808.8 6850.8 6877.8 7070.1 6797.0 6809.3 6850.5 6884.5 6935.7 6804.9 6843.5 6860.5 6873.1 6934.7 6334.4 6366.8 6369.5 6370.2 6375.5 6384.4 6398.3 6442.8 6452.2 6463.6 11:24:58 INFO - PROCESS | 4109 | 11:24:58 INFO - PROCESS | 4109 | [#4] prototype.html Cycles:180 Average:5099.62 Median:5787.23 stddev:1524.87 (26.3%) stddev-sans-first:1486.76 11:24:58 INFO - PROCESS | 4109 | Values: 342.5 343.4 346.1 349.4 351.0 5670.1 5734.3 5776.3 5781.7 5789.7 5577.0 5656.7 5712.6 5722.1 5733.1 4428.0 4431.4 4439.9 4446.7 4448.2 4311.5 4373.0 4393.6 4430.7 4441.0 4388.6 4405.9 4432.8 4433.8 4442.8 4386.3 4392.2 4398.9 4431.4 4439.8 3941.0 3941.5 3943.9 3948.1 3951.8 5343.2 5465.7 5466.7 5487.9 5537.1 5126.4 5127.5 5130.5 5137.8 5150.7 6095.2 6101.5 6102.8 6102.9 6105.4 3989.4 4056.6 4156.0 4220.5 4246.6 6237.8 6299.5 6300.1 6305.2 6306.8 4319.4 4328.4 4332.1 4346.3 4354.0 4333.2 4395.5 4395.7 4395.9 4402.7 5008.4 5047.9 5050.9 5056.2 5081.8 6055.7 6061.0 6062.5 6063.1 6073.6 1542.4 1548.2 1565.2 1565.2 1565.3 1016.5 1060.2 1060.5 1064.6 1089.9 5793.6 5795.9 5795.9 5798.5 5802.1 6241.3 6246.7 6257.5 6262.5 6269.3 5767.4 5784.7 5799.2 5802.7 5804.7 3264.1 3350.0 3362.8 3384.8 3392.6 6501.8 6511.2 6514.1 6515.2 6517.6 6400.4 6402.6 6412.9 6414.2 6415.9 6336.0 6472.3 6487.1 6491.7 6501.2 6227.8 6237.6 6243.1 6246.7 6251.7 6012.3 6084.5 6127.4 6272.3 6283.4 6516.5 6557.0 6560.8 6564.6 6583.0 4393.4 4397.5 4397.7 4399.1 4399.6 6189.6 6240.7 6300.1 6310.3 6313.5 6094.8 6135.4 6142.7 6146.4 6167.0 6137.9 6139.9 6148.2 6152.6 6161.5 5837.6 5964.1 5984.1 5987.8 5999.6 6170.4 6172.5 6174.4 6177.0 6190.3 5991.0 6022.0 6026.7 6037.7 6038.5 11:24:58 INFO - PROCESS | 4109 | 11:24:58 INFO - PROCESS | 4109 | [#5] yui.html Cycles:180 Average:13362.46 Median:46996.91 stddev:15377.21 (32.7%) stddev-sans-first:15391.01 11:24:58 INFO - PROCESS | 4109 | Values: 713.6 739.0 763.9 779.4 806.7 13564.6 13769.4 13817.7 13825.5 13839.9 11407.0 11547.4 12841.1 12933.8 12947.7 808.3 814.5 815.0 816.6 818.1 822.2 822.8 823.0 825.2 826.7 863.8 865.2 865.6 867.2 867.7 856.6 858.5 862.1 863.3 873.1 626.9 630.2 632.1 638.1 642.8 12399.9 12450.5 12484.1 12486.5 12538.7 10515.6 10757.4 11039.4 11083.4 11460.6 10009.9 10054.2 10061.7 10156.9 10171.1 3620.4 3643.4 3648.2 3680.4 3785.9 42944.0 43109.4 44390.3 46978.3 47015.5 9874.0 9913.8 9926.6 9943.5 9992.7 17352.5 17422.6 17633.1 17838.0 17868.4 6829.8 6831.3 6986.0 6989.7 7028.6 4173.3 4187.3 4197.7 4218.0 4240.3 3052.0 3084.7 3086.2 3089.0 3089.2 554.6 560.4 561.1 563.9 566.6 539.4 548.9 595.2 631.8 689.4 8257.7 8311.0 8523.9 8586.9 8988.1 526.2 532.0 533.6 550.9 637.5 3860.6 3913.5 4005.7 4096.7 4127.9 53849.2 54589.7 54650.5 54812.0 55306.4 45097.3 46234.0 47421.8 47795.0 48514.8 48061.3 48394.3 48885.0 49742.3 49973.3 8248.7 8505.2 8625.2 8953.3 9062.4 33711.2 33719.3 34524.7 34822.3 35276.3 41607.8 42332.6 42847.9 45319.5 45599.0 10774.8 11015.9 11078.3 11127.9 11544.2 11077.4 11565.8 11608.3 11975.6 11989.0 10414.9 10581.5 10966.8 11047.0 11352.6 10900.9 11316.2 11381.8 11415.1 11760.8 10579.4 10996.2 11028.2 11413.9 11540.2 9620.0 9678.4 9745.6 9769.8 9808.3 8517.4 8997.3 9052.0 9088.3 9132.0 11:24:58 INFO - PROCESS | 4109 | -------- Summary: end -------- 11:24:58 INFO - PROCESS | 4109 | 11:24:59 INFO - TEST-INFO | 4109: exit 0 11:24:59 INFO - TEST-OK | dromaeo_css | took 1114180ms 11:24:59 INFO - TEST-START | kraken 11:24:59 INFO - operating with platform_type : linux_ 11:24:59 INFO - Initialising browser for kraken test... 11:24:59 INFO - TEST-INFO | started process 4304 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPlCmzP/profile http://localhost:42382/getInfo.html) 11:25:04 INFO - PROCESS | 4304 | __metrics Screen width/height:1600/1200 11:25:04 INFO - PROCESS | 4304 | colorDepth:24 11:25:04 INFO - PROCESS | 4304 | Browser inner width/height: 1024/697 11:25:04 INFO - PROCESS | 4304 | __metrics 11:25:04 INFO - PROCESS | 4304 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:25:04 INFO - PROCESS | 4304 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:05 INFO - TEST-INFO | 4304: exit 0 11:25:05 INFO - Browser initialized. 11:25:05 INFO - Running cycle 1/1 for kraken test... 11:25:05 INFO - TEST-INFO | started process 4387 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPlCmzP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:17 INFO - PROCESS | 4387 | RSS: Main: 150171648 11:25:17 INFO - PROCESS | 4387 | 11:25:19 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42382/tests/kraken/driver.html?testName=audio-beat-detection) 11:25:20 INFO - PROCESS | 4387 | RSS: Main: 185442304 11:25:20 INFO - PROCESS | 4387 | 11:25:22 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42382/tests/kraken/driver.html?testName=audio-dft) 11:25:23 INFO - PROCESS | 4387 | RSS: Main: 176361472 11:25:23 INFO - PROCESS | 4387 | 11:25:26 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42382/tests/kraken/driver.html?testName=audio-fft) 11:25:26 INFO - PROCESS | 4387 | RSS: Main: 161083392 11:25:26 INFO - PROCESS | 4387 | 11:25:28 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42382/tests/kraken/driver.html?testName=audio-oscillator) 11:25:29 INFO - PROCESS | 4387 | RSS: Main: 161988608 11:25:29 INFO - PROCESS | 4387 | 11:25:31 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42382/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:25:32 INFO - PROCESS | 4387 | RSS: Main: 164081664 11:25:32 INFO - PROCESS | 4387 | 11:25:35 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42382/tests/kraken/driver.html?testName=imaging-darkroom) 11:25:35 INFO - PROCESS | 4387 | RSS: Main: 164884480 11:25:35 INFO - PROCESS | 4387 | 11:25:39 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42382/tests/kraken/driver.html?testName=imaging-desaturate) 11:25:39 INFO - PROCESS | 4387 | RSS: Main: 164818944 11:25:39 INFO - PROCESS | 4387 | 11:25:42 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42382/tests/kraken/driver.html?testName=json-parse-financial) 11:25:43 INFO - PROCESS | 4387 | RSS: Main: 166445056 11:25:43 INFO - PROCESS | 4387 | 11:25:44 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42382/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:25:45 INFO - PROCESS | 4387 | RSS: Main: 174125056 11:25:45 INFO - PROCESS | 4387 | 11:25:46 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42382/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:25:47 INFO - PROCESS | 4387 | RSS: Main: 173125632 11:25:47 INFO - PROCESS | 4387 | 11:25:49 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42382/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:25:50 INFO - PROCESS | 4387 | RSS: Main: 180346880 11:25:50 INFO - PROCESS | 4387 | 11:25:52 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42382/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:25:53 INFO - PROCESS | 4387 | RSS: Main: 190156800 11:25:53 INFO - PROCESS | 4387 | 11:25:55 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42382/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:25:56 INFO - PROCESS | 4387 | RSS: Main: 187699200 11:25:56 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | Cycle 1(1): loaded http://localhost:42382/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42382/tests/kraken/driver.html?testName=ai-astar) 11:25:58 INFO - PROCESS | 4387 | RSS: Main: 244813824 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | __start_tp_report 11:25:58 INFO - PROCESS | 4387 | _x_x_mozilla_page_load 11:25:58 INFO - PROCESS | 4387 | _x_x_mozilla_page_load_details 11:25:58 INFO - PROCESS | 4387 | |i|pagename|runs| 11:25:58 INFO - PROCESS | 4387 | |0;ai-astar;113;113;107;112;114;113;102;113;112;118 11:25:58 INFO - PROCESS | 4387 | |1;audio-beat-detection;154;129;159;169;131;156;149;125;172;125 11:25:58 INFO - PROCESS | 4387 | |2;audio-dft;164;162;164;161;161;162;159;164;163;161 11:25:58 INFO - PROCESS | 4387 | |3;audio-fft;74;75;94;94;73;75;73;109;94;73 11:25:58 INFO - PROCESS | 4387 | |4;audio-oscillator;97;99;141;96;98;96;142;96;96;139 11:25:58 INFO - PROCESS | 4387 | |5;imaging-gaussian-blur;109;111;111;109;110;110;110;111;109;110 11:25:58 INFO - PROCESS | 4387 | |6;imaging-darkroom;147;146;146;145;145;147;146;146;147;146 11:25:58 INFO - PROCESS | 4387 | |7;imaging-desaturate;98;96;96;95;96;96;95;96;96;96 11:25:58 INFO - PROCESS | 4387 | |8;json-parse-financial;59;59;60;58;59;58;59;58;63;58 11:25:58 INFO - PROCESS | 4387 | |9;json-stringify-tinderbox;68;69;68;70;68;69;68;68;68;70 11:25:58 INFO - PROCESS | 4387 | |10;stanford-crypto-aes;86;87;88;87;86;86;86;85;87;86 11:25:58 INFO - PROCESS | 4387 | |11;stanford-crypto-ccm;119;122;122;126;134;116;119;118;120;121 11:25:58 INFO - PROCESS | 4387 | |12;stanford-crypto-pbkdf2;149;155;159;154;156;153;155;155;166;147 11:25:58 INFO - PROCESS | 4387 | |13;stanford-crypto-sha256-iterative;70;68;68;70;70;69;68;74;69;68 11:25:58 INFO - PROCESS | 4387 | __end_tp_report 11:25:58 INFO - PROCESS | 4387 | __start_cc_report 11:25:58 INFO - PROCESS | 4387 | _x_x_mozilla_cycle_collect,940 11:25:58 INFO - PROCESS | 4387 | __end_cc_report 11:25:58 INFO - PROCESS | 4387 | __startTimestamp1451849158329__endTimestamp 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | ------- Summary: start ------- 11:25:58 INFO - PROCESS | 4387 | Number of tests: 14 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:4.32 (3.8%) stddev-sans-first:4.56 11:25:58 INFO - PROCESS | 4387 | Values: 113.0 113.0 107.0 112.0 114.0 113.0 102.0 113.0 112.0 118.0 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:155.00 stddev:18.06 (11.7%) stddev-sans-first:18.97 11:25:58 INFO - PROCESS | 4387 | Values: 154.0 129.0 159.0 169.0 131.0 156.0 149.0 125.0 172.0 125.0 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.66 (1.0%) stddev-sans-first:1.62 11:25:58 INFO - PROCESS | 4387 | Values: 164.0 162.0 164.0 161.0 161.0 162.0 159.0 164.0 163.0 161.0 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.00 stddev:13.11 (17.5%) stddev-sans-first:13.45 11:25:58 INFO - PROCESS | 4387 | Values: 74.0 75.0 94.0 94.0 73.0 75.0 73.0 109.0 94.0 73.0 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:21.20 (22.1%) stddev-sans-first:21.96 11:25:58 INFO - PROCESS | 4387 | Values: 97.0 99.0 141.0 96.0 98.0 96.0 142.0 96.0 96.0 139.0 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 11:25:58 INFO - PROCESS | 4387 | Values: 109.0 111.0 111.0 109.0 110.0 110.0 110.0 111.0 109.0 110.0 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 11:25:58 INFO - PROCESS | 4387 | Values: 147.0 146.0 146.0 145.0 145.0 147.0 146.0 146.0 147.0 146.0 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.44 11:25:58 INFO - PROCESS | 4387 | Values: 98.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:1.52 (2.6%) stddev-sans-first:1.62 11:25:58 INFO - PROCESS | 4387 | Values: 59.0 59.0 60.0 58.0 59.0 58.0 59.0 58.0 63.0 58.0 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 11:25:58 INFO - PROCESS | 4387 | Values: 68.0 69.0 68.0 70.0 68.0 69.0 68.0 68.0 68.0 70.0 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.50 stddev:0.84 (1.0%) stddev-sans-first:0.88 11:25:58 INFO - PROCESS | 4387 | Values: 86.0 87.0 88.0 87.0 86.0 86.0 86.0 85.0 87.0 86.0 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:121.50 stddev:5.10 (4.2%) stddev-sans-first:5.32 11:25:58 INFO - PROCESS | 4387 | Values: 119.0 122.0 122.0 126.0 134.0 116.0 119.0 118.0 120.0 121.0 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:155.00 stddev:5.20 (3.4%) stddev-sans-first:5.05 11:25:58 INFO - PROCESS | 4387 | Values: 149.0 155.0 159.0 154.0 156.0 153.0 155.0 155.0 166.0 147.0 11:25:58 INFO - PROCESS | 4387 | 11:25:58 INFO - PROCESS | 4387 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.84 (2.6%) stddev-sans-first:1.94 11:25:58 INFO - PROCESS | 4387 | Values: 70.0 68.0 68.0 70.0 70.0 69.0 68.0 74.0 69.0 68.0 11:25:58 INFO - PROCESS | 4387 | -------- Summary: end -------- 11:25:58 INFO - PROCESS | 4387 | 11:25:59 INFO - TEST-INFO | 4387: exit 0 11:25:59 INFO - TEST-OK | kraken | took 59948ms 11:25:59 INFO - TEST-START | v8_7 11:25:59 INFO - operating with platform_type : linux_ 11:25:59 INFO - Initialising browser for v8_7 test... 11:25:59 INFO - TEST-INFO | started process 4636 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpm1uImO/profile http://localhost:42382/getInfo.html) 11:26:04 INFO - PROCESS | 4636 | __metrics Screen width/height:1600/1200 11:26:04 INFO - PROCESS | 4636 | colorDepth:24 11:26:04 INFO - PROCESS | 4636 | Browser inner width/height: 1024/697 11:26:04 INFO - PROCESS | 4636 | __metrics 11:26:04 INFO - PROCESS | 4636 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:26:04 INFO - PROCESS | 4636 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:26:05 INFO - TEST-INFO | 4636: exit 0 11:26:05 INFO - Browser initialized. 11:26:05 INFO - Running cycle 1/1 for v8_7 test... 11:26:05 INFO - TEST-INFO | started process 4721 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpm1uImO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:17 INFO - PROCESS | 4721 | RSS: Main: 150269952 11:26:17 INFO - PROCESS | 4721 | 11:26:38 INFO - PROCESS | 4721 | Cycle 1(1): loaded http://localhost:42382/tests/v8_7/run.html (next: http://localhost:42382/tests/v8_7/run.html) 11:26:38 INFO - PROCESS | 4721 | RSS: Main: 590823424 11:26:38 INFO - PROCESS | 4721 | 11:26:38 INFO - PROCESS | 4721 | __start_tp_report 11:26:38 INFO - PROCESS | 4721 | _x_x_mozilla_page_load 11:26:38 INFO - PROCESS | 4721 | _x_x_mozilla_page_load_details 11:26:38 INFO - PROCESS | 4721 | |i|pagename|runs| 11:26:38 INFO - PROCESS | 4721 | |0;Richards;167.64459346186086 11:26:38 INFO - PROCESS | 4721 | |1;DeltaBlue;195.35065442469232 11:26:38 INFO - PROCESS | 4721 | |2;Encrypt;286.20492272467084 11:26:38 INFO - PROCESS | 4721 | |3;Decrypt;5175.257731958763 11:26:38 INFO - PROCESS | 4721 | |4;RayTrace;1114.8272017837235 11:26:38 INFO - PROCESS | 4721 | |5;Earley;801.2820512820513 11:26:38 INFO - PROCESS | 4721 | |6;Boyer;12658.227848101265 11:26:38 INFO - PROCESS | 4721 | |7;RegExp;25897.4358974359 11:26:38 INFO - PROCESS | 4721 | |8;Splay;643.0868167202573 11:26:38 INFO - PROCESS | 4721 | |9;NavierStokes;4868.9320388349515 11:26:38 INFO - PROCESS | 4721 | __end_tp_report 11:26:38 INFO - PROCESS | 4721 | __startTimestamp1451849198864__endTimestamp 11:26:38 INFO - PROCESS | 4721 | 11:26:38 INFO - PROCESS | 4721 | ------- Summary: start ------- 11:26:38 INFO - PROCESS | 4721 | Number of tests: 10 11:26:38 INFO - PROCESS | 4721 | 11:26:38 INFO - PROCESS | 4721 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 11:26:38 INFO - PROCESS | 4721 | Values: 167.6 11:26:38 INFO - PROCESS | 4721 | 11:26:38 INFO - PROCESS | 4721 | [#1] DeltaBlue Cycles:1 Average:195.35 Median:195.35 stddev:0.00 (0.0%) 11:26:38 INFO - PROCESS | 4721 | Values: 195.4 11:26:38 INFO - PROCESS | 4721 | 11:26:38 INFO - PROCESS | 4721 | [#2] Encrypt Cycles:1 Average:286.20 Median:286.20 stddev:0.00 (0.0%) 11:26:38 INFO - PROCESS | 4721 | Values: 286.2 11:26:38 INFO - PROCESS | 4721 | 11:26:38 INFO - PROCESS | 4721 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 11:26:38 INFO - PROCESS | 4721 | Values: 5175.3 11:26:38 INFO - PROCESS | 4721 | 11:26:38 INFO - PROCESS | 4721 | [#4] RayTrace Cycles:1 Average:1114.83 Median:1114.83 stddev:0.00 (0.0%) 11:26:38 INFO - PROCESS | 4721 | Values: 1114.8 11:26:38 INFO - PROCESS | 4721 | 11:26:38 INFO - PROCESS | 4721 | [#5] Earley Cycles:1 Average:801.28 Median:801.28 stddev:0.00 (0.0%) 11:26:38 INFO - PROCESS | 4721 | Values: 801.3 11:26:38 INFO - PROCESS | 4721 | 11:26:38 INFO - PROCESS | 4721 | [#6] Boyer Cycles:1 Average:12658.23 Median:12658.23 stddev:0.00 (0.0%) 11:26:38 INFO - PROCESS | 4721 | Values: 12658.2 11:26:38 INFO - PROCESS | 4721 | 11:26:38 INFO - PROCESS | 4721 | [#7] RegExp Cycles:1 Average:25897.44 Median:25897.44 stddev:0.00 (0.0%) 11:26:38 INFO - PROCESS | 4721 | Values: 25897.4 11:26:38 INFO - PROCESS | 4721 | 11:26:38 INFO - PROCESS | 4721 | [#8] Splay Cycles:1 Average:643.09 Median:643.09 stddev:0.00 (0.0%) 11:26:38 INFO - PROCESS | 4721 | Values: 643.1 11:26:38 INFO - PROCESS | 4721 | 11:26:38 INFO - PROCESS | 4721 | [#9] NavierStokes Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%) 11:26:38 INFO - PROCESS | 4721 | Values: 4868.9 11:26:38 INFO - PROCESS | 4721 | -------- Summary: end -------- 11:26:38 INFO - PROCESS | 4721 | 11:26:39 INFO - TEST-INFO | 4721: exit 0 11:26:39 INFO - TEST-OK | v8_7 | took 40536ms 11:26:39 INFO - SUITE-END | took 1214s 11:26:39 INFO - Completed test suite (00:20:14) 11:26:39 INFO - Working with test: dromaeo_css 11:26:39 INFO - Generating results file: dromaeo_css 11:26:39 INFO - Working with test: kraken 11:26:39 INFO - Generating results file: kraken 11:26:39 INFO - javascript benchmark 11:26:39 INFO - Working with test: v8_7 11:26:39 INFO - Generating results file: v8_7 11:26:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:26:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 11:26:40 INFO - process_Request line: dromaeo_css 6820.95 graph.html#tests=[[72,201,35]] 11:26:40 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:26:40 INFO - process_Request line: kraken 1526.30 graph.html#tests=[[232,201,35]] 11:26:40 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:26:40 INFO - process_Request line: v8_7 20638.11 graph.html#tests=[[230,201,35]] 11:26:40 INFO - RETURN: dromaeo_css: 6820.95 11:26:40 INFO - RETURN: kraken: 1526.30 11:26:40 INFO - RETURN: v8_7: 20638.11 11:26:40 INFO - javascript benchmark 11:26:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3053.2672158681917, 3118.8596513156904, 3161.74706023518, 3164.3671265746857, 3182.5385319128736, 5058.494150584949, 5166.974165129169, 5241.764120614572, 5261.368635763713, 5311.442298558649, 5150.459201783806, 5193.662411943221, 5212.50481204285, 5294.391145018324, 5307.575393968483, 4750.952490475085, 4766.213574760169, 4782.928256076144, 4799.5680388765, 4868.853934381974, 4827.324174615556, 4855.951440485603, 4857.587105096053, 4863.951360486385, 4893.094777466163, 4596.7931443085145, 4693.718376897397, 4723.385959825235, 4775.880602984936, 4777.307290442884, 4783.856484305476, 4813.638977076698, 4817.759112044384, 4825.806967721322, 4852.320675105488, 4751.691140075884, 4781.474037855833, 4797.040591881638, 4800.3279540864305, 4805.1590971579835, 4893.632977526664, 5030.798768049273, 5045.142325804622, 5101.948980510185, 5157.896842063175, 5580.107182850725, 5647.858803529944, 5654.03881340169, 5657.9434205658235, 5728.484436400744, 5664.801731939362, 5693.943060569382, 5695.202671625976, 5698.629589076697, 5698.971505142447, 5162.638615296931, 5267.499587539178, 5275.815346462856, 5282.154855223146, 5283.049051170826, 5626.578006649518, 5723.341815691166, 5768.7692492300675, 5772.076467765138, 5778.508826749689, 5538.75075621598, 5539.889202215933, 5543.7782488700805, 5548.0845660465575, 5549.667019978814, 5463.945360546423, 5523.7238138092935, 5577.804776832872, 5599.468050535193, 5618.129189975561, 5564.749586268627, 5634.183043458757, 5650.5479561634975, 5651.265335506358, 5682.602217844711, 5514.393416724157, 5589.860253493695, 5598.356189038232, 5599.80400685974, 5601.159826026047, 4316.827326906889, 4333.111712099012, 4370.759608221579, 4371.431713877239, 4396.098799746044, 3895.0846551060476, 3915.1973845362204, 3923.4114882767244, 3947.17109407022, 3950.2692001979153, 5263.631545791758, 5270.7628156733035, 5281.762320695578, 5285.471452854761, 5329.200619907045, 5475.890482190334, 5497.697626630574, 5596.524295434933, 5601.019821531216, 5640.605157638925, 5249.238860365225, 5272.077386457355, 5272.182811664198, 5276.92084618731, 5303.390110137307, 4834.516548345207, 4851.466338702739, 4853.102176097434, 4860.708357498491, 4891.877703057381, 5686.090225563973, 5819.301683797971, 5875.647461152259, 5881.059030555176, 5998.670073145931, 5585.748641311232, 5587.664740115606, 5588.0, 5588.888222235614, 5608.495235428831, 5801.3038435388025, 5841.795537156179, 5846.532277417711, 5850.444207800252, 5860.0, 5444.8094316698725, 5488.615796894179, 5515.0, 5560.610757246954, 5611.410801865745, 5616.494515493625, 5625.409332020079, 5627.268455100811, 5629.549636029026, 5633.267675202197, 5393.43368946255, 5432.782688692408, 5479.506844384025, 5485.369182543899, 5535.308086489189, 5456.372517160418, 5458.235846981505, 5475.09660905946, 5572.024895643327, 5572.91640625399, 5388.488093631099, 5399.0, 5400.675959442446, 5402.864928376822, 5417.322834645669, 5465.453454654503, 5519.39286678457, 5523.226748255167, 5527.723613819373, 5555.944440555542, 5266.368035835724, 5323.441038691037, 5391.083515802245, 5397.298351214317, 5397.676139431646], "unit": "score", "name": "dojo.html", "value": 5181.407145279389}, {"lowerIsBetter": false, "replicates": [527.306591831741, 530.4483337329177, 543.8151028650258, 562.344868228514, 562.7298896529663, 28736.13791586253, 29452.0, 35785.0, 36408.453873191924, 36465.63534364656, 39380.60619393805, 39775.80112099442, 39819.800900995455, 39890.40164397536, 39959.20081598366, 7353.411727061823, 8362.665493380258, 8517.446365986221, 8518.148185181462, 8542.402031857773, 7362.300581444754, 7469.887951680729, 7470.178280389153, 9943.0, 10079.848802267936, 9980.30137890348, 10093.343932644391, 10103.949480252588, 10113.443760593165, 10113.646022389217, 9958.203343732484, 10075.546600402999, 10082.89917100827, 10088.092071713545, 10090.848637270446, 7474.962625186839, 7627.733029344002, 10003.09972102507, 10206.744831379201, 10225.64210252645, 36633.63366366329, 36943.445848312294, 37034.259314813826, 37120.071998199994, 37162.814185928895, 3195.6325022622464, 3208.1338038729414, 3220.211048293183, 3254.625718042432, 3282.4419848625553, 28057.29856753577, 28437.289067773265, 28512.28719282014, 28600.998965036124, 29266.8293268269, 3715.1826598148364, 3753.9812300938593, 3783.5055153214325, 3899.395593682984, 3910.1202229498135, 217614.0, 219184.0, 219305.90347048323, 219342.0, 219505.0, 55176.172357414674, 56890.0, 58292.708536457896, 60718.0, 61821.0, 57000.0, 57128.42871571314, 57372.71313643488, 57408.71295643579, 57433.42566574364, 15843.287052082684, 16116.919415402848, 16129.258026135585, 16130.838691613168, 16137.757933631005, 11360.0, 11413.828792568118, 11421.885781142248, 11433.0, 11547.884521154681, 19975.101120449614, 20017.099230534663, 20241.0, 20290.69563956542, 20303.187872485232, 7697.499662521918, 7837.412194085467, 7846.8430631387055, 7953.2842044216295, 7967.322777563972, 975.9658411955547, 1005.9698209053594, 1018.9184865210914, 1019.0777346501428, 1040.7502199472071, 28713.71286287152, 28916.42167156645, 29167.854160729486, 29252.26869328241, 30838.845805771278, 942.0344147249125, 961.5624890674726, 962.485070487286, 979.1579241852002, 979.647326962293, 13800.0, 13933.860661393459, 14099.295035248402, 14105.294735263196, 14176.787348189786, 476577.0, 483452.0, 486481.0, 487181.0, 487423.0, 49457.752711236215, 49978.50021499811, 50065.74967125141, 50088.74955625198, 50209.49790502121, 1331.161368337941, 1333.9132956358, 1347.9326033698471, 1348.4673553946136, 1351.4526616720243, 24282.0, 30743.538846917763, 30876.38247234998, 30879.382412352075, 31440.0, 46204.53795462002, 46937.76531117459, 46960.7651961738, 46961.0, 46963.765181173876, 227695.0, 228933.0, 229171.0, 229459.0, 229510.0, 25974.350641233363, 26288.737112628627, 30331.545026825057, 31101.0, 31641.20896977594, 37209.4418583716, 37306.81346593249, 38008.80995595004, 38257.23485530218, 38317.2336553273, 33577.0, 38852.41721374238, 39025.8048709766, 40446.59553404428, 42718.0, 32805.83597081999, 37268.627313726516, 37292.627073728916, 37336.626633733315, 38930.4160437588, 36493.635063649024, 37049.629503704615, 37125.814370927976, 38180.427293590066, 38269.85190444291, 31936.840315798272, 32598.51102233516, 33581.0, 33680.15799605029, 34724.47913281252, 24063.759362406152, 24115.0, 24200.51598968046, 24329.148479803123, 26739.86630066837], "unit": "score", "name": "ext.html", "value": 18266.19299426874}, {"lowerIsBetter": false, "replicates": [357.7066805219719, 360.8773017174161, 363.282517028868, 363.9581448133464, 364.11520006384507, 13577.117487363315, 13701.862981370183, 16458.91770541147, 16601.833981660195, 16973.40593079241, 14637.853621463782, 15408.84591154088, 15708.293126809293, 15722.213889305518, 15742.685146297095, 5154.793808247666, 5274.05067087924, 5279.234510995903, 5283.577313814885, 5286.762095705683, 4014.9397759033636, 4117.897052573695, 5287.418383977779, 5317.813876514323, 5671.319441667006, 5767.567432442563, 5780.537556995451, 5792.884142317151, 5800.448957349066, 5822.097574875901, 5658.8019419320335, 5777.653340799545, 5821.796237131723, 5830.096335068071, 5836.766529338843, 5134.691918484903, 5139.871503212412, 5151.716655583941, 5155.175171972504, 5158.948410515922, 16831.579210519714, 17691.557711057198, 18275.360362387386, 20144.194232230693, 20145.697814532792, 2152.418846911325, 2209.2930262316067, 2250.718660167479, 2284.6001949658908, 2300.988495057514, 12468.376581170996, 12663.176893501894, 12681.492740290378, 12681.93659031699, 12754.936225318907, 1802.315120254295, 1830.2130084063847, 1872.81271872813, 1881.1252767463059, 1927.4603111128765, 54154.729226353615, 57511.0, 59113.0, 59522.40477595212, 59910.0, 9394.577244024036, 9531.952340238393, 9671.951640241754, 9722.513874306256, 9858.929624778733, 12633.873661263453, 12678.492860285669, 12681.175723577939, 12689.682757931125, 12690.746185076247, 6994.4404447644065, 7214.206437291894, 7432.888506672404, 7495.962520187364, 7561.357284630758, 7225.096862892138, 7229.674664640103, 7259.564426134449, 7346.853062938818, 7436.293552112541, 4274.145170965757, 4308.913821723548, 4348.5216626171095, 4375.212461756914, 4381.627561657231, 1704.1223769758585, 1765.5409593505524, 1770.8140645232322, 1771.9911400443173, 1823.3800507827136, 746.9365103966115, 832.1844592299459, 838.5974732128491, 952.3809523809579, 967.2117224462041, 15181.861360398014, 15329.46346877854, 15417.76657867368, 15637.296321665552, 15674.216289185495, 852.4885068958575, 854.5342788180333, 884.2837301785574, 885.4156256870434, 964.1948972607951, 9101.726948191565, 9662.951685241529, 9677.516124193902, 9708.320417570701, 9724.319297649237, 493769.0, 494452.0, 529975.8826789722, 530394.0, 537932.0, 74126.25873741193, 75529.62235188788, 76243.61878190574, 76702.61648691833, 78284.0, 1103.051375816797, 1113.2763703592568, 1117.173291764105, 1122.5341483284508, 1148.3569201247328, 14704.485343012942, 14806.259687015821, 15047.774283385977, 15149.848501515286, 15373.308201130752, 31186.22034449157, 31223.843880780452, 32652.51021234636, 32723.67276327206, 36125.63874361328, 38675.41986870143, 38917.41623875701, 39455.80272098621, 39578.406323904586, 41679.37480937849, 9122.0, 9215.400998935047, 9443.905560944302, 9542.188913942115, 9545.904540954501, 14940.0, 16088.0, 16280.18599070018, 16752.078635675156, 16811.159442028093, 13501.324933753076, 13820.0, 13867.098638588459, 14043.297835108, 14398.928005359907, 13477.78699917012, 13503.662408439475, 13675.658108547366, 13693.520726774515, 13994.580162595139, 14218.217998010208, 14230.92884535612, 14663.340149693076, 15056.397744090114, 15112.715419189053, 9269.67556135532, 9426.434413935185, 9460.148586627236, 9551.0926461986, 9561.569729362334, 10075.09324160829, 10786.838197426889, 14352.56942291733, 14418.639534011734, 14586.854131458975], "unit": "score", "name": "jquery.html", "value": 8656.865030606554}, {"lowerIsBetter": false, "replicates": [1311.8425788905333, 1417.7944198091275, 1424.5227848670695, 1520.369046845559, 1728.8703347248952, 6415.871682566346, 7280.4903656744045, 7404.851902961937, 7469.925300746991, 7520.3983681305435, 7278.708851645928, 7497.437692173082, 7510.136334321554, 7511.0, 7526.096868375803, 2274.545090981806, 2283.4177284792354, 2291.9312420627407, 2294.4149241943283, 2302.0561569756405, 2267.2971378872603, 2309.8267629927736, 2358.7523310052457, 2366.2073205476186, 2372.4424760181346, 2260.9660855087186, 2269.795718385345, 2303.2399308228246, 2313.479467119893, 2324.837261391703, 2283.931482055541, 2286.771322867708, 2314.826388020905, 2314.93055208344, 2319.431739223884, 2327.0808030827898, 2367.242482405631, 2371.7272513660805, 2372.3357459911253, 2373.6202207646866, 7496.437767167485, 7534.8116297092465, 7553.69785208591, 7585.469017168801, 7589.962050189769, 4681.344611754357, 4732.337472753818, 4771.4512831024185, 4771.522847715235, 4772.6420518461255, 2957.2902503399246, 2967.9258018549494, 3020.1694534003327, 3026.530887712408, 3044.360684256309, 995.4375777685584, 1002.1231422505308, 1008.1229330482454, 1013.4831236069584, 1030.4487099401783, 10549.578016879392, 10594.576216951313, 10609.681709548726, 10612.787744245072, 10628.0, 4254.617084462413, 4307.203167414038, 4331.198728235287, 4368.9126217476105, 4369.4101296325225, 8985.415947963493, 9007.459552426875, 9014.0, 9033.0, 9033.50315732641, 4730.88172795676, 4746.0, 4752.310914917318, 4779.259214821708, 4781.043791241766, 3833.252515759456, 3883.4174873768598, 4236.661067114624, 4353.325234588644, 4355.194289056535, 3637.690796282293, 3638.5451818522683, 3678.5401824771902, 3689.8339574719203, 3725.5715592706642, 1154.1689983212075, 1183.148133343991, 1183.1954271095738, 1186.8160435132568, 1196.246364790194, 1302.6743314171458, 1306.1640550047978, 1332.094175960337, 1332.593558964525, 1336.4520546576052, 7072.222055573883, 7079.973403856412, 7112.0754301940415, 7173.426125910019, 7179.353858152791, 465.5786513205554, 465.6786817096193, 470.3368250766403, 473.7157705376815, 506.04357763826397, 5474.945250547523, 5519.448055194529, 5549.472800083986, 5551.694656793834, 5561.054620714488, 8977.0, 9009.684661036832, 9170.679026234184, 9172.082791720775, 9210.171084602283, 9072.183503484586, 9125.726228213165, 9190.540472976325, 9206.861897071549, 9221.81556368869, 7076.0801095857205, 7108.289171082851, 7134.821629459201, 7154.069970903749, 7189.281071892873, 6923.5499692519825, 6954.547954382949, 7014.403775679124, 7027.15674119109, 7028.367446929801, 8080.353571714131, 8109.432339736398, 8117.797055073434, 8164.346852251687, 8304.584770761317, 8342.374321925758, 8390.538520381439, 8456.450330728483, 8565.05784363707, 8572.871406928776, 6049.485793707584, 6146.293176284606, 6153.2000839890525, 6368.87262254743, 6708.295628959084, 7162.176349719641, 7190.388816950409, 7201.531900426456, 7249.275072492708, 7256.383207427428, 6674.666266686743, 6808.761693340709, 6850.828729281808, 6877.793666190022, 7070.116235470567, 6797.048413222252, 6809.319068093349, 6850.520463567503, 6884.5180837342905, 6935.7225710971, 6804.863902722017, 6843.486738494533, 6860.5197636164985, 6873.072135261676, 6934.687939042856, 6334.398232167937, 6366.77716279928, 6369.45859601939, 6370.203724534434, 6375.458086062737, 6384.3934826191435, 6398.328175541501, 6442.806715798533, 6452.161219041494, 6463.64449955257], "unit": "score", "name": "mootools.html", "value": 4337.619512304555}, {"lowerIsBetter": false, "replicates": [342.547836855351, 343.397337672385, 346.0915097868098, 349.4443834303457, 350.9556831456764, 5670.064439367499, 5734.340550836655, 5776.277965254343, 5781.682007489587, 5789.739461724222, 5576.972115139429, 5656.717164141797, 5712.571557133211, 5722.141678748179, 5733.082706766918, 4427.977860110703, 4431.401760762305, 4439.88900277494, 4446.666500012496, 4448.243798554237, 4311.461067366579, 4372.97813510932, 4393.648508119359, 4430.667699922503, 4440.97779511102, 4388.583084606973, 4405.867823965286, 4432.778361081949, 4433.84481543146, 4442.777861106948, 4386.298192289234, 4392.209402307567, 4398.868033958986, 4431.379606855043, 4439.822407103712, 3940.960590394088, 3941.527016757979, 3943.9014024649327, 3948.1314110895555, 3951.7826519541413, 5343.225232341289, 5465.699386533739, 5466.699331536764, 5487.890242195133, 5537.058700021006, 5126.410462796752, 5127.461616530285, 5130.51260130287, 5137.792618734595, 5150.716710580917, 6095.207623009025, 6101.511879049665, 6102.786402475892, 6102.8779424411705, 6105.389461053904, 3989.40158976153, 4056.6146216109423, 4156.023334516386, 4220.514640816284, 4246.596573325529, 6237.750489980395, 6299.464545513637, 6300.149479820211, 6305.180326557564, 6306.842328941767, 4319.416878721332, 4328.350747387917, 4332.1119170569955, 4346.261135606955, 4354.042110735633, 4333.241682705514, 4395.450568678915, 4395.7362558246605, 4395.890102747393, 4402.691811573223, 5008.398992120896, 5047.924281135786, 5050.873728156826, 5056.165732654144, 5081.771320290596, 6055.697215139226, 6061.030235162353, 6062.545309101835, 6063.120847477091, 6073.605215661057, 1542.367629271993, 1548.2258870564717, 1565.1704596563839, 1565.2095691675631, 1565.3190861975077, 1016.4663551635302, 1060.1995493402433, 1060.48566445274, 1064.584811923335, 1089.8964598363143, 5793.623414478046, 5795.869805387909, 5795.913061304083, 5798.536117110621, 5802.071668533014, 6241.313455519889, 6246.656433896089, 6257.530685198537, 6262.530310226751, 6269.279032911182, 5767.36558978512, 5784.71076446176, 5799.2460980073165, 5802.65184088956, 5804.65172089676, 3264.0860559043504, 3349.9665003349655, 3362.7814192077435, 3384.8476818543227, 3392.6268110507826, 6501.804945851632, 6511.218653761579, 6514.055461958084, 6515.185601799775, 6517.641529715911, 6400.423961843457, 6402.583832050902, 6412.903806442907, 6414.198225221848, 6415.935840641627, 6336.017917222838, 6472.255690595548, 6487.059376390397, 6491.6954481159455, 6501.2198536175965, 6227.844303892439, 6237.594556353823, 6243.063540468785, 6246.718897649707, 6251.71867265965, 6012.278526576839, 6084.543659225487, 6127.387261274015, 6272.278687950761, 6283.434490895841, 6516.543841931209, 6557.0, 6560.8359791003695, 6564.606123632598, 6583.0, 4393.428854248928, 4397.472303323621, 4397.692161548661, 4399.142167277479, 4399.626031787334, 6189.597676151036, 6240.7206522663655, 6300.054991751274, 6310.305866354605, 6313.526485513513, 6094.75620975156, 6135.447809696971, 6142.710030893562, 6146.416090471398, 6167.0, 6137.877242455215, 6139.877202456015, 6148.231471066117, 6152.630842149485, 6161.537884658758, 5837.591368604157, 5964.105384192232, 5984.1323008164445, 5987.790427335022, 5999.580029398075, 6170.444659980623, 6172.475339596184, 6174.413430724074, 6177.0, 6190.2571691397325, 5990.9700451497465, 6022.0, 6026.698665066817, 6037.728302226498, 6038.456538911519], "unit": "score", "name": "prototype.html", "value": 4612.807303613172}, {"lowerIsBetter": false, "replicates": [713.5718568858686, 738.9889151662729, 763.8510490454361, 779.3657437860032, 806.6732973145878, 13564.593062208138, 13769.449222031119, 13817.723645527083, 13825.516106936258, 13839.930800345985, 11406.973372396482, 11547.422628868566, 12841.101122921376, 12933.805992910091, 12947.676308092303, 808.272554700771, 814.5031530766228, 814.9837003259961, 816.5957850863831, 818.1164342510075, 822.1696086952192, 822.761399194236, 823.012385137834, 825.2036784502953, 826.6610689617258, 863.8315528471951, 865.1824026295153, 865.5542395666206, 867.1588559097696, 867.7310033889482, 856.6402111113347, 858.4634603372892, 862.0991064337782, 863.3395452478859, 873.1181506678237, 626.9185005949244, 630.2027934662656, 632.0708558419162, 638.0716058135401, 642.7718160053207, 12399.938000309941, 12450.501979920793, 12484.126111172221, 12486.50053997839, 12538.68653283666, 10515.579376824919, 10757.408342541157, 11039.448027598668, 11083.390413527253, 11460.598879039277, 10009.899901001043, 10054.195664346835, 10061.748456288578, 10156.94921525395, 10171.084602385821, 3620.4207326827845, 3643.398839191557, 3648.21563363878, 3680.392735198689, 3785.867494637702, 42944.0, 43109.35335969963, 44390.33414498785, 46978.295325570485, 47015.52984470146, 9874.0, 9913.752156196153, 9926.602935882629, 9943.502824858728, 9992.700218993441, 17352.47942561725, 17422.56443588895, 17633.118344083003, 17838.0, 17868.374606888698, 6829.760958366433, 6831.28271531492, 6986.0, 6989.685464154125, 7028.578285302899, 4173.31140361843, 4187.330027195634, 4197.664186865043, 4217.97891010543, 4240.279152544075, 3051.969480305213, 3084.722374986262, 3086.1513083902105, 3089.0, 3089.1968088297203, 554.5979165105347, 560.4395604395604, 561.1134407635925, 563.9295088113986, 566.6147020026422, 539.3608573840012, 548.9121740521498, 595.1786534582335, 631.766246488802, 689.3726708695164, 8257.669693212205, 8310.958445207856, 8523.872141917876, 8586.87119693205, 8988.10118988109, 526.1896679114121, 531.9707416092075, 533.6184627991005, 550.9366422861423, 637.4740838808002, 3860.613938606117, 3913.471681323042, 4005.679545636342, 4096.672266218696, 4127.938080928789, 53849.1922621161, 54589.727051365284, 54650.45349546533, 54812.0, 55306.446935530934, 45097.32354014692, 46234.0, 47421.762891185324, 47795.0, 48514.75742621264, 48061.279080813816, 48394.27408588874, 48885.0, 49742.25386619203, 49973.25040124474, 8248.670053197804, 8505.23452889243, 8625.223729864343, 8953.28373730087, 9062.365634405529, 33711.22374511364, 33719.325613487104, 34524.654753452145, 34822.30355392827, 35276.29447411089, 41607.79196104, 42332.57667423409, 42847.92880177896, 45319.546804531536, 45599.0, 10774.784504309713, 11015.889841101487, 11078.279911806028, 11127.944360278147, 11544.249623774427, 11077.390743509184, 11565.768684626428, 11608.30350178992, 11975.580854670394, 11989.0, 10414.947925260325, 10581.52383142745, 10966.780664386828, 11047.0, 11352.602658906899, 10900.890991089987, 11316.15128865322, 11381.772364552497, 11415.143864210051, 11760.823917608514, 10579.36523808574, 10996.23026388145, 11028.22802403824, 11413.885861141282, 11540.192186546861, 9619.951900240454, 9678.370905891095, 9745.561449734638, 9769.755756106155, 9808.264380171373, 8517.403781735218, 8997.32520060985, 9052.0, 9088.278147017167, 9132.0], "unit": "score", "name": "yui.html", "value": 6142.634429476533}], "name": "dromaeo_css", "value": 6820.948294528115}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 107.0, 112.0, 114.0, 113.0, 102.0, 113.0, 112.0, 118.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 159.0, 169.0, 131.0, 156.0, 149.0, 125.0, 172.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 164.0, 161.0, 161.0, 162.0, 159.0, 164.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 94.0, 94.0, 73.0, 75.0, 73.0, 109.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.4}, {"lowerIsBetter": true, "replicates": [97.0, 99.0, 141.0, 96.0, 98.0, 96.0, 142.0, 96.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 111.0, 109.0, 110.0, 110.0, 110.0, 111.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 60.0, 58.0, 59.0, 58.0, 59.0, 58.0, 63.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 70.0, 68.0, 69.0, 68.0, 68.0, 68.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 88.0, 87.0, 86.0, 86.0, 86.0, 85.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [119.0, 122.0, 122.0, 126.0, 134.0, 116.0, 119.0, 118.0, 120.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [149.0, 155.0, 159.0, 154.0, 156.0, 153.0, 155.0, 155.0, 166.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.9}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 68.0, 70.0, 70.0, 69.0, 68.0, 74.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1526.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [195.35065442469232], "unit": "score", "name": "DeltaBlue", "value": 338.45804200000003}, {"lowerIsBetter": false, "replicates": [286.20492272467084], "unit": "score", "name": "Encrypt", "value": 930.036414}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1114.8272017837235], "unit": "score", "name": "RayTrace", "value": 663.7701329999999}, {"lowerIsBetter": false, "replicates": [801.2820512820513], "unit": "score", "name": "Earley", "value": 831.745824}, {"lowerIsBetter": false, "replicates": [12658.227848101265], "unit": "score", "name": "Boyer", "value": 52.65057700000003}, {"lowerIsBetter": false, "replicates": [25897.4358974359], "unit": "score", "name": "RegExp", "value": 35.17664851485149}, {"lowerIsBetter": false, "replicates": [643.0868167202573], "unit": "score", "name": "Splay", "value": 126.71850499999996}, {"lowerIsBetter": false, "replicates": [4868.9320388349515], "unit": "score", "name": "NavierStokes", "value": 304.7896311066801}], "name": "v8_7", "value": 20638.1073549543}]} 11:26:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20638.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1526.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6820.95"}}} 11:26:40 INFO - Return code: 0 11:26:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:26:40 INFO - # TBPL SUCCESS # 11:26:40 INFO - Running post-action listener: _resource_record_post_action 11:26:40 INFO - Running post-run listener: _resource_record_post_run 11:26:41 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 560029696; Read time: 32; Write time: 981896 11:26:41 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 245714944; Read time: 0; Write time: 464276 11:26:41 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314314752; Read time: 32; Write time: 517620 11:26:41 INFO - Running post-run listener: _upload_blobber_files 11:26:41 INFO - Blob upload gear active. 11:26:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:26:41 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:26:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:26:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:26:41 INFO - (blobuploader) - INFO - Open directory for files ... 11:26:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:26:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:26:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:42 INFO - (blobuploader) - INFO - Done attempting. 11:26:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:26:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:26:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:43 INFO - (blobuploader) - INFO - Done attempting. 11:26:43 INFO - (blobuploader) - INFO - Iteration through files over. 11:26:43 INFO - Return code: 0 11:26:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:26:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:26:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/28b171cb06d0df76bda650e08e0335728c3ee070934ef6c2b9ca7c4600c610b16065a0cd313657e55e58f59a8267a491fed2118fb23bbab483f710c03c320ca1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/15747d38571c6f5d4cc9b70c75a79b2b5a64b42cd9f7935a7a6c4040b706fc922285f3f1f13a7a56f097315eca928b79af42f33b2a3323dba4cde4cb258a564b"} 11:26:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:26:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:26:43 INFO - Contents: 11:26:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/28b171cb06d0df76bda650e08e0335728c3ee070934ef6c2b9ca7c4600c610b16065a0cd313657e55e58f59a8267a491fed2118fb23bbab483f710c03c320ca1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/15747d38571c6f5d4cc9b70c75a79b2b5a64b42cd9f7935a7a6c4040b706fc922285f3f1f13a7a56f097315eca928b79af42f33b2a3323dba4cde4cb258a564b"} 11:26:43 INFO - Copying logs to upload dir... 11:26:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.279501 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-03 11:26:41.519134) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-03 11:26:41.522918) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759 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/28b171cb06d0df76bda650e08e0335728c3ee070934ef6c2b9ca7c4600c610b16065a0cd313657e55e58f59a8267a491fed2118fb23bbab483f710c03c320ca1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/15747d38571c6f5d4cc9b70c75a79b2b5a64b42cd9f7935a7a6c4040b706fc922285f3f1f13a7a56f097315eca928b79af42f33b2a3323dba4cde4cb258a564b"} build_url:https://queue.taskcluster.net/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/UF5YGKpgT9Kiu6Pa0PHLLQ/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/28b171cb06d0df76bda650e08e0335728c3ee070934ef6c2b9ca7c4600c610b16065a0cd313657e55e58f59a8267a491fed2118fb23bbab483f710c03c320ca1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/15747d38571c6f5d4cc9b70c75a79b2b5a64b42cd9f7935a7a6c4040b706fc922285f3f1f13a7a56f097315eca928b79af42f33b2a3323dba4cde4cb258a564b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-03 11:26:41.548348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 11:26:41.548753) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451837673.925846-1351084759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 11:26:41.633680) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-03 11:26:41.634160) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-03 11:26:41.634633) ========= ========= Total master_lag: 0.26 =========