builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1450885589.41 results: success (0) buildid: 20151223053002 builduid: 0bd4b4d2207c4b06b5e986e37b09b2d7 revision: e41477a7325cea2e99b4e8d2be97c77356dfb2bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.409950) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.410454) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.410751) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006174 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.432982) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.433284) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.446426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.446773) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.495340) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.495675) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.496097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.496394) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-23 07:46:29-- 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% 17.5M=0.001s 2015-12-23 07:46:29 (17.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104109 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.612926) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.613234) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022651 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.662520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:29.662862) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e41477a7325cea2e99b4e8d2be97c77356dfb2bc --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 e41477a7325cea2e99b4e8d2be97c77356dfb2bc --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=d60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-23 07:46:29,961 truncating revision to first 12 chars 2015-12-23 07:46:29,961 Setting DEBUG logging. 2015-12-23 07:46:29,961 attempt 1/10 2015-12-23 07:46:29,961 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/e41477a7325c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-23 07:46:30,308 unpacking tar archive at: b2g-inbound-e41477a7325c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.614729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:30.290535) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:30.290852) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:30.301228) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:30.301648) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 07:46:30.302100) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-23 07:46:30.302430) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --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', '--system-bits', '64', '--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=d60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:46:30 INFO - MultiFileLogger online at 20151223 07:46:30 in /builds/slave/test-pgo 07:46:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 07:46:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:46:30 INFO - {'append_to_log': False, 07:46:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:46:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 07:46:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:46:30 INFO - 'branch': 'B2G-Inbound', 07:46:30 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:30 INFO - 'config_files': ('talos/linux_config.py',), 07:46:30 INFO - 'default_actions': ('clobber', 07:46:30 INFO - 'read-buildbot-config', 07:46:30 INFO - 'download-and-extract', 07:46:30 INFO - 'populate-webroot', 07:46:30 INFO - 'create-virtualenv', 07:46:30 INFO - 'install', 07:46:30 INFO - 'run-tests'), 07:46:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:30 INFO - 'download_minidump_stackwalk': True, 07:46:30 INFO - 'download_symbols': 'ondemand', 07:46:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:46:30 INFO - 'tooltool.py': '/tools/tooltool.py', 07:46:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:46:30 INFO - '/tools/misc-python/virtualenv.py')}, 07:46:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:30 INFO - 'installer_path': 'installer.exe', 07:46:30 INFO - 'log_level': 'info', 07:46:30 INFO - 'log_name': 'talos', 07:46:30 INFO - 'log_to_console': True, 07:46:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:46:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:46:30 INFO - 'opt_config_files': (), 07:46:30 INFO - 'pip_index': False, 07:46:30 INFO - 'sps_profile': False, 07:46:30 INFO - 'sps_profile_interval': 0, 07:46:30 INFO - 'suite': 'dromaeojs', 07:46:30 INFO - 'system_bits': '64', 07:46:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:30 INFO - 'title': 'talos-linux64-ix-019', 07:46:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:30 INFO - 'use_talos_json': True, 07:46:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:46:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:30 INFO - 'work_dir': 'build'} 07:46:30 INFO - ##### 07:46:30 INFO - ##### Running clobber step. 07:46:30 INFO - ##### 07:46:30 INFO - Running pre-action listener: _resource_record_pre_action 07:46:30 INFO - Running main action method: clobber 07:46:30 INFO - rmtree: /builds/slave/test-pgo/build 07:46:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:46:31 INFO - Running post-action listener: _resource_record_post_action 07:46:31 INFO - ##### 07:46:31 INFO - ##### Running read-buildbot-config step. 07:46:31 INFO - ##### 07:46:31 INFO - Running pre-action listener: _resource_record_pre_action 07:46:31 INFO - Running main action method: read_buildbot_config 07:46:31 INFO - Using buildbot properties: 07:46:31 INFO - { 07:46:31 INFO - "project": "", 07:46:31 INFO - "product": "firefox", 07:46:31 INFO - "script_repo_revision": "production", 07:46:31 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 07:46:31 INFO - "repository": "", 07:46:31 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 07:46:31 INFO - "buildid": "20151223053002", 07:46:31 INFO - "pgo_build": "True", 07:46:31 INFO - "basedir": "/builds/slave/test-pgo", 07:46:31 INFO - "buildnumber": 0, 07:46:31 INFO - "slavename": "talos-linux64-ix-019", 07:46:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:46:31 INFO - "platform": "ubuntu64_hw", 07:46:31 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 07:46:31 INFO - "branch": "b2g-inbound", 07:46:31 INFO - "repo_path": "integration/b2g-inbound", 07:46:31 INFO - "revision": "e41477a7325cea2e99b4e8d2be97c77356dfb2bc", 07:46:31 INFO - "stage_platform": "linux64-pgo", 07:46:31 INFO - "builduid": "0bd4b4d2207c4b06b5e986e37b09b2d7", 07:46:31 INFO - "slavebuilddir": "test" 07:46:31 INFO - } 07:46:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:46:31 INFO - Running post-action listener: _resource_record_post_action 07:46:31 INFO - ##### 07:46:31 INFO - ##### Running download-and-extract step. 07:46:31 INFO - ##### 07:46:31 INFO - Running pre-action listener: _resource_record_pre_action 07:46:31 INFO - Running main action method: download_and_extract 07:46:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:46:31 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')]} 07:46:31 INFO - https://queue.taskcluster.net/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:46:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/test_packages.json 07:46:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/test_packages.json 07:46:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:46:31 INFO - Downloaded 1302 bytes. 07:46:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:46:31 INFO - Using the following test package requirements: 07:46:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:46:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:46:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'jsshell-linux-x86_64.zip'], 07:46:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:46:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:46:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:46:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:46:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:46:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:46:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:46:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:46:31 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')]} 07:46:31 INFO - https://queue.taskcluster.net/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:46:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:46:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:46:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/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 07:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/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 07:46:32 INFO - Downloaded 23180327 bytes. 07:46:32 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 07:46:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:46:32 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 07:46:33 INFO - Return code: 0 07:46:33 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 07:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:33 INFO - https://queue.taskcluster.net/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:46:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:46:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:46:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/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 07:46:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/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 07:46:34 INFO - Downloaded 23180327 bytes. 07:46:34 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 07:46:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:46:34 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 07:46:36 INFO - Return code: 0 07:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:36 INFO - https://queue.taskcluster.net/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:46:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:46:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:46:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/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 07:46:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/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 07:46:37 INFO - Downloaded 11132277 bytes. 07:46:37 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 07:46:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:46:37 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 07:46:37 INFO - Return code: 0 07:46: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')]} 07:46:37 INFO - https://queue.taskcluster.net/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:46:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:46:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:46:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/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 07:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJGqjjwnSQW3ipv_GUen1w/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 07:46:38 INFO - Downloaded 54834737 bytes. 07:46:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:46:38 INFO - mkdir: /builds/slave/test-pgo/properties 07:46:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:46:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:46:38 INFO - Contents: 07:46:38 INFO - build_url:https://queue.taskcluster.net/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:46:38 INFO - Running post-action listener: _resource_record_post_action 07:46:38 INFO - Running post-action listener: set_extra_try_arguments 07:46:38 INFO - ##### 07:46:38 INFO - ##### Running populate-webroot step. 07:46:38 INFO - ##### 07:46:38 INFO - Running pre-action listener: _resource_record_pre_action 07:46:38 INFO - Running main action method: populate_webroot 07:46:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:38 INFO - '--tppagecycles', 07:46:38 INFO - '7'], 07:46:38 INFO - 'tests': ['tsvgm']}}, 07:46:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:46:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:46:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:46:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:46:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:46:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:38 INFO - 'talos_options': ['--e10s'], 07:46:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:38 INFO - 'tests': ['damp', 'tps']}, 07:46:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:38 INFO - 'talos_options': ['--e10s'], 07:46:38 INFO - 'tests': ['damp', 'tps']}, 07:46:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:46:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:38 INFO - 'other': {'tests': ['a11yr', 07:46:38 INFO - 'ts_paint', 07:46:38 INFO - 'tpaint', 07:46:38 INFO - 'sessionrestore', 07:46:38 INFO - 'sessionrestore_no_auto_restore']}, 07:46:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:46:38 INFO - 'tests': ['a11yr', 07:46:38 INFO - 'ts_paint', 07:46:38 INFO - 'tpaint', 07:46:38 INFO - 'sessionrestore', 07:46:38 INFO - 'sessionrestore_no_auto_restore']}, 07:46:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:46:38 INFO - 'tests': ['a11yr', 07:46:38 INFO - 'ts_paint', 07:46:38 INFO - 'tpaint', 07:46:38 INFO - 'sessionrestore', 07:46:38 INFO - 'sessionrestore_no_auto_restore']}, 07:46:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:46:38 INFO - 'tests': ['a11yr', 07:46:38 INFO - 'ts_paint', 07:46:38 INFO - 'tpaint', 07:46:38 INFO - 'sessionrestore', 07:46:38 INFO - 'sessionrestore_no_auto_restore']}, 07:46:38 INFO - 'other_l64': {'tests': ['a11yr', 07:46:38 INFO - 'ts_paint', 07:46:38 INFO - 'tpaint', 07:46:38 INFO - 'sessionrestore', 07:46:38 INFO - 'sessionrestore_no_auto_restore']}, 07:46:38 INFO - 'other_nol64': {'tests': ['a11yr', 07:46:38 INFO - 'ts_paint', 07:46:38 INFO - 'tpaint', 07:46:38 INFO - 'sessionrestore', 07:46:38 INFO - 'sessionrestore_no_auto_restore']}, 07:46:38 INFO - 'svgr': {'tests': ['tsvgx', 07:46:38 INFO - 'tsvgr_opacity', 07:46:38 INFO - 'tart', 07:46:38 INFO - 'tscrollx', 07:46:38 INFO - 'cart']}, 07:46:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:46:38 INFO - 'tests': ['tsvgx', 07:46:38 INFO - 'tsvgr_opacity', 07:46:38 INFO - 'tart', 07:46:38 INFO - 'tscrollx', 07:46:38 INFO - 'cart']}, 07:46:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:38 INFO - 'tests': ['tp5o']}, 07:46:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:38 INFO - 'talos_options': ['--e10s'], 07:46:38 INFO - 'tests': ['tp5o']}, 07:46:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:38 INFO - 'talos_options': ['--xperf_path', 07:46:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:38 INFO - 'tests': ['tp5n']}, 07:46:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:38 INFO - 'talos_options': ['--e10s', 07:46:38 INFO - '--xperf_path', 07:46:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:38 INFO - 'tests': ['tp5n']}}, 07:46:38 INFO - 'talos.zip': {'path': '', 07:46:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:38 INFO - Running post-action listener: _resource_record_post_action 07:46:38 INFO - ##### 07:46:38 INFO - ##### Running create-virtualenv step. 07:46:38 INFO - ##### 07:46:38 INFO - Running pre-action listener: _resource_record_pre_action 07:46:38 INFO - Running main action method: create_virtualenv 07:46:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:46:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 07:46:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:46:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:38 INFO - Using real prefix '/usr' 07:46:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:46:39 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:41 INFO - Installing pip.................done. 07:46:41 INFO - Return code: 0 07:46:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:46: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')]} 07:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6741cb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', '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 07:46:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:46:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:46:41 INFO - Using env: {'DISPLAY': ':0', 07:46:41 INFO - 'HOME': '/home/cltbld', 07:46:41 INFO - 'LANG': 'en_US.UTF-8', 07:46:41 INFO - 'LANGUAGE': 'en_US:en', 07:46:41 INFO - 'LOGNAME': 'cltbld', 07:46:41 INFO - 'MAIL': '/var/mail/cltbld', 07:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:41 INFO - 'MOZ_NO_REMOTE': '1', 07:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:41 INFO - 'NO_EM_RESTART': '1', 07:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:41 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:41 INFO - 'SHELL': '/bin/bash', 07:46:41 INFO - 'SHLVL': '1', 07:46:41 INFO - 'TERM': 'linux', 07:46:41 INFO - 'TMOUT': '86400', 07:46:41 INFO - 'USER': 'cltbld', 07:46:41 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', 07:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:41 INFO - '_': '/tools/buildbot/bin/python'} 07:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:46:41 INFO - Cleaning up... 07:46:41 INFO - Return code: 0 07:46:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:46: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')]} 07:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6741cb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', '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 07:46:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:46:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:46:41 INFO - Using env: {'DISPLAY': ':0', 07:46:41 INFO - 'HOME': '/home/cltbld', 07:46:41 INFO - 'LANG': 'en_US.UTF-8', 07:46:41 INFO - 'LANGUAGE': 'en_US:en', 07:46:41 INFO - 'LOGNAME': 'cltbld', 07:46:41 INFO - 'MAIL': '/var/mail/cltbld', 07:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:41 INFO - 'MOZ_NO_REMOTE': '1', 07:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:41 INFO - 'NO_EM_RESTART': '1', 07:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:41 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:41 INFO - 'SHELL': '/bin/bash', 07:46:41 INFO - 'SHLVL': '1', 07:46:41 INFO - 'TERM': 'linux', 07:46:41 INFO - 'TMOUT': '86400', 07:46:41 INFO - 'USER': 'cltbld', 07:46:41 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', 07:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:41 INFO - '_': '/tools/buildbot/bin/python'} 07:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:41 INFO - Downloading/unpacking psutil>=0.7.1 07:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:46:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:46:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:43 INFO - Installing collected packages: psutil 07:46:43 INFO - Running setup.py install for psutil 07:46:43 INFO - building 'psutil._psutil_linux' extension 07:46:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:46:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:46:43 INFO - building 'psutil._psutil_posix' extension 07:46:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:46:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:46:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:43 INFO - Successfully installed psutil 07:46:43 INFO - Cleaning up... 07:46:43 INFO - Return code: 0 07:46:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:44 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 0x7f6741cb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', '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 07:46:44 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 07:46:44 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 07:46:44 INFO - Using env: {'DISPLAY': ':0', 07:46:44 INFO - 'HOME': '/home/cltbld', 07:46:44 INFO - 'LANG': 'en_US.UTF-8', 07:46:44 INFO - 'LANGUAGE': 'en_US:en', 07:46:44 INFO - 'LOGNAME': 'cltbld', 07:46:44 INFO - 'MAIL': '/var/mail/cltbld', 07:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:44 INFO - 'MOZ_NO_REMOTE': '1', 07:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:44 INFO - 'NO_EM_RESTART': '1', 07:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:44 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:44 INFO - 'SHELL': '/bin/bash', 07:46:44 INFO - 'SHLVL': '1', 07:46:44 INFO - 'TERM': 'linux', 07:46:44 INFO - 'TMOUT': '86400', 07:46:44 INFO - 'USER': 'cltbld', 07:46:44 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', 07:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:44 INFO - '_': '/tools/buildbot/bin/python'} 07:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:46:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:46:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:46:45 INFO - Installing collected packages: mozsystemmonitor 07:46:45 INFO - Running setup.py install for mozsystemmonitor 07:46:46 INFO - Successfully installed mozsystemmonitor 07:46:46 INFO - Cleaning up... 07:46:46 INFO - Return code: 0 07:46:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:46: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')]} 07:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6741cb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', '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 07:46:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:46:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:46:46 INFO - Using env: {'DISPLAY': ':0', 07:46:46 INFO - 'HOME': '/home/cltbld', 07:46:46 INFO - 'LANG': 'en_US.UTF-8', 07:46:46 INFO - 'LANGUAGE': 'en_US:en', 07:46:46 INFO - 'LOGNAME': 'cltbld', 07:46:46 INFO - 'MAIL': '/var/mail/cltbld', 07:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:46 INFO - 'MOZ_NO_REMOTE': '1', 07:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:46 INFO - 'NO_EM_RESTART': '1', 07:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:46 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:46 INFO - 'SHELL': '/bin/bash', 07:46:46 INFO - 'SHLVL': '1', 07:46:46 INFO - 'TERM': 'linux', 07:46:46 INFO - 'TMOUT': '86400', 07:46:46 INFO - 'USER': 'cltbld', 07:46:46 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', 07:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:46 INFO - '_': '/tools/buildbot/bin/python'} 07:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:46 INFO - Downloading/unpacking blobuploader==1.2.4 07:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:47 INFO - Downloading blobuploader-1.2.4.tar.gz 07:46:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:46:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:46:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:46:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:46:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:48 INFO - Downloading docopt-0.6.1.tar.gz 07:46:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:46:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:46:48 INFO - Installing collected packages: blobuploader, requests, docopt 07:46:48 INFO - Running setup.py install for blobuploader 07:46:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:46:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:46:48 INFO - Running setup.py install for requests 07:46:49 INFO - Running setup.py install for docopt 07:46:49 INFO - Successfully installed blobuploader requests docopt 07:46:49 INFO - Cleaning up... 07:46:49 INFO - Return code: 0 07:46:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:46: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')]} 07:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6741cb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', '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 07:46:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:46:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:46:49 INFO - Using env: {'DISPLAY': ':0', 07:46:49 INFO - 'HOME': '/home/cltbld', 07:46:49 INFO - 'LANG': 'en_US.UTF-8', 07:46:49 INFO - 'LANGUAGE': 'en_US:en', 07:46:49 INFO - 'LOGNAME': 'cltbld', 07:46:49 INFO - 'MAIL': '/var/mail/cltbld', 07:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:49 INFO - 'MOZ_NO_REMOTE': '1', 07:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:49 INFO - 'NO_EM_RESTART': '1', 07:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:49 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:49 INFO - 'SHELL': '/bin/bash', 07:46:49 INFO - 'SHLVL': '1', 07:46:49 INFO - 'TERM': 'linux', 07:46:49 INFO - 'TMOUT': '86400', 07:46:49 INFO - 'USER': 'cltbld', 07:46:49 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', 07:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:49 INFO - '_': '/tools/buildbot/bin/python'} 07:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:46:49 INFO - Running setup.py (path:/tmp/pip-0eXtcN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:46:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:46:49 INFO - Running setup.py (path:/tmp/pip-wE3vPp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:46:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:46:49 INFO - Running setup.py (path:/tmp/pip-v6YzcK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:46:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:46:49 INFO - Running setup.py (path:/tmp/pip-ZAygqt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:46:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:46:49 INFO - Running setup.py (path:/tmp/pip-VJzjZL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:46:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:46:49 INFO - Running setup.py (path:/tmp/pip-JnbHwR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:46:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:46:49 INFO - Running setup.py (path:/tmp/pip-Ocp9OB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:46:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:46:50 INFO - Running setup.py (path:/tmp/pip-MLrdwS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:46:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:46:50 INFO - Running setup.py (path:/tmp/pip-Dn_6oM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:46:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:46:50 INFO - Running setup.py (path:/tmp/pip-EdOwek-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:46:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:46:50 INFO - Running setup.py (path:/tmp/pip-56DMYH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:46:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:46:50 INFO - Running setup.py (path:/tmp/pip-XFfyNf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:46:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:46:50 INFO - Running setup.py (path:/tmp/pip-Xe955p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:46:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:46:50 INFO - Running setup.py (path:/tmp/pip-jwmGkp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:46:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:46:50 INFO - Running setup.py (path:/tmp/pip-BChq5K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:46:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:46:50 INFO - Running setup.py (path:/tmp/pip-ih4h5o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:46:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:46:50 INFO - Running setup.py (path:/tmp/pip-MODfU_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:46:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:46:50 INFO - Running setup.py install for manifestparser 07:46:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:46:50 INFO - Running setup.py install for mozcrash 07:46:50 INFO - Running setup.py install for mozdebug 07:46:51 INFO - Running setup.py install for mozdevice 07:46:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:46:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:46:51 INFO - Running setup.py install for mozfile 07:46:51 INFO - Running setup.py install for mozhttpd 07:46:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:46:51 INFO - Running setup.py install for mozinfo 07:46:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:46:51 INFO - Running setup.py install for mozInstall 07:46:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:46:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:46:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:46:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:46:51 INFO - Running setup.py install for mozleak 07:46:51 INFO - Running setup.py install for mozlog 07:46:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:46:51 INFO - Running setup.py install for moznetwork 07:46:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:46:51 INFO - Running setup.py install for mozprocess 07:46:51 INFO - Running setup.py install for mozprofile 07:46:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:46:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:46:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:46:52 INFO - Running setup.py install for mozrunner 07:46:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:46:52 INFO - Running setup.py install for mozscreenshot 07:46:52 INFO - Running setup.py install for moztest 07:46:52 INFO - Running setup.py install for mozversion 07:46:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:46:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:46:52 INFO - Cleaning up... 07:46:52 INFO - Return code: 0 07:46:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:46: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')]} 07:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6741cb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', '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 07:46:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:46:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:46:52 INFO - Using env: {'DISPLAY': ':0', 07:46:52 INFO - 'HOME': '/home/cltbld', 07:46:52 INFO - 'LANG': 'en_US.UTF-8', 07:46:52 INFO - 'LANGUAGE': 'en_US:en', 07:46:52 INFO - 'LOGNAME': 'cltbld', 07:46:52 INFO - 'MAIL': '/var/mail/cltbld', 07:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:52 INFO - 'MOZ_NO_REMOTE': '1', 07:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:52 INFO - 'NO_EM_RESTART': '1', 07:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:52 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:52 INFO - 'SHELL': '/bin/bash', 07:46:52 INFO - 'SHLVL': '1', 07:46:52 INFO - 'TERM': 'linux', 07:46:52 INFO - 'TMOUT': '86400', 07:46:52 INFO - 'USER': 'cltbld', 07:46:52 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', 07:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:52 INFO - '_': '/tools/buildbot/bin/python'} 07:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:46:52 INFO - Running setup.py (path:/tmp/pip-ro44CL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 07:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:46:52 INFO - Running setup.py (path:/tmp/pip-ETvjvY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:46:52 INFO - Running setup.py (path:/tmp/pip-pANxcL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:46:52 INFO - Running setup.py (path:/tmp/pip-nFB3J7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:46:53 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)) 07:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:46:53 INFO - Running setup.py (path:/tmp/pip-twAH8Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 07:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:46:53 INFO - Running setup.py (path:/tmp/pip-JsWxOg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 07:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:46:53 INFO - Running setup.py (path:/tmp/pip-p3zUxX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 07:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:46:53 INFO - Running setup.py (path:/tmp/pip-ody_1Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 07:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:46:53 INFO - Running setup.py (path:/tmp/pip-mRYDwd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 07:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:46:53 INFO - Running setup.py (path:/tmp/pip-lmqb03-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:46:53 INFO - Running setup.py (path:/tmp/pip-wRZh9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 07:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:46:53 INFO - Running setup.py (path:/tmp/pip-j6tVK2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 07:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:46:53 INFO - Running setup.py (path:/tmp/pip-18erSK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:46:53 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)) 07:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:46:53 INFO - Running setup.py (path:/tmp/pip-PvSdye-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 07:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:46:53 INFO - Running setup.py (path:/tmp/pip-CYF4DA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 07:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:46:53 INFO - Running setup.py (path:/tmp/pip-TtCroY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 07:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:46:53 INFO - Running setup.py (path:/tmp/pip-NR9eyj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:46:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46:55 INFO - Downloading blessings-1.5.1.tar.gz 07:46:55 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:46:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:46:55 INFO - Installing collected packages: blessings 07:46:55 INFO - Running setup.py install for blessings 07:46:55 INFO - Successfully installed blessings 07:46:55 INFO - Cleaning up... 07:46:55 INFO - Return code: 0 07:46:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:46:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:46:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:46:56 INFO - Reading from file tmpfile_stdout 07:46:56 INFO - Current package versions: 07:46:56 INFO - argparse == 1.2.1 07:46:56 INFO - blessings == 1.5.1 07:46:56 INFO - blobuploader == 1.2.4 07:46:56 INFO - docopt == 0.6.1 07:46:56 INFO - manifestparser == 1.1 07:46:56 INFO - mozInstall == 1.12 07:46:56 INFO - mozcrash == 0.16 07:46:56 INFO - mozdebug == 0.1 07:46:56 INFO - mozdevice == 0.47 07:46:56 INFO - mozfile == 1.2 07:46:56 INFO - mozhttpd == 0.7 07:46:56 INFO - mozinfo == 0.9 07:46:56 INFO - mozleak == 0.1 07:46:56 INFO - mozlog == 3.1 07:46:56 INFO - moznetwork == 0.27 07:46:56 INFO - mozprocess == 0.22 07:46:56 INFO - mozprofile == 0.28 07:46:56 INFO - mozrunner == 6.11 07:46:56 INFO - mozscreenshot == 0.1 07:46:56 INFO - mozsystemmonitor == 0.0 07:46:56 INFO - moztest == 0.7 07:46:56 INFO - mozversion == 1.4 07:46:56 INFO - psutil == 3.1.1 07:46:56 INFO - requests == 1.2.3 07:46:56 INFO - wsgiref == 0.1.2 07:46:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6741cb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', '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 07:46:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 07:46:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:46:56 INFO - Using env: {'DISPLAY': ':0', 07:46:56 INFO - 'HOME': '/home/cltbld', 07:46:56 INFO - 'LANG': 'en_US.UTF-8', 07:46:56 INFO - 'LANGUAGE': 'en_US:en', 07:46:56 INFO - 'LOGNAME': 'cltbld', 07:46:56 INFO - 'MAIL': '/var/mail/cltbld', 07:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:56 INFO - 'MOZ_NO_REMOTE': '1', 07:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:56 INFO - 'NO_EM_RESTART': '1', 07:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:56 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:56 INFO - 'SHELL': '/bin/bash', 07:46:56 INFO - 'SHLVL': '1', 07:46:56 INFO - 'TERM': 'linux', 07:46:56 INFO - 'TMOUT': '86400', 07:46:56 INFO - 'USER': 'cltbld', 07:46:56 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', 07:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:56 INFO - '_': '/tools/buildbot/bin/python'} 07:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:56 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)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:46:56 INFO - Cleaning up... 07:46:56 INFO - Return code: 0 07:46:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6741cb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', '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 07:46:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:46:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:46:56 INFO - Using env: {'DISPLAY': ':0', 07:46:56 INFO - 'HOME': '/home/cltbld', 07:46:56 INFO - 'LANG': 'en_US.UTF-8', 07:46:56 INFO - 'LANGUAGE': 'en_US:en', 07:46:56 INFO - 'LOGNAME': 'cltbld', 07:46:56 INFO - 'MAIL': '/var/mail/cltbld', 07:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:56 INFO - 'MOZ_NO_REMOTE': '1', 07:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:56 INFO - 'NO_EM_RESTART': '1', 07:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:56 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:56 INFO - 'SHELL': '/bin/bash', 07:46:56 INFO - 'SHLVL': '1', 07:46:56 INFO - 'TERM': 'linux', 07:46:56 INFO - 'TMOUT': '86400', 07:46:56 INFO - 'USER': 'cltbld', 07:46:56 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', 07:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:56 INFO - '_': '/tools/buildbot/bin/python'} 07:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:56 INFO - Downloading/unpacking jsonschema 07:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:46:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 07:46:58 INFO - Downloading/unpacking functools32 (from jsonschema) 07:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:58 INFO - Downloading functools32-3.2.3-2.tar.gz 07:46:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:46:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:46:58 INFO - warning: no files found matching '*.txt' 07:46:58 INFO - no previously-included directories found matching 'build' 07:46:58 INFO - no previously-included directories found matching 'dist' 07:46:58 INFO - no previously-included directories found matching '.git*' 07:46:58 INFO - Installing collected packages: jsonschema, functools32 07:46:58 INFO - Running setup.py install for functools32 07:46:58 INFO - warning: no files found matching '*.txt' 07:46:58 INFO - no previously-included directories found matching 'build' 07:46:58 INFO - no previously-included directories found matching 'dist' 07:46:58 INFO - no previously-included directories found matching '.git*' 07:46:58 INFO - Successfully installed jsonschema functools32 07:46:58 INFO - Cleaning up... 07:46:58 INFO - Return code: 0 07:46:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:46: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')]} 07:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6741cb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', '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 07:46:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:46:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:46:58 INFO - Using env: {'DISPLAY': ':0', 07:46:58 INFO - 'HOME': '/home/cltbld', 07:46:58 INFO - 'LANG': 'en_US.UTF-8', 07:46:58 INFO - 'LANGUAGE': 'en_US:en', 07:46:58 INFO - 'LOGNAME': 'cltbld', 07:46:58 INFO - 'MAIL': '/var/mail/cltbld', 07:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:58 INFO - 'MOZ_NO_REMOTE': '1', 07:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:58 INFO - 'NO_EM_RESTART': '1', 07:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:58 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:58 INFO - 'SHELL': '/bin/bash', 07:46:58 INFO - 'SHLVL': '1', 07:46:58 INFO - 'TERM': 'linux', 07:46:58 INFO - 'TMOUT': '86400', 07:46:58 INFO - 'USER': 'cltbld', 07:46:58 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', 07:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:58 INFO - '_': '/tools/buildbot/bin/python'} 07:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:58 INFO - Downloading/unpacking flake8 07:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:47:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 07:47:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:47:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 07:47:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47:01 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 07:47:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:47:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:47:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:47:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:47:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:47:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:47:01 INFO - no previously-included directories found matching 'docs/_build' 07:47:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:47:01 INFO - Running setup.py install for pep8 07:47:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:47:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:47:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:47:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:47:01 INFO - no previously-included directories found matching 'docs/_build' 07:47:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:47:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:47:01 INFO - Cleaning up... 07:47:01 INFO - Return code: 0 07:47:01 INFO - Running post-action listener: _resource_record_post_action 07:47:01 INFO - Running post-action listener: _start_resource_monitoring 07:47:01 INFO - Starting resource monitoring. 07:47:01 INFO - ##### 07:47:01 INFO - ##### Running install step. 07:47:01 INFO - ##### 07:47:01 INFO - Running pre-action listener: _resource_record_pre_action 07:47:01 INFO - Running main action method: install 07:47:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:47:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:47:01 INFO - Reading from file tmpfile_stdout 07:47:01 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:47:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:47:01 INFO - Reading from file tmpfile_stdout 07:47:01 INFO - Output received: 07:47:01 INFO - Usage: mozinstall [options] installer 07:47:01 INFO - Options: 07:47:01 INFO - -h, --help show this help message and exit 07:47:01 INFO - -d DEST, --destination=DEST 07:47:01 INFO - Directory to install application into. [default: 07:47:01 INFO - "/builds/slave/test-pgo"] 07:47:01 INFO - --app=APP Application being installed. [default: firefox] 07:47:01 INFO - mkdir: /builds/slave/test-pgo/build/application 07:47:01 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'] 07:47:01 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 07:47:17 INFO - Reading from file tmpfile_stdout 07:47:17 INFO - Output received: 07:47:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:47:17 INFO - Running post-action listener: _resource_record_post_action 07:47:17 INFO - ##### 07:47:17 INFO - ##### Running run-tests step. 07:47:17 INFO - ##### 07:47:17 INFO - Running pre-action listener: _resource_record_pre_action 07:47:17 INFO - Running main action method: run_tests 07:47:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:47:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:47:17 INFO - Python 2.7.3 07:47:17 INFO - Return code: 0 07:47:17 INFO - grabbing minidump binary from tooltool 07:47:17 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')]} 07:47:17 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 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:47:17 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 07:47:17 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 07:47:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:17 INFO - Return code: 0 07:47:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:47:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:47:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:47:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:47:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:47:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:47:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:47:18 INFO - Return code: 0 07:47:18 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/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 07:47:18 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/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 07:47:18 INFO - Using env: {'DISPLAY': ':0', 07:47:18 INFO - 'HOME': '/home/cltbld', 07:47:18 INFO - 'LANG': 'en_US.UTF-8', 07:47:18 INFO - 'LANGUAGE': 'en_US:en', 07:47:18 INFO - 'LOGNAME': 'cltbld', 07:47:18 INFO - 'MAIL': '/var/mail/cltbld', 07:47:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:47:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:18 INFO - 'MOZ_NO_REMOTE': '1', 07:47:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:18 INFO - 'NO_EM_RESTART': '1', 07:47:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:47:18 INFO - 'PWD': '/builds/slave/test-pgo', 07:47:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:47:18 INFO - 'SHELL': '/bin/bash', 07:47:18 INFO - 'SHLVL': '1', 07:47:18 INFO - 'TERM': 'linux', 07:47:18 INFO - 'TMOUT': '86400', 07:47:18 INFO - 'USER': 'cltbld', 07:47:18 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267', 07:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:18 INFO - '_': '/tools/buildbot/bin/python'} 07:47:18 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/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 07:47:18 INFO - mozversion application_buildid: 20151223053002 07:47:18 INFO - mozversion application_changeset: e41477a7325cea2e99b4e8d2be97c77356dfb2bc 07:47:18 INFO - mozversion application_display_name: Nightly 07:47:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:18 INFO - mozversion application_name: Firefox 07:47:18 INFO - mozversion application_remotingname: firefox 07:47:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 07:47:18 INFO - mozversion application_vendor: Mozilla 07:47:18 INFO - mozversion application_version: 46.0a1 07:47:18 INFO - mozversion platform_buildid: 20151223053002 07:47:18 INFO - mozversion platform_changeset: e41477a7325cea2e99b4e8d2be97c77356dfb2bc 07:47:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 07:47:18 INFO - mozversion platform_version: 46.0a1 07:47:18 INFO - using testdate: 1450885638 07:47:18 INFO - actual date: 1450885638 07:47:18 INFO - starting webserver on 'localhost:56351' 07:47:18 INFO - SUITE-START | Running 3 tests 07:47:18 INFO - TEST-START | dromaeo_css 07:47:18 INFO - operating with platform_type : linux_ 07:47:18 INFO - Initialising browser for dromaeo_css test... 07:47:18 INFO - TEST-INFO | started process 21515 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9QODJ6/profile http://localhost:56351/getInfo.html) 07:47:22 INFO - PROCESS | 21515 | __metrics Screen width/height:1600/1200 07:47:22 INFO - PROCESS | 21515 | colorDepth:24 07:47:22 INFO - PROCESS | 21515 | Browser inner width/height: 1024/697 07:47:22 INFO - PROCESS | 21515 | __metrics 07:47:23 INFO - PROCESS | 21515 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:47:23 INFO - PROCESS | 21515 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:47:24 INFO - TEST-INFO | 21515: exit 0 07:47:24 INFO - Browser initialized. 07:47:24 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:24 INFO - TEST-INFO | started process 21608 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9QODJ6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:36 INFO - PROCESS | 21608 | RSS: Main: 150413312 07:47:36 INFO - PROCESS | 21608 | 07:48:27 INFO - PROCESS | 21608 | 1450885707561 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] 07:50:36 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:56351/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56351/tests/dromaeo/cssquery-ext.html) 07:50:37 INFO - PROCESS | 21608 | RSS: Main: 266260480 07:50:37 INFO - PROCESS | 21608 | 07:53:39 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:56351/tests/dromaeo/cssquery-ext.html (next: http://localhost:56351/tests/dromaeo/cssquery-jquery.html) 07:53:40 INFO - PROCESS | 21608 | RSS: Main: 236892160 07:53:40 INFO - PROCESS | 21608 | 07:56:42 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:56351/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56351/tests/dromaeo/cssquery-mootools.html) 07:56:42 INFO - PROCESS | 21608 | RSS: Main: 232648704 07:56:42 INFO - PROCESS | 21608 | 07:59:44 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:56351/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56351/tests/dromaeo/cssquery-prototype.html) 07:59:45 INFO - PROCESS | 21608 | RSS: Main: 211562496 07:59:45 INFO - PROCESS | 21608 | 08:02:47 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:56351/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56351/tests/dromaeo/cssquery-yui.html) 08:02:48 INFO - PROCESS | 21608 | RSS: Main: 215879680 08:02:48 INFO - PROCESS | 21608 | 08:05:50 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:56351/tests/dromaeo/cssquery-yui.html (next: http://localhost:56351/tests/dromaeo/cssquery-dojo.html) 08:05:51 INFO - PROCESS | 21608 | RSS: Main: 291762176 08:05:51 INFO - PROCESS | 21608 | 08:05:51 INFO - PROCESS | 21608 | __start_tp_report 08:05:51 INFO - PROCESS | 21608 | _x_x_mozilla_page_load 08:05:51 INFO - PROCESS | 21608 | _x_x_mozilla_page_load_details 08:05:51 INFO - PROCESS | 21608 | |i|pagename|runs| 08:05:51 INFO - PROCESS | 21608 | |0;dojo.html;3172.5717028201193;3186.681331866815;3237.854296556655;3246.107320486866;3269.3624743175083;5218.947810521893;5306.257124002643;5379.731013449326;5419.837404877855;5453;5196.636235463519;5237;5257.86855328616;5331.973340133303;5460.645058071223;4823.855284341458;4829.565339119487;4839.201531747275;4878.70727756334;4947.529984651453;4678.719276843401;4926.285688575154;4958.3306253655655;4963.25551167326;5004.349434573519;4854.732989685566;4872.4640289568115;4915.0661374339115;4933.087378834927;4934.777934992934;4873.951260487385;4900.351233296488;4910.459849416561;4947.109520286347;4947.752612369367;4754.263089221176;4857.2714092886;4893.75531223441;4895.632827537914;4955.702657840505;5199.428062913076;5276.92084618731;5285.312909321802;5296.285001524822;5297.152455607084;5924.466797988159;5927;5927.970360148215;5935.228420305376;5942.10868369748;5675.801346952878;5888.499477544414;5950.494207992326;5972.9701351493395;5983.760649574012;5290.470952904679;5402.189671549299;5408.540274076709;5417.322834645669;5425.9728701356635;5902.232709747791;5914.6746928918465;5918.526517878559;5937.2578427696535;5971.134185543072;5583.581231407579;5697.088465845445;5709.857253568611;5710.628809127394;5715.1713001614535;5658.74535645897;5720.8283751487525;5744.310682718101;5778.393268706809;5802.709864506758;5830.679312637761;5844.094165404369;5857.326407463111;5863.501602363847;5919.052951527735;5856.619319744288;5859.2382990211;5860.355360910296;5864.179014937912;5870.207521984563;4340.457442819647;4400.44994375703;4417.911641767147;4505.662075344362;4514.909701806011;4005.0187704012706;4012.217617564547;4015.6185162409524;4035.6367926886132;4043.433919251307;5342.385625653022;5388.488093631099;5398.6220964532895;5409.323834520685;5412.404635490093;5621.971890140523;5731.455511726379;5817.360090390053;5877.235959325346;5887.264091988502;5271.446498117719;5274.393444753902;5284.365876094893;5341.172118321666;5371.838844834661;4921.926171107436;4977;4977.203647416396;5030.496950305013;5090.2364645303505;5850.414958504116;5985.0723137911955;6011.549133814981;6020.157177995085;6027.246594175728;5760.33756118035;5841.649501029951;5869.647821130746;5870.530357571299;5914.7338369774325;5901.085331773582;5943.940560594338;5949.6430214187285;5952.880942381042;5963.403659634176;5529.917051244154;5543.944560554504;5720.771169153354;5732.942670573241;5732.971335143297;5836.270466191726;5847.502962248256;5925.970370148121;5938.346781854079;5980.9401905980385;5718.25662663851;5723.599348045597;5729.455701708331;5737.368889422077;5746.16680581305;5519.254900588369;5651.6043876928225;5659.066254068197;5672.461116193955;5708.172315014383;5538.723063846711;5593.244911936837;5595.132754422908;5621.634593751393;5645.491905728504;5707.971460142839;5723.427657234243;5760.711964401847;5786.218860453785;5841.474267315962;5405.108157154025;5501.092319767194;5599.468050535193;5632.295963004624;5650.745716442688 08:05:51 INFO - PROCESS | 21608 | |1;ext.html;564.5850300029477;600.1777564736312;615.2616859768278;622.2470810319514;635.3678090300152;29311;30071.548926766118;36214.637853621454;36319.818400907956;36339;41144;41596.37605435921;41616.16767664645;41644.37533437001;41794.791026044906;7562.584057876842;7674.347680447141;8713.607887645056;8884.733457996239;8896.955515222448;10481.475926203697;10720.35677859331;10723.946380268088;10742.838857417146;10746.570137194503;10388.896111038906;10461.21540884433;10490.37057776532;10497.37015779052;10497.895021049806;7792.493487923267;7926;10418.635347762829;10581.153507719364;10817.080548153417;10236.385816851012;10370.740731481697;10386.896131038744;10393.636222732244;10396.896031039669;40030.39954400686;40550.39174412386;40558.797206014075;40575.18849622991;40651.59348406507;3044.25415773137;3270.5257737627912;3327.783694059878;3387.6104248011547;3911.7261791674596;30410.239744006354;30421;30473.847630761928;30882.845585772153;31375.215619609466;3988.6011398860173;3990.3415936370466;4102.712810103294;4151.12826306476;4235.428217190671;269498;273504;273854;274013.999999998;274583;58576.707116464146;61513.384866150765;61971.38028619746;61971.69014154901;62025.68987155126;54044;54266.18600720992;54280.185797213075;71339;71741.64129179425;13794.379252933642;13821.861781382258;13931.303434828218;13976.231307278198;13983.44066237339;10266.435346056038;10302.433366164933;10338.638147664795;10356;10356.378617282837;18124.184411701506;18124.365647202285;18124.818751812312;18188.1815318311;21077.367678969655;8015.398845086642;8120.837583248302;8174.754757357289;8227.917720822716;8333.250007499355;957.3346524165638;980.7204946590188;1017.29298137795;1048.8426735989663;1136.6192325570862;28174;28201.474815648045;28445.857770711013;28577.857110714314;28665;1035.1201478743158;1036.891126431729;1070.9196810239264;1071.3893080943787;1074.5486895503907;14512.346944387527;14523.128612283297;14574.489892853699;14587.489437869624;14650.560483185522;372283;372842;372906.1354693209;373309;373526;51823;52564.73717631464;52714;52956;52976.47023529792;1187.3469591724518;1187.7268228307537;1213.6480420677904;1265.7088869560052;1354.7290541891857;27632.30919226955;28649.570256445753;28751;28968.565471518366;29129.56305655459;41173;41554.79222603868;41559;41742;43158;182746;296884;302298;304751;306122;31608.525872112397;32580;32608.184795380304;32617.510737338485;32618.51072233871;41562.58437415587;42058;42233;42567.787161064;42822.57177428186;36155.27689446249;36577.81711091428;36840.81579592085;36883.815580921924;37744.811275943444;35855.28289434249;36350.636493635786;36396.818015909754;36818;36846.44730328993;38773.61226387813;40457.39313910235;40472.39291410572;41236.38145427881;41442.58557414387;29284.56073158947;30438;33079.66920330766;33177.66822331746;33546.832265838515;25148.62277065882;25356.873215633805;25371;25411.745882540938;25874.48251034931 08:05:51 INFO - PROCESS | 21608 | |2;jquery.html;355.9911002224944;356.93867912803574;359.9352116619009;361.47405524961187;365.81160702238344;14617.634559136028;15042.398304067852;16405.34378624855;16772.664546709075;17475.650486990267;14942.626434339147;16309.266083026263;16581.66836663266;17115.058671773048;17118.058506782123;5277.6305658603915;5308.92036619451;5457.317835270591;5458.781648734046;5459.863503412426;5351.036813373591;5389.191621256823;5396.78412863485;5402.35171779385;5404.162354835007;5253.106971814801;5343.625946183749;5354.464553544653;5356.143017117262;5364.91952620711;5359.356877174725;5380.3274590676165;5392.325959255054;5397.892042159155;5398.865028374303;4793.496682848286;4799.640026997954;4801.063792560452;4818.373611430527;4820.566149046603;12170.57402990891;12191.146619736623;12446.377681115999;12545.937270313681;12616.432260548298;2061.1970913664263;2088.905999230038;2101.8738875667354;2259.367377134405;2473.666055082577;9554.808903821955;9625.759356016155;9744.220462362993;9756.219502439788;9784;1779.430582213692;1787.2850859656112;1797.3170195325692;1800.4328636479468;1808.4574627611664;49549.54061079909;50957.490425095646;54569.9999999996;61815.381846181415;64631.67684161596;9453.480058596706;9878.357906736039;9893.802123957481;9958.601655933682;10023.899761002442;13091.149075310075;13158.802617960739;13172.670683232996;13176.60470185896;13214.537491187762;6791.252962174157;6857.73131970587;6921.688524016331;6937.653117344113;6955.89566156508;6563.278039415661;6581.736730530725;6606.141201643755;6638.634875081917;6648.268690444047;4345.587169218919;4406.603405693439;4414.073044660593;4434.201843668106;4467.798949047301;1799.796362474797;1807.3583877723481;1819.454163750896;1825.2790147891508;1864.4872660018602;905.3210092430677;926.1340646495414;933.2580598424269;943.2925306020485;1042.3068659341452;16329.591760206089;16450.917745411436;17074.57313567146;17187.140642967803;17745.80575496397;906.6826610686339;938.9718308450757;968.7093871838562;1015.9288849780593;1083.5774048121239;7143.535670181422;9168.404053736485;9291.256699464027;9323.160915517636;9370.718878433658;523339;528779;535708;536184;536198;72748.27251727521;73867.26132738711;77783.61108194423;83241;84072.57963710265;907.5008745190119;922.7231830450838;1082.4966390628394;1130.1862658885589;1164.2490593567102;14672.706545869236;14719.233691957033;14839.40642374293;15390.692186156439;15473.303701333693;28430.857845710638;35414;35595.2624974374;36089.639103609676;38041.23917521689;42688.78655606702;48357.75821120872;48558.27162592635;48590.27114593213;50274.245886311;9335.859962100438;9414.435133891988;9565.856512152463;9634.759131021781;9663.323567350219;11562.364069976233;11603.709907252049;11689.123315751183;13373.331333433483;17466.563335916704;13971.301434928417;14010.229437380634;14202.644933876736;14668.55994320172;14713.411463541339;13901.16593004423;14007.439702412197;14127.929360353544;14325;14371.640708982359;14117.2941352934;14169.716605667623;14315.71368572602;14738.926305368404;14772.556823294888;9333.346665733334;9487.762805929908;9545;9572.9042709572;9670.468124253233;14223.359948802121;14284.142951422948;14412.855871441152;14485.782713259521;14509 08:05:51 INFO - PROCESS | 21608 | |3;mootools.html;1429.6354429620446;1492.8656420922118;1552.1230504764815;1628.7719719239308;1824.3067634298964;6569.24453687826;7488.101427828655;7682.231776822315;7685.730999415022;7699.692012319514;7439.776806695794;7714.228577142283;7716.533858566869;7717.459777815555;7722.111957124932;2041.4998325410222;2084.593504266669;2247.370736193868;2293.529826385587;2338.2634470141934;2271.080212513926;2271.114265436481;2271.5684020036224;2271.6024695678275;2272.4432514034083;2233.229535810143;2320.118355025088;2321.1179751694417;2323.9767602323927;2326.7673232676766;2280.942976425586;2289.816814654832;2327.44141406063;2336.2757545161053;2337.3922780077132;2311.7688231176917;2325.093213646679;2343.69531960844;2347.319277409549;2352.929412117622;7543.660535275926;7698.3071523562585;7700.191479894643;7703.075630924325;7707.884381734279;4598.540145985408;4702.247640377557;4712.175369310357;4715.1748444022505;4720.409948756405;3083.953740693891;3126.04655580048;3159.1154476746547;3193.441147799149;3215.1640573450836;1072.1208608940672;1095.4851219926622;1158.1082566423806;1947.7662680478293;1983.2364539652194;10513.684589462327;10625.78748425035;10627.202959777971;10632.096271816905;10663.733406664818;4009.4386785850006;4087.91824163521;4125.608067233608;4205.600467955539;4208.663306935499;8226.629801658939;8287.171282871785;8303.8339233215;8306.044804847399;8306.875396869053;4574.245249533789;4597.494275629678;4614.930776038362;4615;4623.237165867594;4231.555686652919;4278.272693642089;4279.7218180818145;4280.315149576053;4282.957170428256;3190.1227162530026;3227.289996200832;3299.9175020624675;3722.40441529354;3788.6969042476535;1212.1999480342931;1224.4918358880964;1229.9569515067108;1241.453760345445;1245.5951815659946;1039.5062345386032;1043.113353649392;1102.7463683352873;1206.3365149167923;1349.9325033748273;7090.361867431956;7123.287671232835;7130.572165670076;7136.429085673238;7152.819784735564;1140.4696815980608;1150.3960420779158;1159.62891874601;1181.167277069664;1202.1284568687631;5618.550515958714;5645.774169033275;5648.830535083954;5649.12438572022;5657.547396208293;8943.016268210491;8972.820543589092;9213.90786092144;9232.630694772268;9233.122853328923;9145.176934075966;9211.585478653476;9244.722658320261;9369.718908432758;9388.67139650109;7190;7230.493865429369;7245.275472452712;7251.057362542836;7333.523320984119;7054.047703560159;7073.469489788389;7114;7116.003759473781;7121.359077683033;8023.077346105272;8318.292945099492;8414.453060551044;8436.776667383318;8442.788930276793;8382.119877412784;8449.788755281168;8593.054763976083;8609.225169734755;8620.353473489638;6415.582987105823;6498.122753428227;6554.63949482783;6558.344165583403;6582.967085164543;6409.8397540060005;6699.028640846953;7249.492535522463;7304.306090921354;7382.224866389167;6872.41584465326;6973.825654358681;7029.507934444539;7069.681864316015;7094.432445404458;6488.740450382121;6691.397774200345;6762.053312536151;6863.965680171567;6899.517033807786;6621.172353455818;6659.334066593496;6659.933400665931;6669.966650166718;6678.198616166092;5991.281046274475;6020.367861374492;6036.3661815510495;6075.119107729266;6195.81412557624;6275.96862015687;6324.620522768649;6326.2092238470195;6340.556161068681;6351.491880649444 08:05:51 INFO - PROCESS | 21608 | |4;prototype.html;338.66472192529403;338.8644542183127;344.50219432919425;350.17533708117384;351.5675718865795;5643.181738647893;5813.186153938446;5840.240768700074;5863.325717542484;5868.29580450346;5641.943580564193;5795.420457954213;5806.303243610772;5818.098194779805;5821.155932389801;4522.45730512339;4526.9320960185705;4528.230200865861;4533.138703646297;4537.909241815161;4368.104538569585;4452.7996240169105;4477.3731677565;4538.7503687297185;4588.380568623244;4547.113312903985;4553.225951588238;4557.407537020183;4564.680472366936;4569.771511424432;4543.591076803087;4554.248548989446;4557.043020965584;4563.475200351969;4566.06395688883;4025.074232926414;4025.7383270087353;4027.556968733437;4031.1534577738416;4040.959590404117;5437.483439073281;5557.277553917965;5572.916406253909;5594.608377413582;5609.242752228438;5203.297554830087;5235.528802407764;5246.737663116829;5250;5259.421463638997;5964.970175149097;6261.217347831521;6264.279607845065;6269.435750782452;6274.56078074535;4278.2940814765525;4298.871033868989;4383.890402739957;4397.692161548693;4406.272964960777;6384.425401713868;6476.996065609838;6494.5453818232745;6495.123158373606;6495.188101487314;4480.260756975128;4480.596746292784;4480.865574032784;4483.327500874895;4483.955160448354;4405.074934263776;4449.666275029385;4488.9575243264235;4537.863864084016;4543.023250001265;5138.614603904722;5149.176131818966;5154.845354639367;5156.819511317086;5167.3799144102195;6220.937790622126;6240.594361366497;6245.6252624841745;6248.625082495065;6253.812385628438;1582.2800625715272;1588.3725928258273;1589.4039735099338;1589.4834178891906;1589.6502769390715;1076.1014552848303;1079.8974097460728;1081.7728277061747;1084.951177197028;1106.363840791548;5883.646981181143;5886.23478947734;5893.5874488785375;5896.233489646319;5896.528277737771;6435.613863168225;6445.45213656835;6449.355064493513;6451.064595633607;6453.612783233021;5880.705964701748;5880.764769409261;5883.941160588425;5887.234659494238;5888.146218798251;3405.4551271796395;3489.2323688788933;3500.6149323574386;3506.263684626257;3508.947365789515;6676;6683.064370988066;6684.4318232950745;6690.899636505456;6693.163354580677;6667;6673.799786006428;6679;6680.565763225375;6680.86638267232;6490.772822951174;6657.101291325609;6662.400383965466;6672.799816005528;6677.532572719863;6267.5299352549655;6389.680515974275;6489.643069631215;6496.642684652389;6502.154719886385;6287.46556542699;6404.071409645669;6432.195975503062;6436.517261205522;6446.258680251831;6638.17022872141;6664;6665.700043497957;6670.266270710315;6676.399124078856;4404.537523560109;4482.731036137842;4510.0528888933695;4515.638748900145;4521;6493.22081350241;6494.577852439576;6500.479961603155;6504.60972341661;6506.772262970773;6284.5600807943;6306.527010474141;6314.210723659543;6322.272938612118;6325.430711236011;6186.226721659793;6297.779577714758;6313.116163737172;6318.557700961072;6324.114623952558;6145.139680444652;6189.195404597373;6190.2571691397325;6197.380261973766;6205.100260462298;6321;6325.177726895474;6327.557071004985;6328.588641738456;6343.429091381798;6074.1799857020505;6186.536009799193;6197.225346831646;6198.318184999556;6204.286507051746 08:05:51 INFO - PROCESS | 21608 | |5;yui.html;839.7648658375657;852.7740148860553;854.9316054715623;854.957252137393;877.841988442081;13220.40508177132;13382.665433364147;13410.530631427902;13419.12775669582;13457;12273.079519036064;12342.25946443214;12420.441080151393;12438.626841194757;13379.866201337984;825.9675405742837;831.2850948184556;836.8200836820082;837.5812093953024;837.7109897085496;833.4332653795417;837.5309826497181;837.9832403351929;838.1032295443878;838.2832678060262;853.2065179383171;855.6620135046653;861.6424183963679;862.6420035685184;863.0765081362944;868.6004437958484;868.934829887761;869.7521206456192;870.0777176193224;870.2950610005915;636.3350298937621;637.1303171171364;637.5218586060455;637.7321524959528;638.1735652330198;13081.542146024938;13085.803712944313;13189;13213.273269970148;13214.933925330408;12249.57126500577;12269.263844169378;12586.81119783204;12626.179298345578;12664.620061398173;9835.360701554377;10085;10251;10321.74195645115;10527.684169474927;3477.0611934777467;3534.9823250883837;3542.36237477254;3592.568891733009;3600.58593261773;43857.56142438567;44392.3341149883;44410.333844992354;44443.111137777385;44636.33045504287;9089.909100908906;9105.544722763836;9146.451212927246;9161.450312981242;9207.90792092084;17796.55508612295;18300.54248643768;18321.541961451072;18343.724844127348;18383.98888061143;7393.445491588045;7442.627868606548;7592.772216833504;7630.881972240503;7699.153093159748;4149.522804877417;4198.895027624334;4206.537280899099;4370.825166993348;4407.316865885793;3138.4821504451966;3158.8894388696285;3160.8893688720786;3166.366726654678;3169.2393825481718;586.2115454713404;590.6338070396382;596.5972968246416;607.2439812433548;610.5420934299276;570.8515785895697;627.9168434450536;641.2497378067673;677.3801971196399;684.165318311659;7785.493942893694;7826.921730782619;7865.960670196612;7906.802329941797;8087.959560202161;636.2841802971657;647.6502688548226;658.5686375424104;665.7436886798617;674.0731494195481;3649.1424515238896;3857.479240302523;3869.729118961646;3892.727509074338;4262.936055959163;53033.73483132559;54117;55254.72372638111;55497;55498.72250638721;47986;49465;50288;50290.245646315336;50888;38670.419943700865;40671.796641017194;41631.58368416277;45593;45895.770521147184;7903.446758726834;8028.879566806386;8535.829283414421;8860.158284962918;9041.728748137566;35158.47262291119;35362.46956295709;35976.82011589925;36218;36286.63713362833;38569.6143038566;44706;45103.77448112739;45554.54445455503;46597.068058639314;10673.146148308271;10961.61634342826;10965.94857539971;10986.176036797113;11300.208985370946;12129.150959432754;12382.876171238533;12383.257004579395;12423.62729118128;12506.901577290364;10908.400037997986;11144.554217831195;11596.188266821579;11598.826017609574;11798.941005294919;11189.552417903193;11516.654500365003;11580.305181689126;11781.882181178078;11923.0461563073;10901.672949811518;11280.774384512428;11544.653660390202;11589.304641721523;11636.941815291208;9882.901170988485;9971.102600765676;10037.69886903394;10215.387076775418;10239.283250172417;8937.910620893708;8976.326775491994;8996.235319997873;9034.277257819227;9545.856812147684 08:05:51 INFO - PROCESS | 21608 | __end_tp_report 08:05:51 INFO - PROCESS | 21608 | __start_cc_report 08:05:51 INFO - PROCESS | 21608 | _x_x_mozilla_cycle_collect,925 08:05:51 INFO - PROCESS | 21608 | __end_cc_report 08:05:51 INFO - PROCESS | 21608 | __startTimestamp1450886751105__endTimestamp 08:05:51 INFO - PROCESS | 21608 | 08:05:51 INFO - PROCESS | 21608 | ------- Summary: start ------- 08:05:51 INFO - PROCESS | 21608 | Number of tests: 6 08:05:51 INFO - PROCESS | 21608 | 08:05:51 INFO - PROCESS | 21608 | [#0] dojo.html Cycles:165 Average:5377.74 Median:5593.24 stddev:611.37 (10.9%) stddev-sans-first:588.26 08:05:51 INFO - PROCESS | 21608 | Values: 3172.6 3186.7 3237.9 3246.1 3269.4 5218.9 5306.3 5379.7 5419.8 5453.0 5196.6 5237.0 5257.9 5332.0 5460.6 4823.9 4829.6 4839.2 4878.7 4947.5 4678.7 4926.3 4958.3 4963.3 5004.3 4854.7 4872.5 4915.1 4933.1 4934.8 4874.0 4900.4 4910.5 4947.1 4947.8 4754.3 4857.3 4893.8 4895.6 4955.7 5199.4 5276.9 5285.3 5296.3 5297.2 5924.5 5927.0 5928.0 5935.2 5942.1 5675.8 5888.5 5950.5 5973.0 5983.8 5290.5 5402.2 5408.5 5417.3 5426.0 5902.2 5914.7 5918.5 5937.3 5971.1 5583.6 5697.1 5709.9 5710.6 5715.2 5658.7 5720.8 5744.3 5778.4 5802.7 5830.7 5844.1 5857.3 5863.5 5919.1 5856.6 5859.2 5860.4 5864.2 5870.2 4340.5 4400.4 4417.9 4505.7 4514.9 4005.0 4012.2 4015.6 4035.6 4043.4 5342.4 5388.5 5398.6 5409.3 5412.4 5622.0 5731.5 5817.4 5877.2 5887.3 5271.4 5274.4 5284.4 5341.2 5371.8 4921.9 4977.0 4977.2 5030.5 5090.2 5850.4 5985.1 6011.5 6020.2 6027.2 5760.3 5841.6 5869.6 5870.5 5914.7 5901.1 5943.9 5949.6 5952.9 5963.4 5529.9 5543.9 5720.8 5732.9 5733.0 5836.3 5847.5 5926.0 5938.3 5980.9 5718.3 5723.6 5729.5 5737.4 5746.2 5519.3 5651.6 5659.1 5672.5 5708.2 5538.7 5593.2 5595.1 5621.6 5645.5 5708.0 5723.4 5760.7 5786.2 5841.5 5405.1 5501.1 5599.5 5632.3 5650.7 08:05:51 INFO - PROCESS | 21608 | 08:05:51 INFO - PROCESS | 21608 | [#1] ext.html Cycles:180 Average:47696.90 Median:17944.52 stddev:82070.49 (457.4%) stddev-sans-first:82224.42 08:05:51 INFO - PROCESS | 21608 | Values: 564.6 600.2 615.3 622.2 635.4 29311.0 30071.5 36214.6 36319.8 36339.0 41144.0 41596.4 41616.2 41644.4 41794.8 7562.6 7674.3 8713.6 8884.7 8897.0 10481.5 10720.4 10723.9 10742.8 10746.6 10388.9 10461.2 10490.4 10497.4 10497.9 7792.5 7926.0 10418.6 10581.2 10817.1 10236.4 10370.7 10386.9 10393.6 10396.9 40030.4 40550.4 40558.8 40575.2 40651.6 3044.3 3270.5 3327.8 3387.6 3911.7 30410.2 30421.0 30473.8 30882.8 31375.2 3988.6 3990.3 4102.7 4151.1 4235.4 269498.0 273504.0 273854.0 274014.0 274583.0 58576.7 61513.4 61971.4 61971.7 62025.7 54044.0 54266.2 54280.2 71339.0 71741.6 13794.4 13821.9 13931.3 13976.2 13983.4 10266.4 10302.4 10338.6 10356.0 10356.4 18124.2 18124.4 18124.8 18188.2 21077.4 8015.4 8120.8 8174.8 8227.9 8333.3 957.3 980.7 1017.3 1048.8 1136.6 28174.0 28201.5 28445.9 28577.9 28665.0 1035.1 1036.9 1070.9 1071.4 1074.5 14512.3 14523.1 14574.5 14587.5 14650.6 372283.0 372842.0 372906.1 373309.0 373526.0 51823.0 52564.7 52714.0 52956.0 52976.5 1187.3 1187.7 1213.6 1265.7 1354.7 27632.3 28649.6 28751.0 28968.6 29129.6 41173.0 41554.8 41559.0 41742.0 43158.0 182746.0 296884.0 302298.0 304751.0 306122.0 31608.5 32580.0 32608.2 32617.5 32618.5 41562.6 42058.0 42233.0 42567.8 42822.6 36155.3 36577.8 36840.8 36883.8 37744.8 35855.3 36350.6 36396.8 36818.0 36846.4 38773.6 40457.4 40472.4 41236.4 41442.6 29284.6 30438.0 33079.7 33177.7 33546.8 25148.6 25356.9 25371.0 25411.7 25874.5 08:05:51 INFO - PROCESS | 21608 | 08:05:51 INFO - PROCESS | 21608 | [#2] jquery.html Cycles:180 Average:28064.49 Median:4424.14 stddev:86954.35 (1965.5%) stddev-sans-first:87173.39 08:05:51 INFO - PROCESS | 21608 | Values: 356.0 356.9 359.9 361.5 365.8 14617.6 15042.4 16405.3 16772.7 17475.7 14942.6 16309.3 16581.7 17115.1 17118.1 5277.6 5308.9 5457.3 5458.8 5459.9 5351.0 5389.2 5396.8 5402.4 5404.2 5253.1 5343.6 5354.5 5356.1 5364.9 5359.4 5380.3 5392.3 5397.9 5398.9 4793.5 4799.6 4801.1 4818.4 4820.6 12170.6 12191.1 12446.4 12545.9 12616.4 2061.2 2088.9 2101.9 2259.4 2473.7 9554.8 9625.8 9744.2 9756.2 9784.0 1779.4 1787.3 1797.3 1800.4 1808.5 49549.5 50957.5 54570.0 61815.4 64631.7 9453.5 9878.4 9893.8 9958.6 10023.9 13091.1 13158.8 13172.7 13176.6 13214.5 6791.3 6857.7 6921.7 6937.7 6955.9 6563.3 6581.7 6606.1 6638.6 6648.3 4345.6 4406.6 4414.1 4434.2 4467.8 1799.8 1807.4 1819.5 1825.3 1864.5 905.3 926.1 933.3 943.3 1042.3 16329.6 16450.9 17074.6 17187.1 17745.8 906.7 939.0 968.7 1015.9 1083.6 7143.5 9168.4 9291.3 9323.2 9370.7 523339.0 528779.0 535708.0 536184.0 536198.0 72748.3 73867.3 77783.6 83241.0 84072.6 907.5 922.7 1082.5 1130.2 1164.2 14672.7 14719.2 14839.4 15390.7 15473.3 28430.9 35414.0 35595.3 36089.6 38041.2 42688.8 48357.8 48558.3 48590.3 50274.2 9335.9 9414.4 9565.9 9634.8 9663.3 11562.4 11603.7 11689.1 13373.3 17466.6 13971.3 14010.2 14202.6 14668.6 14713.4 13901.2 14007.4 14127.9 14325.0 14371.6 14117.3 14169.7 14315.7 14738.9 14772.6 9333.3 9487.8 9545.0 9572.9 9670.5 14223.4 14284.1 14412.9 14485.8 14509.0 08:05:51 INFO - PROCESS | 21608 | 08:05:51 INFO - PROCESS | 21608 | [#3] mootools.html Cycles:180 Average:5351.44 Median:6005.82 stddev:2710.97 (45.1%) stddev-sans-first:2702.55 08:05:51 INFO - PROCESS | 21608 | Values: 1429.6 1492.9 1552.1 1628.8 1824.3 6569.2 7488.1 7682.2 7685.7 7699.7 7439.8 7714.2 7716.5 7717.5 7722.1 2041.5 2084.6 2247.4 2293.5 2338.3 2271.1 2271.1 2271.6 2271.6 2272.4 2233.2 2320.1 2321.1 2324.0 2326.8 2280.9 2289.8 2327.4 2336.3 2337.4 2311.8 2325.1 2343.7 2347.3 2352.9 7543.7 7698.3 7700.2 7703.1 7707.9 4598.5 4702.2 4712.2 4715.2 4720.4 3084.0 3126.0 3159.1 3193.4 3215.2 1072.1 1095.5 1158.1 1947.8 1983.2 10513.7 10625.8 10627.2 10632.1 10663.7 4009.4 4087.9 4125.6 4205.6 4208.7 8226.6 8287.2 8303.8 8306.0 8306.9 4574.2 4597.5 4614.9 4615.0 4623.2 4231.6 4278.3 4279.7 4280.3 4283.0 3190.1 3227.3 3299.9 3722.4 3788.7 1212.2 1224.5 1230.0 1241.5 1245.6 1039.5 1043.1 1102.7 1206.3 1349.9 7090.4 7123.3 7130.6 7136.4 7152.8 1140.5 1150.4 1159.6 1181.2 1202.1 5618.6 5645.8 5648.8 5649.1 5657.5 8943.0 8972.8 9213.9 9232.6 9233.1 9145.2 9211.6 9244.7 9369.7 9388.7 7190.0 7230.5 7245.3 7251.1 7333.5 7054.0 7073.5 7114.0 7116.0 7121.4 8023.1 8318.3 8414.5 8436.8 8442.8 8382.1 8449.8 8593.1 8609.2 8620.4 6415.6 6498.1 6554.6 6558.3 6583.0 6409.8 6699.0 7249.5 7304.3 7382.2 6872.4 6973.8 7029.5 7069.7 7094.4 6488.7 6691.4 6762.1 6864.0 6899.5 6621.2 6659.3 6659.9 6670.0 6678.2 5991.3 6020.4 6036.4 6075.1 6195.8 6276.0 6324.6 6326.2 6340.6 6351.5 08:05:51 INFO - PROCESS | 21608 | 08:05:51 INFO - PROCESS | 21608 | [#4] prototype.html Cycles:180 Average:5233.58 Median:5880.74 stddev:1566.09 (26.6%) stddev-sans-first:1526.78 08:05:51 INFO - PROCESS | 21608 | Values: 338.7 338.9 344.5 350.2 351.6 5643.2 5813.2 5840.2 5863.3 5868.3 5641.9 5795.4 5806.3 5818.1 5821.2 4522.5 4526.9 4528.2 4533.1 4537.9 4368.1 4452.8 4477.4 4538.8 4588.4 4547.1 4553.2 4557.4 4564.7 4569.8 4543.6 4554.2 4557.0 4563.5 4566.1 4025.1 4025.7 4027.6 4031.2 4041.0 5437.5 5557.3 5572.9 5594.6 5609.2 5203.3 5235.5 5246.7 5250.0 5259.4 5965.0 6261.2 6264.3 6269.4 6274.6 4278.3 4298.9 4383.9 4397.7 4406.3 6384.4 6477.0 6494.5 6495.1 6495.2 4480.3 4480.6 4480.9 4483.3 4484.0 4405.1 4449.7 4489.0 4537.9 4543.0 5138.6 5149.2 5154.8 5156.8 5167.4 6220.9 6240.6 6245.6 6248.6 6253.8 1582.3 1588.4 1589.4 1589.5 1589.7 1076.1 1079.9 1081.8 1085.0 1106.4 5883.6 5886.2 5893.6 5896.2 5896.5 6435.6 6445.5 6449.4 6451.1 6453.6 5880.7 5880.8 5883.9 5887.2 5888.1 3405.5 3489.2 3500.6 3506.3 3508.9 6676.0 6683.1 6684.4 6690.9 6693.2 6667.0 6673.8 6679.0 6680.6 6680.9 6490.8 6657.1 6662.4 6672.8 6677.5 6267.5 6389.7 6489.6 6496.6 6502.2 6287.5 6404.1 6432.2 6436.5 6446.3 6638.2 6664.0 6665.7 6670.3 6676.4 4404.5 4482.7 4510.1 4515.6 4521.0 6493.2 6494.6 6500.5 6504.6 6506.8 6284.6 6306.5 6314.2 6322.3 6325.4 6186.2 6297.8 6313.1 6318.6 6324.1 6145.1 6189.2 6190.3 6197.4 6205.1 6321.0 6325.2 6327.6 6328.6 6343.4 6074.2 6186.5 6197.2 6198.3 6204.3 08:05:51 INFO - PROCESS | 21608 | 08:05:51 INFO - PROCESS | 21608 | [#5] yui.html Cycles:180 Average:13413.05 Median:44671.17 stddev:15226.84 (34.1%) stddev-sans-first:15240.27 08:05:51 INFO - PROCESS | 21608 | Values: 839.8 852.8 854.9 855.0 877.8 13220.4 13382.7 13410.5 13419.1 13457.0 12273.1 12342.3 12420.4 12438.6 13379.9 826.0 831.3 836.8 837.6 837.7 833.4 837.5 838.0 838.1 838.3 853.2 855.7 861.6 862.6 863.1 868.6 868.9 869.8 870.1 870.3 636.3 637.1 637.5 637.7 638.2 13081.5 13085.8 13189.0 13213.3 13214.9 12249.6 12269.3 12586.8 12626.2 12664.6 9835.4 10085.0 10251.0 10321.7 10527.7 3477.1 3535.0 3542.4 3592.6 3600.6 43857.6 44392.3 44410.3 44443.1 44636.3 9089.9 9105.5 9146.5 9161.5 9207.9 17796.6 18300.5 18321.5 18343.7 18384.0 7393.4 7442.6 7592.8 7630.9 7699.2 4149.5 4198.9 4206.5 4370.8 4407.3 3138.5 3158.9 3160.9 3166.4 3169.2 586.2 590.6 596.6 607.2 610.5 570.9 627.9 641.2 677.4 684.2 7785.5 7826.9 7866.0 7906.8 8088.0 636.3 647.7 658.6 665.7 674.1 3649.1 3857.5 3869.7 3892.7 4262.9 53033.7 54117.0 55254.7 55497.0 55498.7 47986.0 49465.0 50288.0 50290.2 50888.0 38670.4 40671.8 41631.6 45593.0 45895.8 7903.4 8028.9 8535.8 8860.2 9041.7 35158.5 35362.5 35976.8 36218.0 36286.6 38569.6 44706.0 45103.8 45554.5 46597.1 10673.1 10961.6 10965.9 10986.2 11300.2 12129.2 12382.9 12383.3 12423.6 12506.9 10908.4 11144.6 11596.2 11598.8 11798.9 11189.6 11516.7 11580.3 11781.9 11923.0 10901.7 11280.8 11544.7 11589.3 11636.9 9882.9 9971.1 10037.7 10215.4 10239.3 8937.9 8976.3 8996.2 9034.3 9545.9 08:05:51 INFO - PROCESS | 21608 | -------- Summary: end -------- 08:05:51 INFO - PROCESS | 21608 | 08:05:51 INFO - TEST-INFO | 21608: exit 0 08:05:51 INFO - TEST-OK | dromaeo_css | took 1112922ms 08:05:51 INFO - TEST-START | kraken 08:05:51 INFO - operating with platform_type : linux_ 08:05:51 INFO - Initialising browser for kraken test... 08:05:51 INFO - TEST-INFO | started process 21805 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu9gQ7m/profile http://localhost:56351/getInfo.html) 08:05:56 INFO - PROCESS | 21805 | __metrics Screen width/height:1600/1200 08:05:56 INFO - PROCESS | 21805 | colorDepth:24 08:05:56 INFO - PROCESS | 21805 | Browser inner width/height: 1024/697 08:05:56 INFO - PROCESS | 21805 | __metrics 08:05:56 INFO - PROCESS | 21805 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:05:56 INFO - PROCESS | 21805 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:05:56 ERROR - PROCESS | 21805 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 08:05:56 INFO - TEST-INFO | 21805: exit 0 08:05:56 INFO - Browser initialized. 08:05:56 INFO - Running cycle 1/1 for kraken test... 08:05:56 INFO - TEST-INFO | started process 21890 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu9gQ7m/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:08 INFO - PROCESS | 21890 | RSS: Main: 150188032 08:06:08 INFO - PROCESS | 21890 | 08:06:11 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56351/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:11 INFO - PROCESS | 21890 | RSS: Main: 186257408 08:06:11 INFO - PROCESS | 21890 | 08:06:14 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56351/tests/kraken/driver.html?testName=audio-dft) 08:06:14 INFO - PROCESS | 21890 | RSS: Main: 176136192 08:06:14 INFO - PROCESS | 21890 | 08:06:17 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56351/tests/kraken/driver.html?testName=audio-fft) 08:06:18 INFO - PROCESS | 21890 | RSS: Main: 160641024 08:06:18 INFO - PROCESS | 21890 | 08:06:20 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56351/tests/kraken/driver.html?testName=audio-oscillator) 08:06:20 INFO - PROCESS | 21890 | RSS: Main: 163766272 08:06:20 INFO - PROCESS | 21890 | 08:06:23 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56351/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:23 INFO - PROCESS | 21890 | RSS: Main: 164732928 08:06:23 INFO - PROCESS | 21890 | 08:06:26 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56351/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:27 INFO - PROCESS | 21890 | RSS: Main: 164089856 08:06:27 INFO - PROCESS | 21890 | 08:06:30 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56351/tests/kraken/driver.html?testName=imaging-desaturate) 08:06:31 INFO - PROCESS | 21890 | RSS: Main: 166354944 08:06:31 INFO - PROCESS | 21890 | 08:06:33 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56351/tests/kraken/driver.html?testName=json-parse-financial) 08:06:34 INFO - PROCESS | 21890 | RSS: Main: 164093952 08:06:34 INFO - PROCESS | 21890 | 08:06:35 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56351/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:06:36 INFO - PROCESS | 21890 | RSS: Main: 176693248 08:06:36 INFO - PROCESS | 21890 | 08:06:38 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56351/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:06:38 INFO - PROCESS | 21890 | RSS: Main: 173871104 08:06:38 INFO - PROCESS | 21890 | 08:06:40 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56351/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:06:41 INFO - PROCESS | 21890 | RSS: Main: 188489728 08:06:41 INFO - PROCESS | 21890 | 08:06:43 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:06:44 INFO - PROCESS | 21890 | RSS: Main: 193097728 08:06:44 INFO - PROCESS | 21890 | 08:06:47 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:06:47 INFO - PROCESS | 21890 | RSS: Main: 190545920 08:06:47 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | Cycle 1(1): loaded http://localhost:56351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56351/tests/kraken/driver.html?testName=ai-astar) 08:06:49 INFO - PROCESS | 21890 | RSS: Main: 249057280 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | __start_tp_report 08:06:49 INFO - PROCESS | 21890 | _x_x_mozilla_page_load 08:06:49 INFO - PROCESS | 21890 | _x_x_mozilla_page_load_details 08:06:49 INFO - PROCESS | 21890 | |i|pagename|runs| 08:06:49 INFO - PROCESS | 21890 | |0;ai-astar;108;110;103;108;110;110;100;110;109;116 08:06:49 INFO - PROCESS | 21890 | |1;audio-beat-detection;148;124;148;158;135;156;150;127;170;127 08:06:49 INFO - PROCESS | 21890 | |2;audio-dft;161;160;158;160;160;161;160;161;162;160 08:06:49 INFO - PROCESS | 21890 | |3;audio-fft;72;72;80;91;71;72;71;105;92;73 08:06:49 INFO - PROCESS | 21890 | |4;audio-oscillator;94;93;136;92;92;92;135;94;94;140 08:06:49 INFO - PROCESS | 21890 | |5;imaging-gaussian-blur;109;110;110;110;109;109;109;109;110;109 08:06:49 INFO - PROCESS | 21890 | |6;imaging-darkroom;147;147;147;147;147;148;147;147;147;145 08:06:49 INFO - PROCESS | 21890 | |7;imaging-desaturate;95;96;96;95;96;96;95;95;95;95 08:06:49 INFO - PROCESS | 21890 | |8;json-parse-financial;60;58;58;57;58;57;58;66;55;56 08:06:49 INFO - PROCESS | 21890 | |9;json-stringify-tinderbox;67;68;68;67;67;67;68;69;68;68 08:06:49 INFO - PROCESS | 21890 | |10;stanford-crypto-aes;91;85;85;85;91;84;84;84;85;85 08:06:49 INFO - PROCESS | 21890 | |11;stanford-crypto-ccm;125;116;130;122;116;115;123;117;116;124 08:06:49 INFO - PROCESS | 21890 | |12;stanford-crypto-pbkdf2;140;140;149;160;151;142;151;138;153;137 08:06:49 INFO - PROCESS | 21890 | |13;stanford-crypto-sha256-iterative;68;66;66;66;68;66;66;66;67;67 08:06:49 INFO - PROCESS | 21890 | __end_tp_report 08:06:49 INFO - PROCESS | 21890 | __start_cc_report 08:06:49 INFO - PROCESS | 21890 | _x_x_mozilla_cycle_collect,911 08:06:49 INFO - PROCESS | 21890 | __end_cc_report 08:06:49 INFO - PROCESS | 21890 | __startTimestamp1450886809538__endTimestamp 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | ------- Summary: start ------- 08:06:49 INFO - PROCESS | 21890 | Number of tests: 14 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:4.33 (3.9%) stddev-sans-first:4.59 08:06:49 INFO - PROCESS | 21890 | Values: 108.0 110.0 103.0 108.0 110.0 110.0 100.0 110.0 109.0 116.0 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:149.00 stddev:15.43 (10.4%) stddev-sans-first:16.31 08:06:49 INFO - PROCESS | 21890 | Values: 148.0 124.0 148.0 158.0 135.0 156.0 150.0 127.0 170.0 127.0 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 08:06:49 INFO - PROCESS | 21890 | Values: 161.0 160.0 158.0 160.0 160.0 161.0 160.0 161.0 162.0 160.0 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#3] audio-fft Cycles:10 Average:79.90 Median:72.50 stddev:11.99 (16.5%) stddev-sans-first:12.37 08:06:49 INFO - PROCESS | 21890 | Values: 72.0 72.0 80.0 91.0 71.0 72.0 71.0 105.0 92.0 73.0 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#4] audio-oscillator Cycles:10 Average:106.20 Median:92.50 stddev:21.31 (23.0%) stddev-sans-first:22.14 08:06:49 INFO - PROCESS | 21890 | Values: 94.0 93.0 136.0 92.0 92.0 92.0 135.0 94.0 94.0 140.0 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:06:49 INFO - PROCESS | 21890 | Values: 109.0 110.0 110.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:06:49 INFO - PROCESS | 21890 | Values: 147.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 145.0 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:06:49 INFO - PROCESS | 21890 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.00 stddev:3.02 (5.2%) stddev-sans-first:3.14 08:06:49 INFO - PROCESS | 21890 | Values: 60.0 58.0 58.0 57.0 58.0 57.0 58.0 66.0 55.0 56.0 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 08:06:49 INFO - PROCESS | 21890 | Values: 67.0 68.0 68.0 67.0 67.0 67.0 68.0 69.0 68.0 68.0 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.00 stddev:2.73 (3.2%) stddev-sans-first:2.18 08:06:49 INFO - PROCESS | 21890 | Values: 91.0 85.0 85.0 85.0 91.0 84.0 84.0 84.0 85.0 85.0 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:122.50 stddev:5.10 (4.2%) stddev-sans-first:5.13 08:06:49 INFO - PROCESS | 21890 | Values: 125.0 116.0 130.0 122.0 116.0 115.0 123.0 117.0 116.0 124.0 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:150.00 stddev:7.72 (5.1%) stddev-sans-first:7.87 08:06:49 INFO - PROCESS | 21890 | Values: 140.0 140.0 149.0 160.0 151.0 142.0 151.0 138.0 153.0 137.0 08:06:49 INFO - PROCESS | 21890 | 08:06:49 INFO - PROCESS | 21890 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 08:06:49 INFO - PROCESS | 21890 | Values: 68.0 66.0 66.0 66.0 68.0 66.0 66.0 66.0 67.0 67.0 08:06:49 INFO - PROCESS | 21890 | -------- Summary: end -------- 08:06:49 INFO - PROCESS | 21890 | 08:06:50 INFO - TEST-INFO | 21890: exit 0 08:06:50 INFO - TEST-OK | kraken | took 58521ms 08:06:50 INFO - TEST-START | v8_7 08:06:50 INFO - operating with platform_type : linux_ 08:06:50 INFO - Initialising browser for v8_7 test... 08:06:50 INFO - TEST-INFO | started process 22139 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjhiS8G/profile http://localhost:56351/getInfo.html) 08:06:54 INFO - PROCESS | 22139 | __metrics Screen width/height:1600/1200 08:06:54 INFO - PROCESS | 22139 | colorDepth:24 08:06:54 INFO - PROCESS | 22139 | Browser inner width/height: 1024/697 08:06:54 INFO - PROCESS | 22139 | __metrics 08:06:54 INFO - PROCESS | 22139 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:06:54 INFO - PROCESS | 22139 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:55 INFO - TEST-INFO | 22139: exit 0 08:06:55 INFO - Browser initialized. 08:06:55 INFO - Running cycle 1/1 for v8_7 test... 08:06:55 INFO - TEST-INFO | started process 22223 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjhiS8G/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:07 INFO - PROCESS | 22223 | RSS: Main: 149630976 08:07:07 INFO - PROCESS | 22223 | 08:07:28 INFO - PROCESS | 22223 | Cycle 1(1): loaded http://localhost:56351/tests/v8_7/run.html (next: http://localhost:56351/tests/v8_7/run.html) 08:07:29 INFO - PROCESS | 22223 | RSS: Main: 482631680 08:07:29 INFO - PROCESS | 22223 | 08:07:29 INFO - PROCESS | 22223 | __start_tp_report 08:07:29 INFO - PROCESS | 22223 | _x_x_mozilla_page_load 08:07:29 INFO - PROCESS | 22223 | _x_x_mozilla_page_load_details 08:07:29 INFO - PROCESS | 22223 | |i|pagename|runs| 08:07:29 INFO - PROCESS | 22223 | |0;Richards;167.84155756965424 08:07:29 INFO - PROCESS | 22223 | |1;DeltaBlue;188.85741265344666 08:07:29 INFO - PROCESS | 22223 | |2;Encrypt;280.3476310625175 08:07:29 INFO - PROCESS | 22223 | |3;Decrypt;5196.891191709845 08:07:29 INFO - PROCESS | 22223 | |4;RayTrace;1962.7450980392157 08:07:29 INFO - PROCESS | 22223 | |5;Earley;763.9419404125287 08:07:29 INFO - PROCESS | 22223 | |6;Boyer;12168.674698795181 08:07:29 INFO - PROCESS | 22223 | |7;RegExp;25125 08:07:29 INFO - PROCESS | 22223 | |8;Splay;641.4368184733804 08:07:29 INFO - PROCESS | 22223 | |9;NavierStokes;4826.923076923077 08:07:29 INFO - PROCESS | 22223 | __end_tp_report 08:07:29 INFO - PROCESS | 22223 | __startTimestamp1450886849056__endTimestamp 08:07:29 INFO - PROCESS | 22223 | 08:07:29 INFO - PROCESS | 22223 | ------- Summary: start ------- 08:07:29 INFO - PROCESS | 22223 | Number of tests: 10 08:07:29 INFO - PROCESS | 22223 | 08:07:29 INFO - PROCESS | 22223 | [#0] Richards Cycles:1 Average:167.84 Median:167.84 stddev:0.00 (0.0%) 08:07:29 INFO - PROCESS | 22223 | Values: 167.8 08:07:29 INFO - PROCESS | 22223 | 08:07:29 INFO - PROCESS | 22223 | [#1] DeltaBlue Cycles:1 Average:188.86 Median:188.86 stddev:0.00 (0.0%) 08:07:29 INFO - PROCESS | 22223 | Values: 188.9 08:07:29 INFO - PROCESS | 22223 | 08:07:29 INFO - PROCESS | 22223 | [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 08:07:29 INFO - PROCESS | 22223 | Values: 280.3 08:07:29 INFO - PROCESS | 22223 | 08:07:29 INFO - PROCESS | 22223 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 08:07:29 INFO - PROCESS | 22223 | Values: 5196.9 08:07:29 INFO - PROCESS | 22223 | 08:07:29 INFO - PROCESS | 22223 | [#4] RayTrace Cycles:1 Average:1962.75 Median:1962.75 stddev:0.00 (0.0%) 08:07:29 INFO - PROCESS | 22223 | Values: 1962.7 08:07:29 INFO - PROCESS | 22223 | 08:07:29 INFO - PROCESS | 22223 | [#5] Earley Cycles:1 Average:763.94 Median:763.94 stddev:0.00 (0.0%) 08:07:29 INFO - PROCESS | 22223 | Values: 763.9 08:07:29 INFO - PROCESS | 22223 | 08:07:29 INFO - PROCESS | 22223 | [#6] Boyer Cycles:1 Average:12168.67 Median:12168.67 stddev:0.00 (0.0%) 08:07:29 INFO - PROCESS | 22223 | Values: 12168.7 08:07:29 INFO - PROCESS | 22223 | 08:07:29 INFO - PROCESS | 22223 | [#7] RegExp Cycles:1 Average:25125.00 Median:25125.00 stddev:0.00 (0.0%) 08:07:29 INFO - PROCESS | 22223 | Values: 25125.0 08:07:29 INFO - PROCESS | 22223 | 08:07:29 INFO - PROCESS | 22223 | [#8] Splay Cycles:1 Average:641.44 Median:641.44 stddev:0.00 (0.0%) 08:07:29 INFO - PROCESS | 22223 | Values: 641.4 08:07:29 INFO - PROCESS | 22223 | 08:07:29 INFO - PROCESS | 22223 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 08:07:29 INFO - PROCESS | 22223 | Values: 4826.9 08:07:29 INFO - PROCESS | 22223 | -------- Summary: end -------- 08:07:29 INFO - PROCESS | 22223 | 08:07:29 INFO - TEST-INFO | 22223: exit 0 08:07:29 INFO - TEST-OK | v8_7 | took 39561ms 08:07:29 INFO - SUITE-END | took 1211s 08:07:30 INFO - Completed test suite (00:20:11) 08:07:30 INFO - Working with test: dromaeo_css 08:07:30 INFO - Generating results file: dromaeo_css 08:07:30 INFO - Working with test: kraken 08:07:30 INFO - Generating results file: kraken 08:07:30 INFO - javascript benchmark 08:07:30 INFO - Working with test: v8_7 08:07:30 INFO - Generating results file: v8_7 08:07:30 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:07:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 08:07:30 INFO - process_Request line: dromaeo_css 6957.62 graph.html#tests=[[72,201,35]] 08:07:30 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:07:30 INFO - process_Request line: kraken 1495.80 graph.html#tests=[[232,201,35]] 08:07:30 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:07:30 INFO - process_Request line: v8_7 19848.14 graph.html#tests=[[230,201,35]] 08:07:30 INFO - RETURN: dromaeo_css: 6957.62 08:07:30 INFO - RETURN: kraken: 1495.80 08:07:30 INFO - RETURN: v8_7: 19848.14 08:07:30 INFO - javascript benchmark 08:07:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3172.5717028201193, 3186.681331866815, 3237.854296556655, 3246.107320486866, 3269.3624743175083, 5218.947810521893, 5306.257124002643, 5379.731013449326, 5419.837404877855, 5453.0, 5196.636235463519, 5237.0, 5257.86855328616, 5331.973340133303, 5460.645058071223, 4823.855284341458, 4829.565339119487, 4839.201531747275, 4878.70727756334, 4947.529984651453, 4678.719276843401, 4926.285688575154, 4958.3306253655655, 4963.25551167326, 5004.349434573519, 4854.732989685566, 4872.4640289568115, 4915.0661374339115, 4933.087378834927, 4934.777934992934, 4873.951260487385, 4900.351233296488, 4910.459849416561, 4947.109520286347, 4947.752612369367, 4754.263089221176, 4857.2714092886, 4893.75531223441, 4895.632827537914, 4955.702657840505, 5199.428062913076, 5276.92084618731, 5285.312909321802, 5296.285001524822, 5297.152455607084, 5924.466797988159, 5927.0, 5927.970360148215, 5935.228420305376, 5942.10868369748, 5675.801346952878, 5888.499477544414, 5950.494207992326, 5972.9701351493395, 5983.760649574012, 5290.470952904679, 5402.189671549299, 5408.540274076709, 5417.322834645669, 5425.9728701356635, 5902.232709747791, 5914.6746928918465, 5918.526517878559, 5937.2578427696535, 5971.134185543072, 5583.581231407579, 5697.088465845445, 5709.857253568611, 5710.628809127394, 5715.1713001614535, 5658.74535645897, 5720.8283751487525, 5744.310682718101, 5778.393268706809, 5802.709864506758, 5830.679312637761, 5844.094165404369, 5857.326407463111, 5863.501602363847, 5919.052951527735, 5856.619319744288, 5859.2382990211, 5860.355360910296, 5864.179014937912, 5870.207521984563, 4340.457442819647, 4400.44994375703, 4417.911641767147, 4505.662075344362, 4514.909701806011, 4005.0187704012706, 4012.217617564547, 4015.6185162409524, 4035.6367926886132, 4043.433919251307, 5342.385625653022, 5388.488093631099, 5398.6220964532895, 5409.323834520685, 5412.404635490093, 5621.971890140523, 5731.455511726379, 5817.360090390053, 5877.235959325346, 5887.264091988502, 5271.446498117719, 5274.393444753902, 5284.365876094893, 5341.172118321666, 5371.838844834661, 4921.926171107436, 4977.0, 4977.203647416396, 5030.496950305013, 5090.2364645303505, 5850.414958504116, 5985.0723137911955, 6011.549133814981, 6020.157177995085, 6027.246594175728, 5760.33756118035, 5841.649501029951, 5869.647821130746, 5870.530357571299, 5914.7338369774325, 5901.085331773582, 5943.940560594338, 5949.6430214187285, 5952.880942381042, 5963.403659634176, 5529.917051244154, 5543.944560554504, 5720.771169153354, 5732.942670573241, 5732.971335143297, 5836.270466191726, 5847.502962248256, 5925.970370148121, 5938.346781854079, 5980.9401905980385, 5718.25662663851, 5723.599348045597, 5729.455701708331, 5737.368889422077, 5746.16680581305, 5519.254900588369, 5651.6043876928225, 5659.066254068197, 5672.461116193955, 5708.172315014383, 5538.723063846711, 5593.244911936837, 5595.132754422908, 5621.634593751393, 5645.491905728504, 5707.971460142839, 5723.427657234243, 5760.711964401847, 5786.218860453785, 5841.474267315962, 5405.108157154025, 5501.092319767194, 5599.468050535193, 5632.295963004624, 5650.745716442688], "unit": "score", "name": "dojo.html", "value": 5337.524573170134}, {"lowerIsBetter": false, "replicates": [564.5850300029477, 600.1777564736312, 615.2616859768278, 622.2470810319514, 635.3678090300152, 29311.0, 30071.548926766118, 36214.637853621454, 36319.818400907956, 36339.0, 41144.0, 41596.37605435921, 41616.16767664645, 41644.37533437001, 41794.791026044906, 7562.584057876842, 7674.347680447141, 8713.607887645056, 8884.733457996239, 8896.955515222448, 10481.475926203697, 10720.35677859331, 10723.946380268088, 10742.838857417146, 10746.570137194503, 10388.896111038906, 10461.21540884433, 10490.37057776532, 10497.37015779052, 10497.895021049806, 7792.493487923267, 7926.0, 10418.635347762829, 10581.153507719364, 10817.080548153417, 10236.385816851012, 10370.740731481697, 10386.896131038744, 10393.636222732244, 10396.896031039669, 40030.39954400686, 40550.39174412386, 40558.797206014075, 40575.18849622991, 40651.59348406507, 3044.25415773137, 3270.5257737627912, 3327.783694059878, 3387.6104248011547, 3911.7261791674596, 30410.239744006354, 30421.0, 30473.847630761928, 30882.845585772153, 31375.215619609466, 3988.6011398860173, 3990.3415936370466, 4102.712810103294, 4151.12826306476, 4235.428217190671, 269498.0, 273504.0, 273854.0, 274013.999999998, 274583.0, 58576.707116464146, 61513.384866150765, 61971.38028619746, 61971.69014154901, 62025.68987155126, 54044.0, 54266.18600720992, 54280.185797213075, 71339.0, 71741.64129179425, 13794.379252933642, 13821.861781382258, 13931.303434828218, 13976.231307278198, 13983.44066237339, 10266.435346056038, 10302.433366164933, 10338.638147664795, 10356.0, 10356.378617282837, 18124.184411701506, 18124.365647202285, 18124.818751812312, 18188.1815318311, 21077.367678969655, 8015.398845086642, 8120.837583248302, 8174.754757357289, 8227.917720822716, 8333.250007499355, 957.3346524165638, 980.7204946590188, 1017.29298137795, 1048.8426735989663, 1136.6192325570862, 28174.0, 28201.474815648045, 28445.857770711013, 28577.857110714314, 28665.0, 1035.1201478743158, 1036.891126431729, 1070.9196810239264, 1071.3893080943787, 1074.5486895503907, 14512.346944387527, 14523.128612283297, 14574.489892853699, 14587.489437869624, 14650.560483185522, 372283.0, 372842.0, 372906.1354693209, 373309.0, 373526.0, 51823.0, 52564.73717631464, 52714.0, 52956.0, 52976.47023529792, 1187.3469591724518, 1187.7268228307537, 1213.6480420677904, 1265.7088869560052, 1354.7290541891857, 27632.30919226955, 28649.570256445753, 28751.0, 28968.565471518366, 29129.56305655459, 41173.0, 41554.79222603868, 41559.0, 41742.0, 43158.0, 182746.0, 296884.0, 302298.0, 304751.0, 306122.0, 31608.525872112397, 32580.0, 32608.184795380304, 32617.510737338485, 32618.51072233871, 41562.58437415587, 42058.0, 42233.0, 42567.787161064, 42822.57177428186, 36155.27689446249, 36577.81711091428, 36840.81579592085, 36883.815580921924, 37744.811275943444, 35855.28289434249, 36350.636493635786, 36396.818015909754, 36818.0, 36846.44730328993, 38773.61226387813, 40457.39313910235, 40472.39291410572, 41236.38145427881, 41442.58557414387, 29284.56073158947, 30438.0, 33079.66920330766, 33177.66822331746, 33546.832265838515, 25148.62277065882, 25356.873215633805, 25371.0, 25411.745882540938, 25874.48251034931], "unit": "score", "name": "ext.html", "value": 18748.404607342036}, {"lowerIsBetter": false, "replicates": [355.9911002224944, 356.93867912803574, 359.9352116619009, 361.47405524961187, 365.81160702238344, 14617.634559136028, 15042.398304067852, 16405.34378624855, 16772.664546709075, 17475.650486990267, 14942.626434339147, 16309.266083026263, 16581.66836663266, 17115.058671773048, 17118.058506782123, 5277.6305658603915, 5308.92036619451, 5457.317835270591, 5458.781648734046, 5459.863503412426, 5351.036813373591, 5389.191621256823, 5396.78412863485, 5402.35171779385, 5404.162354835007, 5253.106971814801, 5343.625946183749, 5354.464553544653, 5356.143017117262, 5364.91952620711, 5359.356877174725, 5380.3274590676165, 5392.325959255054, 5397.892042159155, 5398.865028374303, 4793.496682848286, 4799.640026997954, 4801.063792560452, 4818.373611430527, 4820.566149046603, 12170.57402990891, 12191.146619736623, 12446.377681115999, 12545.937270313681, 12616.432260548298, 2061.1970913664263, 2088.905999230038, 2101.8738875667354, 2259.367377134405, 2473.666055082577, 9554.808903821955, 9625.759356016155, 9744.220462362993, 9756.219502439788, 9784.0, 1779.430582213692, 1787.2850859656112, 1797.3170195325692, 1800.4328636479468, 1808.4574627611664, 49549.54061079909, 50957.490425095646, 54569.9999999996, 61815.381846181415, 64631.67684161596, 9453.480058596706, 9878.357906736039, 9893.802123957481, 9958.601655933682, 10023.899761002442, 13091.149075310075, 13158.802617960739, 13172.670683232996, 13176.60470185896, 13214.537491187762, 6791.252962174157, 6857.73131970587, 6921.688524016331, 6937.653117344113, 6955.89566156508, 6563.278039415661, 6581.736730530725, 6606.141201643755, 6638.634875081917, 6648.268690444047, 4345.587169218919, 4406.603405693439, 4414.073044660593, 4434.201843668106, 4467.798949047301, 1799.796362474797, 1807.3583877723481, 1819.454163750896, 1825.2790147891508, 1864.4872660018602, 905.3210092430677, 926.1340646495414, 933.2580598424269, 943.2925306020485, 1042.3068659341452, 16329.591760206089, 16450.917745411436, 17074.57313567146, 17187.140642967803, 17745.80575496397, 906.6826610686339, 938.9718308450757, 968.7093871838562, 1015.9288849780593, 1083.5774048121239, 7143.535670181422, 9168.404053736485, 9291.256699464027, 9323.160915517636, 9370.718878433658, 523339.0, 528779.0, 535708.0, 536184.0, 536198.0, 72748.27251727521, 73867.26132738711, 77783.61108194423, 83241.0, 84072.57963710265, 907.5008745190119, 922.7231830450838, 1082.4966390628394, 1130.1862658885589, 1164.2490593567102, 14672.706545869236, 14719.233691957033, 14839.40642374293, 15390.692186156439, 15473.303701333693, 28430.857845710638, 35414.0, 35595.2624974374, 36089.639103609676, 38041.23917521689, 42688.78655606702, 48357.75821120872, 48558.27162592635, 48590.27114593213, 50274.245886311, 9335.859962100438, 9414.435133891988, 9565.856512152463, 9634.759131021781, 9663.323567350219, 11562.364069976233, 11603.709907252049, 11689.123315751183, 13373.331333433483, 17466.563335916704, 13971.301434928417, 14010.229437380634, 14202.644933876736, 14668.55994320172, 14713.411463541339, 13901.16593004423, 14007.439702412197, 14127.929360353544, 14325.0, 14371.640708982359, 14117.2941352934, 14169.716605667623, 14315.71368572602, 14738.926305368404, 14772.556823294888, 9333.346665733334, 9487.762805929908, 9545.0, 9572.9042709572, 9670.468124253233, 14223.359948802121, 14284.142951422948, 14412.855871441152, 14485.782713259521, 14509.0], "unit": "score", "name": "jquery.html", "value": 8558.021186355434}, {"lowerIsBetter": false, "replicates": [1429.6354429620446, 1492.8656420922118, 1552.1230504764815, 1628.7719719239308, 1824.3067634298964, 6569.24453687826, 7488.101427828655, 7682.231776822315, 7685.730999415022, 7699.692012319514, 7439.776806695794, 7714.228577142283, 7716.533858566869, 7717.459777815555, 7722.111957124932, 2041.4998325410222, 2084.593504266669, 2247.370736193868, 2293.529826385587, 2338.2634470141934, 2271.080212513926, 2271.114265436481, 2271.5684020036224, 2271.6024695678275, 2272.4432514034083, 2233.229535810143, 2320.118355025088, 2321.1179751694417, 2323.9767602323927, 2326.7673232676766, 2280.942976425586, 2289.816814654832, 2327.44141406063, 2336.2757545161053, 2337.3922780077132, 2311.7688231176917, 2325.093213646679, 2343.69531960844, 2347.319277409549, 2352.929412117622, 7543.660535275926, 7698.3071523562585, 7700.191479894643, 7703.075630924325, 7707.884381734279, 4598.540145985408, 4702.247640377557, 4712.175369310357, 4715.1748444022505, 4720.409948756405, 3083.953740693891, 3126.04655580048, 3159.1154476746547, 3193.441147799149, 3215.1640573450836, 1072.1208608940672, 1095.4851219926622, 1158.1082566423806, 1947.7662680478293, 1983.2364539652194, 10513.684589462327, 10625.78748425035, 10627.202959777971, 10632.096271816905, 10663.733406664818, 4009.4386785850006, 4087.91824163521, 4125.608067233608, 4205.600467955539, 4208.663306935499, 8226.629801658939, 8287.171282871785, 8303.8339233215, 8306.044804847399, 8306.875396869053, 4574.245249533789, 4597.494275629678, 4614.930776038362, 4615.0, 4623.237165867594, 4231.555686652919, 4278.272693642089, 4279.7218180818145, 4280.315149576053, 4282.957170428256, 3190.1227162530026, 3227.289996200832, 3299.9175020624675, 3722.40441529354, 3788.6969042476535, 1212.1999480342931, 1224.4918358880964, 1229.9569515067108, 1241.453760345445, 1245.5951815659946, 1039.5062345386032, 1043.113353649392, 1102.7463683352873, 1206.3365149167923, 1349.9325033748273, 7090.361867431956, 7123.287671232835, 7130.572165670076, 7136.429085673238, 7152.819784735564, 1140.4696815980608, 1150.3960420779158, 1159.62891874601, 1181.167277069664, 1202.1284568687631, 5618.550515958714, 5645.774169033275, 5648.830535083954, 5649.12438572022, 5657.547396208293, 8943.016268210491, 8972.820543589092, 9213.90786092144, 9232.630694772268, 9233.122853328923, 9145.176934075966, 9211.585478653476, 9244.722658320261, 9369.718908432758, 9388.67139650109, 7190.0, 7230.493865429369, 7245.275472452712, 7251.057362542836, 7333.523320984119, 7054.047703560159, 7073.469489788389, 7114.0, 7116.003759473781, 7121.359077683033, 8023.077346105272, 8318.292945099492, 8414.453060551044, 8436.776667383318, 8442.788930276793, 8382.119877412784, 8449.788755281168, 8593.054763976083, 8609.225169734755, 8620.353473489638, 6415.582987105823, 6498.122753428227, 6554.63949482783, 6558.344165583403, 6582.967085164543, 6409.8397540060005, 6699.028640846953, 7249.492535522463, 7304.306090921354, 7382.224866389167, 6872.41584465326, 6973.825654358681, 7029.507934444539, 7069.681864316015, 7094.432445404458, 6488.740450382121, 6691.397774200345, 6762.053312536151, 6863.965680171567, 6899.517033807786, 6621.172353455818, 6659.334066593496, 6659.933400665931, 6669.966650166718, 6678.198616166092, 5991.281046274475, 6020.367861374492, 6036.3661815510495, 6075.119107729266, 6195.81412557624, 6275.96862015687, 6324.620522768649, 6326.2092238470195, 6340.556161068681, 6351.491880649444], "unit": "score", "name": "mootools.html", "value": 4470.110296098582}, {"lowerIsBetter": false, "replicates": [338.66472192529403, 338.8644542183127, 344.50219432919425, 350.17533708117384, 351.5675718865795, 5643.181738647893, 5813.186153938446, 5840.240768700074, 5863.325717542484, 5868.29580450346, 5641.943580564193, 5795.420457954213, 5806.303243610772, 5818.098194779805, 5821.155932389801, 4522.45730512339, 4526.9320960185705, 4528.230200865861, 4533.138703646297, 4537.909241815161, 4368.104538569585, 4452.7996240169105, 4477.3731677565, 4538.7503687297185, 4588.380568623244, 4547.113312903985, 4553.225951588238, 4557.407537020183, 4564.680472366936, 4569.771511424432, 4543.591076803087, 4554.248548989446, 4557.043020965584, 4563.475200351969, 4566.06395688883, 4025.074232926414, 4025.7383270087353, 4027.556968733437, 4031.1534577738416, 4040.959590404117, 5437.483439073281, 5557.277553917965, 5572.916406253909, 5594.608377413582, 5609.242752228438, 5203.297554830087, 5235.528802407764, 5246.737663116829, 5250.0, 5259.421463638997, 5964.970175149097, 6261.217347831521, 6264.279607845065, 6269.435750782452, 6274.56078074535, 4278.2940814765525, 4298.871033868989, 4383.890402739957, 4397.692161548693, 4406.272964960777, 6384.425401713868, 6476.996065609838, 6494.5453818232745, 6495.123158373606, 6495.188101487314, 4480.260756975128, 4480.596746292784, 4480.865574032784, 4483.327500874895, 4483.955160448354, 4405.074934263776, 4449.666275029385, 4488.9575243264235, 4537.863864084016, 4543.023250001265, 5138.614603904722, 5149.176131818966, 5154.845354639367, 5156.819511317086, 5167.3799144102195, 6220.937790622126, 6240.594361366497, 6245.6252624841745, 6248.625082495065, 6253.812385628438, 1582.2800625715272, 1588.3725928258273, 1589.4039735099338, 1589.4834178891906, 1589.6502769390715, 1076.1014552848303, 1079.8974097460728, 1081.7728277061747, 1084.951177197028, 1106.363840791548, 5883.646981181143, 5886.23478947734, 5893.5874488785375, 5896.233489646319, 5896.528277737771, 6435.613863168225, 6445.45213656835, 6449.355064493513, 6451.064595633607, 6453.612783233021, 5880.705964701748, 5880.764769409261, 5883.941160588425, 5887.234659494238, 5888.146218798251, 3405.4551271796395, 3489.2323688788933, 3500.6149323574386, 3506.263684626257, 3508.947365789515, 6676.0, 6683.064370988066, 6684.4318232950745, 6690.899636505456, 6693.163354580677, 6667.0, 6673.799786006428, 6679.0, 6680.565763225375, 6680.86638267232, 6490.772822951174, 6657.101291325609, 6662.400383965466, 6672.799816005528, 6677.532572719863, 6267.5299352549655, 6389.680515974275, 6489.643069631215, 6496.642684652389, 6502.154719886385, 6287.46556542699, 6404.071409645669, 6432.195975503062, 6436.517261205522, 6446.258680251831, 6638.17022872141, 6664.0, 6665.700043497957, 6670.266270710315, 6676.399124078856, 4404.537523560109, 4482.731036137842, 4510.0528888933695, 4515.638748900145, 4521.0, 6493.22081350241, 6494.577852439576, 6500.479961603155, 6504.60972341661, 6506.772262970773, 6284.5600807943, 6306.527010474141, 6314.210723659543, 6322.272938612118, 6325.430711236011, 6186.226721659793, 6297.779577714758, 6313.116163737172, 6318.557700961072, 6324.114623952558, 6145.139680444652, 6189.195404597373, 6190.2571691397325, 6197.380261973766, 6205.100260462298, 6321.0, 6325.177726895474, 6327.557071004985, 6328.588641738456, 6343.429091381798, 6074.1799857020505, 6186.536009799193, 6197.225346831646, 6198.318184999556, 6204.286507051746], "unit": "score", "name": "prototype.html", "value": 4730.174312060583}, {"lowerIsBetter": false, "replicates": [839.7648658375657, 852.7740148860553, 854.9316054715623, 854.957252137393, 877.841988442081, 13220.40508177132, 13382.665433364147, 13410.530631427902, 13419.12775669582, 13457.0, 12273.079519036064, 12342.25946443214, 12420.441080151393, 12438.626841194757, 13379.866201337984, 825.9675405742837, 831.2850948184556, 836.8200836820082, 837.5812093953024, 837.7109897085496, 833.4332653795417, 837.5309826497181, 837.9832403351929, 838.1032295443878, 838.2832678060262, 853.2065179383171, 855.6620135046653, 861.6424183963679, 862.6420035685184, 863.0765081362944, 868.6004437958484, 868.934829887761, 869.7521206456192, 870.0777176193224, 870.2950610005915, 636.3350298937621, 637.1303171171364, 637.5218586060455, 637.7321524959528, 638.1735652330198, 13081.542146024938, 13085.803712944313, 13189.0, 13213.273269970148, 13214.933925330408, 12249.57126500577, 12269.263844169378, 12586.81119783204, 12626.179298345578, 12664.620061398173, 9835.360701554377, 10085.0, 10251.0, 10321.74195645115, 10527.684169474927, 3477.0611934777467, 3534.9823250883837, 3542.36237477254, 3592.568891733009, 3600.58593261773, 43857.56142438567, 44392.3341149883, 44410.333844992354, 44443.111137777385, 44636.33045504287, 9089.909100908906, 9105.544722763836, 9146.451212927246, 9161.450312981242, 9207.90792092084, 17796.55508612295, 18300.54248643768, 18321.541961451072, 18343.724844127348, 18383.98888061143, 7393.445491588045, 7442.627868606548, 7592.772216833504, 7630.881972240503, 7699.153093159748, 4149.522804877417, 4198.895027624334, 4206.537280899099, 4370.825166993348, 4407.316865885793, 3138.4821504451966, 3158.8894388696285, 3160.8893688720786, 3166.366726654678, 3169.2393825481718, 586.2115454713404, 590.6338070396382, 596.5972968246416, 607.2439812433548, 610.5420934299276, 570.8515785895697, 627.9168434450536, 641.2497378067673, 677.3801971196399, 684.165318311659, 7785.493942893694, 7826.921730782619, 7865.960670196612, 7906.802329941797, 8087.959560202161, 636.2841802971657, 647.6502688548226, 658.5686375424104, 665.7436886798617, 674.0731494195481, 3649.1424515238896, 3857.479240302523, 3869.729118961646, 3892.727509074338, 4262.936055959163, 53033.73483132559, 54117.0, 55254.72372638111, 55497.0, 55498.72250638721, 47986.0, 49465.0, 50288.0, 50290.245646315336, 50888.0, 38670.419943700865, 40671.796641017194, 41631.58368416277, 45593.0, 45895.770521147184, 7903.446758726834, 8028.879566806386, 8535.829283414421, 8860.158284962918, 9041.728748137566, 35158.47262291119, 35362.46956295709, 35976.82011589925, 36218.0, 36286.63713362833, 38569.6143038566, 44706.0, 45103.77448112739, 45554.54445455503, 46597.068058639314, 10673.146148308271, 10961.61634342826, 10965.94857539971, 10986.176036797113, 11300.208985370946, 12129.150959432754, 12382.876171238533, 12383.257004579395, 12423.62729118128, 12506.901577290364, 10908.400037997986, 11144.554217831195, 11596.188266821579, 11598.826017609574, 11798.941005294919, 11189.552417903193, 11516.654500365003, 11580.305181689126, 11781.882181178078, 11923.0461563073, 10901.672949811518, 11280.774384512428, 11544.653660390202, 11589.304641721523, 11636.941815291208, 9882.901170988485, 9971.102600765676, 10037.69886903394, 10215.387076775418, 10239.283250172417, 8937.910620893708, 8976.326775491994, 8996.235319997873, 9034.277257819227, 9545.856812147684], "unit": "score", "name": "yui.html", "value": 6264.025771801069}], "name": "dromaeo_css", "value": 6957.623464583055}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 103.0, 108.0, 110.0, 110.0, 100.0, 110.0, 109.0, 116.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [148.0, 124.0, 148.0, 158.0, 135.0, 156.0, 150.0, 127.0, 170.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 158.0, 160.0, 160.0, 161.0, 160.0, 161.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 80.0, 91.0, 71.0, 72.0, 71.0, 105.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 136.0, 92.0, 92.0, 92.0, 135.0, 94.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 58.0, 57.0, 58.0, 57.0, 58.0, 66.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [91.0, 85.0, 85.0, 85.0, 91.0, 84.0, 84.0, 84.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [125.0, 116.0, 130.0, 122.0, 116.0, 115.0, 123.0, 117.0, 116.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [140.0, 140.0, 149.0, 160.0, 151.0, 142.0, 151.0, 138.0, 153.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.1}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 66.0, 66.0, 68.0, 66.0, 66.0, 66.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1495.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.84155756965424], "unit": "score", "name": "Richards", "value": 210.32931599999992}, {"lowerIsBetter": false, "replicates": [188.85741265344666], "unit": "score", "name": "DeltaBlue", "value": 350.09481000000017}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1962.7450980392157], "unit": "score", "name": "RayTrace", "value": 377.0173726273725}, {"lowerIsBetter": false, "replicates": [763.9419404125287], "unit": "score", "name": "Earley", "value": 872.400067}, {"lowerIsBetter": false, "replicates": [12168.674698795181], "unit": "score", "name": "Boyer", "value": 54.768741584158384}, {"lowerIsBetter": false, "replicates": [25125.0], "unit": "score", "name": "RegExp", "value": 36.25810945273629}, {"lowerIsBetter": false, "replicates": [641.4368184733804], "unit": "score", "name": "Splay", "value": 127.04446899999995}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19848.137928250395}]} 08:07:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19848.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1495.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6957.62"}}} 08:07:30 INFO - Return code: 0 08:07:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:07:30 ERROR - # TBPL SUCCESS # 08:07:30 INFO - Running post-action listener: _resource_record_post_action 08:07:30 INFO - Running post-run listener: _resource_record_post_run 08:07:31 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550678528; Read time: 4; Write time: 636612 08:07:31 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 238563328; Read time: 0; Write time: 415132 08:07:31 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311250944; Read time: 4; Write time: 221428 08:07:31 INFO - Running post-run listener: _upload_blobber_files 08:07:31 INFO - Blob upload gear active. 08:07:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:07:31 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 08:07:31 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'] 08:07:31 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 08:07:31 INFO - (blobuploader) - INFO - Open directory for files ... 08:07:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:07:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:07:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:32 INFO - (blobuploader) - INFO - Done attempting. 08:07:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:07:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:07:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:33 INFO - (blobuploader) - INFO - Done attempting. 08:07:33 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:33 INFO - Return code: 0 08:07:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:07:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8d596895b30812196cfcfa9c14cb9b5ffc8c5e333b45c365d928d68e0ebc3a7af9ec8ada522491134f702bb985795fa9368e831eda3f816aadca9bd1c0a8ed45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1eff168f8cf1ae41056d6d1c4e87ef3e0a2585b83e24578115afd2d788330039511f41a4baf2fd7a5cfa6366b4a729378df4b6ed0ef0187c8bd7cf0fcd4c9422"} 08:07:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:07:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:07:33 INFO - Contents: 08:07:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8d596895b30812196cfcfa9c14cb9b5ffc8c5e333b45c365d928d68e0ebc3a7af9ec8ada522491134f702bb985795fa9368e831eda3f816aadca9bd1c0a8ed45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1eff168f8cf1ae41056d6d1c4e87ef3e0a2585b83e24578115afd2d788330039511f41a4baf2fd7a5cfa6366b4a729378df4b6ed0ef0187c8bd7cf0fcd4c9422"} 08:07:33 INFO - Copying logs to upload dir... 08:07:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.965300 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-23 08:07:33.285878) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 08:07:33.289872) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267 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/8d596895b30812196cfcfa9c14cb9b5ffc8c5e333b45c365d928d68e0ebc3a7af9ec8ada522491134f702bb985795fa9368e831eda3f816aadca9bd1c0a8ed45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1eff168f8cf1ae41056d6d1c4e87ef3e0a2585b83e24578115afd2d788330039511f41a4baf2fd7a5cfa6366b4a729378df4b6ed0ef0187c8bd7cf0fcd4c9422"} build_url:https://queue.taskcluster.net/v1/task/CJGqjjwnSQW3ipv_GUen1w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/CJGqjjwnSQW3ipv_GUen1w/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/8d596895b30812196cfcfa9c14cb9b5ffc8c5e333b45c365d928d68e0ebc3a7af9ec8ada522491134f702bb985795fa9368e831eda3f816aadca9bd1c0a8ed45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1eff168f8cf1ae41056d6d1c4e87ef3e0a2585b83e24578115afd2d788330039511f41a4baf2fd7a5cfa6366b4a729378df4b6ed0ef0187c8bd7cf0fcd4c9422"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 08:07:33.314101) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 08:07:33.314425) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450885589.33644-2131637267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004690 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 08:07:33.399519) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 08:07:33.399823) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 08:07:33.400097) ========= ========= Total master_lag: 0.22 =========