builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1452225384.66 results: success (0) buildid: 20160107173008 builduid: aae021f5d0504076914c286b6f9f389d revision: 05079951b25fbdd4bacb67af7a8228b75caf8367 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:24.655786) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:24.656342) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:24.656794) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006329 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:24.686519) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:24.686863) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:24.707789) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:24.708114) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004678 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:24.757712) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:24.758052) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:24.758472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:24.758813) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 19:56:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-01-07 19:56:25 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:24.949792) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:24.950368) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019460 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:25.007045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 19:56:25.007403) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 05079951b25fbdd4bacb67af7a8228b75caf8367 --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 05079951b25fbdd4bacb67af7a8228b75caf8367 --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=7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 19:56:25,151 truncating revision to first 12 chars 2016-01-07 19:56:25,152 Setting DEBUG logging. 2016-01-07 19:56:25,152 attempt 1/10 2016-01-07 19:56:25,152 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/05079951b25f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 19:56:26,348 unpacking tar archive at: b2g-inbound-05079951b25f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.519812 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 19:56:26.543544) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:26.543931) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:26.553396) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:26.553796) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 19:56:26.554311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-07 19:56:26.554644) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:56:26 INFO - MultiFileLogger online at 20160107 19:56:26 in /builds/slave/test-pgo 19:56:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 19:56:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:56:26 INFO - {'append_to_log': False, 19:56:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:56:26 INFO - 'blob_upload_branch': 'B2G-Inbound', 19:56:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:56:26 INFO - 'branch': 'B2G-Inbound', 19:56:26 INFO - 'buildbot_json_path': 'buildprops.json', 19:56:26 INFO - 'config_files': ('talos/linux_config.py',), 19:56:26 INFO - 'default_actions': ('clobber', 19:56:26 INFO - 'read-buildbot-config', 19:56:26 INFO - 'download-and-extract', 19:56:26 INFO - 'populate-webroot', 19:56:26 INFO - 'create-virtualenv', 19:56:26 INFO - 'install', 19:56:26 INFO - 'run-tests'), 19:56:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:56:26 INFO - 'download_minidump_stackwalk': True, 19:56:26 INFO - 'download_symbols': 'ondemand', 19:56:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:56:26 INFO - 'tooltool.py': '/tools/tooltool.py', 19:56:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:56:26 INFO - '/tools/misc-python/virtualenv.py')}, 19:56:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:56:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:56:26 INFO - 'installer_path': 'installer.exe', 19:56:26 INFO - 'log_level': 'info', 19:56:26 INFO - 'log_name': 'talos', 19:56:26 INFO - 'log_to_console': True, 19:56:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:56:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:56:26 INFO - 'opt_config_files': (), 19:56:26 INFO - 'pip_index': False, 19:56:26 INFO - 'sps_profile': False, 19:56:26 INFO - 'sps_profile_interval': 0, 19:56:26 INFO - 'suite': 'dromaeojs', 19:56:26 INFO - 'system_bits': '32', 19:56:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:56:26 INFO - 'title': 'talos-linux64-ix-005', 19:56:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:56:26 INFO - 'use_talos_json': True, 19:56:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:56:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:56:26 INFO - 'work_dir': 'build'} 19:56:26 INFO - ##### 19:56:26 INFO - ##### Running clobber step. 19:56:26 INFO - ##### 19:56:26 INFO - Running pre-action listener: _resource_record_pre_action 19:56:26 INFO - Running main action method: clobber 19:56:26 INFO - rmtree: /builds/slave/test-pgo/build 19:56:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:56:27 INFO - Running post-action listener: _resource_record_post_action 19:56:27 INFO - ##### 19:56:27 INFO - ##### Running read-buildbot-config step. 19:56:27 INFO - ##### 19:56:27 INFO - Running pre-action listener: _resource_record_pre_action 19:56:27 INFO - Running main action method: read_buildbot_config 19:56:27 INFO - Using buildbot properties: 19:56:27 INFO - { 19:56:27 INFO - "project": "", 19:56:27 INFO - "product": "firefox", 19:56:27 INFO - "script_repo_revision": "production", 19:56:27 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 19:56:27 INFO - "repository": "", 19:56:27 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 19:56:27 INFO - "buildid": "20160107173008", 19:56:27 INFO - "pgo_build": "True", 19:56:27 INFO - "basedir": "/builds/slave/test-pgo", 19:56:27 INFO - "buildnumber": 1089, 19:56:27 INFO - "slavename": "talos-linux64-ix-005", 19:56:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:56:27 INFO - "platform": "ubuntu64_hw", 19:56:27 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 19:56:27 INFO - "branch": "b2g-inbound", 19:56:27 INFO - "repo_path": "integration/b2g-inbound", 19:56:27 INFO - "revision": "05079951b25fbdd4bacb67af7a8228b75caf8367", 19:56:27 INFO - "stage_platform": "linux64-pgo", 19:56:27 INFO - "builduid": "aae021f5d0504076914c286b6f9f389d", 19:56:27 INFO - "slavebuilddir": "test" 19:56:27 INFO - } 19:56:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:56:27 INFO - Running post-action listener: _resource_record_post_action 19:56:27 INFO - ##### 19:56:27 INFO - ##### Running download-and-extract step. 19:56:27 INFO - ##### 19:56:27 INFO - Running pre-action listener: _resource_record_pre_action 19:56:27 INFO - Running main action method: download_and_extract 19:56:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:27 INFO - https://queue.taskcluster.net/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:56:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/test_packages.json 19:56:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/test_packages.json 19:56:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:56:28 INFO - Downloaded 1302 bytes. 19:56:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:56:28 INFO - Using the following test package requirements: 19:56:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:56:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:56:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:28 INFO - u'jsshell-linux-x86_64.zip'], 19:56:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:56:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:56:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:56:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:56:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:56:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:56:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:56:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:56:28 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')]} 19:56:28 INFO - https://queue.taskcluster.net/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:56:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:56:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:56:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/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 19:56:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/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 19:56:31 INFO - Downloaded 24018252 bytes. 19:56:31 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 19:56:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:56:31 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 19:56:32 INFO - Return code: 0 19:56:32 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 19:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:32 INFO - https://queue.taskcluster.net/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/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 19:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/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 19:56:36 INFO - Downloaded 24018252 bytes. 19:56:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:56:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:56:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:56:37 INFO - Return code: 0 19:56: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')]} 19:56:37 INFO - https://queue.taskcluster.net/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/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 19:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/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 19:56:38 INFO - Downloaded 11132285 bytes. 19:56:38 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 19:56:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:56:38 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 19:56:38 INFO - Return code: 0 19:56:38 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')]} 19:56:38 INFO - https://queue.taskcluster.net/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/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 19:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HK8LNKtoS5CpPXLMkHhseA/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 19:56:40 INFO - Downloaded 55921124 bytes. 19:56:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:56:40 INFO - mkdir: /builds/slave/test-pgo/properties 19:56:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:56:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:56:40 INFO - Contents: 19:56:40 INFO - build_url:https://queue.taskcluster.net/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:56:40 INFO - Running post-action listener: _resource_record_post_action 19:56:40 INFO - Running post-action listener: set_extra_try_arguments 19:56:40 INFO - ##### 19:56:40 INFO - ##### Running populate-webroot step. 19:56:40 INFO - ##### 19:56:40 INFO - Running pre-action listener: _resource_record_pre_action 19:56:40 INFO - Running main action method: populate_webroot 19:56:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:56:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:56:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:56:40 INFO - '--tppagecycles', 19:56:40 INFO - '7'], 19:56:40 INFO - 'tests': ['tsvgm']}}, 19:56:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:56:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:56:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:56:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:56:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:56:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:56:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:56:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:40 INFO - 'talos_options': ['--e10s'], 19:56:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:56:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:40 INFO - 'tests': ['damp', 'tps']}, 19:56:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:40 INFO - 'talos_options': ['--e10s'], 19:56:40 INFO - 'tests': ['damp', 'tps']}, 19:56:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:56:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:56:40 INFO - 'other': {'tests': ['a11yr', 19:56:40 INFO - 'ts_paint', 19:56:40 INFO - 'tpaint', 19:56:40 INFO - 'sessionrestore', 19:56:40 INFO - 'sessionrestore_no_auto_restore']}, 19:56:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:56:40 INFO - 'tests': ['a11yr', 19:56:40 INFO - 'ts_paint', 19:56:40 INFO - 'tpaint', 19:56:40 INFO - 'sessionrestore', 19:56:40 INFO - 'sessionrestore_no_auto_restore']}, 19:56:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:56:40 INFO - 'tests': ['a11yr', 19:56:40 INFO - 'ts_paint', 19:56:40 INFO - 'tpaint', 19:56:40 INFO - 'sessionrestore', 19:56:40 INFO - 'sessionrestore_no_auto_restore']}, 19:56:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:56:40 INFO - 'tests': ['a11yr', 19:56:40 INFO - 'ts_paint', 19:56:40 INFO - 'tpaint', 19:56:40 INFO - 'sessionrestore', 19:56:40 INFO - 'sessionrestore_no_auto_restore']}, 19:56:40 INFO - 'other_l64': {'tests': ['a11yr', 19:56:40 INFO - 'ts_paint', 19:56:40 INFO - 'tpaint', 19:56:40 INFO - 'sessionrestore', 19:56:40 INFO - 'sessionrestore_no_auto_restore']}, 19:56:40 INFO - 'other_nol64': {'tests': ['a11yr', 19:56:40 INFO - 'ts_paint', 19:56:40 INFO - 'tpaint', 19:56:40 INFO - 'sessionrestore', 19:56:40 INFO - 'sessionrestore_no_auto_restore']}, 19:56:40 INFO - 'svgr': {'tests': ['tsvgx', 19:56:40 INFO - 'tsvgr_opacity', 19:56:40 INFO - 'tart', 19:56:40 INFO - 'tscrollx', 19:56:40 INFO - 'cart']}, 19:56:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:56:40 INFO - 'tests': ['tsvgx', 19:56:40 INFO - 'tsvgr_opacity', 19:56:40 INFO - 'tart', 19:56:40 INFO - 'tscrollx', 19:56:40 INFO - 'cart']}, 19:56:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:40 INFO - 'tests': ['tp5o']}, 19:56:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:40 INFO - 'talos_options': ['--e10s'], 19:56:40 INFO - 'tests': ['tp5o']}, 19:56:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:40 INFO - 'talos_options': ['--xperf_path', 19:56:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:56:40 INFO - 'tests': ['tp5n']}, 19:56:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:40 INFO - 'talos_options': ['--e10s', 19:56:40 INFO - '--xperf_path', 19:56:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:56:40 INFO - 'tests': ['tp5n']}}, 19:56:40 INFO - 'talos.zip': {'path': '', 19:56:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:56:40 INFO - Running post-action listener: _resource_record_post_action 19:56:40 INFO - ##### 19:56:40 INFO - ##### Running create-virtualenv step. 19:56:40 INFO - ##### 19:56:40 INFO - Running pre-action listener: _resource_record_pre_action 19:56:40 INFO - Running main action method: create_virtualenv 19:56:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:56:40 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 19:56:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:56:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:56:40 INFO - Using real prefix '/usr' 19:56:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:56:40 INFO - Installing distribute.............................................................................................................................................................................................done. 19:56:42 INFO - Installing pip.................done. 19:56:42 INFO - Return code: 0 19:56:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:56:42 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')]} 19:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:42 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')]} 19:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:42 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 0x7fcbb0a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2639630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca840>, '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 0x26376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', '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 19:56:42 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 19:56:42 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 19:56:42 INFO - Using env: {'DISPLAY': ':0', 19:56:42 INFO - 'HOME': '/home/cltbld', 19:56:42 INFO - 'LANG': 'en_US.UTF-8', 19:56:42 INFO - 'LANGUAGE': 'en_US:en', 19:56:42 INFO - 'LOGNAME': 'cltbld', 19:56:42 INFO - 'MAIL': '/var/mail/cltbld', 19:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:42 INFO - 'MOZ_NO_REMOTE': '1', 19:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:42 INFO - 'NO_EM_RESTART': '1', 19:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:42 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:42 INFO - 'SHELL': '/bin/bash', 19:56:42 INFO - 'SHLVL': '1', 19:56:42 INFO - 'TERM': 'linux', 19:56:42 INFO - 'TMOUT': '86400', 19:56:42 INFO - 'USER': 'cltbld', 19:56:42 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', 19:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:42 INFO - '_': '/tools/buildbot/bin/python'} 19:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:43 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 19:56:43 INFO - Cleaning up... 19:56:43 INFO - Return code: 0 19:56:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:56: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')]} 19:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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')]} 19:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:43 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 0x7fcbb0a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2639630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca840>, '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 0x26376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', '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 19:56:43 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 19:56:43 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 19:56:43 INFO - Using env: {'DISPLAY': ':0', 19:56:43 INFO - 'HOME': '/home/cltbld', 19:56:43 INFO - 'LANG': 'en_US.UTF-8', 19:56:43 INFO - 'LANGUAGE': 'en_US:en', 19:56:43 INFO - 'LOGNAME': 'cltbld', 19:56:43 INFO - 'MAIL': '/var/mail/cltbld', 19:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:43 INFO - 'MOZ_NO_REMOTE': '1', 19:56:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:43 INFO - 'NO_EM_RESTART': '1', 19:56:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:43 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:43 INFO - 'SHELL': '/bin/bash', 19:56:43 INFO - 'SHLVL': '1', 19:56:43 INFO - 'TERM': 'linux', 19:56:43 INFO - 'TMOUT': '86400', 19:56:43 INFO - 'USER': 'cltbld', 19:56:43 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', 19:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:43 INFO - '_': '/tools/buildbot/bin/python'} 19:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:43 INFO - Downloading/unpacking psutil>=0.7.1 19:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:56:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:56:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:56:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:56:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:56:45 INFO - Installing collected packages: psutil 19:56:45 INFO - Running setup.py install for psutil 19:56:45 INFO - building 'psutil._psutil_linux' extension 19:56:45 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 19:56:45 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 19:56:45 INFO - building 'psutil._psutil_posix' extension 19:56:45 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 19:56:45 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 19:56:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:56:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:56:45 INFO - Successfully installed psutil 19:56:45 INFO - Cleaning up... 19:56:45 INFO - Return code: 0 19:56:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:56:45 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')]} 19:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:45 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')]} 19:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:45 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 0x7fcbb0a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2639630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca840>, '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 0x26376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', '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 19:56:45 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 19:56:45 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 19:56:45 INFO - Using env: {'DISPLAY': ':0', 19:56:45 INFO - 'HOME': '/home/cltbld', 19:56:45 INFO - 'LANG': 'en_US.UTF-8', 19:56:45 INFO - 'LANGUAGE': 'en_US:en', 19:56:45 INFO - 'LOGNAME': 'cltbld', 19:56:45 INFO - 'MAIL': '/var/mail/cltbld', 19:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:45 INFO - 'MOZ_NO_REMOTE': '1', 19:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:45 INFO - 'NO_EM_RESTART': '1', 19:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:45 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:45 INFO - 'SHELL': '/bin/bash', 19:56:45 INFO - 'SHLVL': '1', 19:56:45 INFO - 'TERM': 'linux', 19:56:45 INFO - 'TMOUT': '86400', 19:56:45 INFO - 'USER': 'cltbld', 19:56:45 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', 19:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:45 INFO - '_': '/tools/buildbot/bin/python'} 19:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:56:45 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 19:56:45 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 19:56:45 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 19:56:45 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 19:56:45 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 19:56:45 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 19:56:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:56:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:56:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:56:47 INFO - Installing collected packages: mozsystemmonitor 19:56:47 INFO - Running setup.py install for mozsystemmonitor 19:56:47 INFO - Successfully installed mozsystemmonitor 19:56:47 INFO - Cleaning up... 19:56:47 INFO - Return code: 0 19:56:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcbb0a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2639630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca840>, '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 0x26376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', '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 19:56:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:56:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:56:47 INFO - Using env: {'DISPLAY': ':0', 19:56:47 INFO - 'HOME': '/home/cltbld', 19:56:47 INFO - 'LANG': 'en_US.UTF-8', 19:56:47 INFO - 'LANGUAGE': 'en_US:en', 19:56:47 INFO - 'LOGNAME': 'cltbld', 19:56:47 INFO - 'MAIL': '/var/mail/cltbld', 19:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:47 INFO - 'MOZ_NO_REMOTE': '1', 19:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:47 INFO - 'NO_EM_RESTART': '1', 19:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:47 INFO - 'SHELL': '/bin/bash', 19:56:47 INFO - 'SHLVL': '1', 19:56:47 INFO - 'TERM': 'linux', 19:56:47 INFO - 'TMOUT': '86400', 19:56:47 INFO - 'USER': 'cltbld', 19:56:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', 19:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:47 INFO - '_': '/tools/buildbot/bin/python'} 19:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:48 INFO - Downloading/unpacking blobuploader==1.2.4 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56:49 INFO - Downloading blobuploader-1.2.4.tar.gz 19:56:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:56:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:56:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:56:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:56:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:50 INFO - Downloading docopt-0.6.1.tar.gz 19:56:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:56:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:56:50 INFO - Installing collected packages: blobuploader, requests, docopt 19:56:50 INFO - Running setup.py install for blobuploader 19:56:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:56:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:56:50 INFO - Running setup.py install for requests 19:56:50 INFO - Running setup.py install for docopt 19:56:51 INFO - Successfully installed blobuploader requests docopt 19:56:51 INFO - Cleaning up... 19:56:51 INFO - Return code: 0 19:56:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:51 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 0x7fcbb0a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2639630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca840>, '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 0x26376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', '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 19:56:51 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 19:56:51 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 19:56:51 INFO - Using env: {'DISPLAY': ':0', 19:56:51 INFO - 'HOME': '/home/cltbld', 19:56:51 INFO - 'LANG': 'en_US.UTF-8', 19:56:51 INFO - 'LANGUAGE': 'en_US:en', 19:56:51 INFO - 'LOGNAME': 'cltbld', 19:56:51 INFO - 'MAIL': '/var/mail/cltbld', 19:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:51 INFO - 'MOZ_NO_REMOTE': '1', 19:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:51 INFO - 'NO_EM_RESTART': '1', 19:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:51 INFO - 'SHELL': '/bin/bash', 19:56:51 INFO - 'SHLVL': '1', 19:56:51 INFO - 'TERM': 'linux', 19:56:51 INFO - 'TMOUT': '86400', 19:56:51 INFO - 'USER': 'cltbld', 19:56:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', 19:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:51 INFO - '_': '/tools/buildbot/bin/python'} 19:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:56:51 INFO - Running setup.py (path:/tmp/pip-jLDD0i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:56:51 INFO - Running setup.py (path:/tmp/pip-98gjf_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:56:51 INFO - Running setup.py (path:/tmp/pip-nxIFz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:56:51 INFO - Running setup.py (path:/tmp/pip-t6z3lQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:56:51 INFO - Running setup.py (path:/tmp/pip-prty4w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:56:51 INFO - Running setup.py (path:/tmp/pip-vc33Zn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:56:51 INFO - Running setup.py (path:/tmp/pip-decujA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:56:51 INFO - Running setup.py (path:/tmp/pip-rfwYfT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:56:51 INFO - Running setup.py (path:/tmp/pip-i3GS1r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:56:51 INFO - Running setup.py (path:/tmp/pip-MLjxk7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:56:52 INFO - Running setup.py (path:/tmp/pip-LNdEVc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:56:52 INFO - Running setup.py (path:/tmp/pip-r41Unm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:56:52 INFO - Running setup.py (path:/tmp/pip-TMmSoP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:56:52 INFO - Running setup.py (path:/tmp/pip-6tlmlF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:56:52 INFO - Running setup.py (path:/tmp/pip-q5Tqxr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:56:52 INFO - Running setup.py (path:/tmp/pip-dawrV1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:56:52 INFO - Running setup.py (path:/tmp/pip-i_6cGe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:56:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:56:52 INFO - Running setup.py install for manifestparser 19:56:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:56:52 INFO - Running setup.py install for mozcrash 19:56:52 INFO - Running setup.py install for mozdebug 19:56:52 INFO - Running setup.py install for mozdevice 19:56:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:56:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:56:52 INFO - Running setup.py install for mozfile 19:56:53 INFO - Running setup.py install for mozhttpd 19:56:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:56:53 INFO - Running setup.py install for mozinfo 19:56:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:56:53 INFO - Running setup.py install for mozInstall 19:56:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:56:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:56:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:56:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:56:53 INFO - Running setup.py install for mozleak 19:56:53 INFO - Running setup.py install for mozlog 19:56:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:56:53 INFO - Running setup.py install for moznetwork 19:56:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:56:53 INFO - Running setup.py install for mozprocess 19:56:53 INFO - Running setup.py install for mozprofile 19:56:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:56:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:56:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:56:53 INFO - Running setup.py install for mozrunner 19:56:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:56:54 INFO - Running setup.py install for mozscreenshot 19:56:54 INFO - Running setup.py install for moztest 19:56:54 INFO - Running setup.py install for mozversion 19:56:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:56:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:56:54 INFO - Cleaning up... 19:56:54 INFO - Return code: 0 19:56:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fcbb0a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2639630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca840>, '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 0x26376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', '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 19:56:54 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 19:56:54 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 19:56:54 INFO - Using env: {'DISPLAY': ':0', 19:56:54 INFO - 'HOME': '/home/cltbld', 19:56:54 INFO - 'LANG': 'en_US.UTF-8', 19:56:54 INFO - 'LANGUAGE': 'en_US:en', 19:56:54 INFO - 'LOGNAME': 'cltbld', 19:56:54 INFO - 'MAIL': '/var/mail/cltbld', 19:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:54 INFO - 'MOZ_NO_REMOTE': '1', 19:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:54 INFO - 'NO_EM_RESTART': '1', 19:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:54 INFO - 'SHELL': '/bin/bash', 19:56:54 INFO - 'SHLVL': '1', 19:56:54 INFO - 'TERM': 'linux', 19:56:54 INFO - 'TMOUT': '86400', 19:56:54 INFO - 'USER': 'cltbld', 19:56:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', 19:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:54 INFO - '_': '/tools/buildbot/bin/python'} 19:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:56:54 INFO - Running setup.py (path:/tmp/pip-jakBcE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:56:54 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)) 19:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:56:54 INFO - Running setup.py (path:/tmp/pip-zgLq7p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:56:54 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)) 19:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:56:54 INFO - Running setup.py (path:/tmp/pip-NVprV_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:56:54 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)) 19:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:56:54 INFO - Running setup.py (path:/tmp/pip-N7XcMz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:56:54 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)) 19:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:56:54 INFO - Running setup.py (path:/tmp/pip-4OWwHM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:56:54 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)) 19:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:56:54 INFO - Running setup.py (path:/tmp/pip-5rS4JD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:56:54 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)) 19:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:56:54 INFO - Running setup.py (path:/tmp/pip-ssJXlH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:56:55 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)) 19:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:56:55 INFO - Running setup.py (path:/tmp/pip-Vy7yD0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:56:55 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)) 19:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:56:55 INFO - Running setup.py (path:/tmp/pip-OQ1d6H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:56:55 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)) 19:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:56:55 INFO - Running setup.py (path:/tmp/pip-lmeEoV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:56:55 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)) 19:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:56:55 INFO - Running setup.py (path:/tmp/pip-d_XiTm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:56:55 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)) 19:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:56:55 INFO - Running setup.py (path:/tmp/pip-8qGDN6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:56:55 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)) 19:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:56:55 INFO - Running setup.py (path:/tmp/pip-msC16t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:56:55 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)) 19:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:56:55 INFO - Running setup.py (path:/tmp/pip-pvLCda-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:56:55 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)) 19:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:56:55 INFO - Running setup.py (path:/tmp/pip-EI6xy6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:56:55 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)) 19:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:56:55 INFO - Running setup.py (path:/tmp/pip-V6iSrE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:56:55 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)) 19:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:56:55 INFO - Running setup.py (path:/tmp/pip-5CBgvP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:56:55 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)) 19:56:55 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)) 19:56:55 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)) 19:56:55 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)) 19:56:55 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)) 19:56:55 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)) 19:56:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:57 INFO - Downloading blessings-1.5.1.tar.gz 19:56:57 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 19:56:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:56:57 INFO - Installing collected packages: blessings 19:56:57 INFO - Running setup.py install for blessings 19:56:57 INFO - Successfully installed blessings 19:56:57 INFO - Cleaning up... 19:56:57 INFO - Return code: 0 19:56:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:56:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:56:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:56:58 INFO - Reading from file tmpfile_stdout 19:56:58 INFO - Current package versions: 19:56:58 INFO - argparse == 1.2.1 19:56:58 INFO - blessings == 1.5.1 19:56:58 INFO - blobuploader == 1.2.4 19:56:58 INFO - docopt == 0.6.1 19:56:58 INFO - manifestparser == 1.1 19:56:58 INFO - mozInstall == 1.12 19:56:58 INFO - mozcrash == 0.16 19:56:58 INFO - mozdebug == 0.1 19:56:58 INFO - mozdevice == 0.47 19:56:58 INFO - mozfile == 1.2 19:56:58 INFO - mozhttpd == 0.7 19:56:58 INFO - mozinfo == 0.9 19:56:58 INFO - mozleak == 0.1 19:56:58 INFO - mozlog == 3.1 19:56:58 INFO - moznetwork == 0.27 19:56:58 INFO - mozprocess == 0.22 19:56:58 INFO - mozprofile == 0.28 19:56:58 INFO - mozrunner == 6.11 19:56:58 INFO - mozscreenshot == 0.1 19:56:58 INFO - mozsystemmonitor == 0.0 19:56:58 INFO - moztest == 0.7 19:56:58 INFO - mozversion == 1.4 19:56:58 INFO - psutil == 3.1.1 19:56:58 INFO - requests == 1.2.3 19:56:58 INFO - wsgiref == 0.1.2 19:56:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:56: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')]} 19:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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')]} 19:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fcbb0a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2639630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca840>, '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 0x26376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', '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 19:56:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 19:56:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 19:56:58 INFO - Using env: {'DISPLAY': ':0', 19:56:58 INFO - 'HOME': '/home/cltbld', 19:56:58 INFO - 'LANG': 'en_US.UTF-8', 19:56:58 INFO - 'LANGUAGE': 'en_US:en', 19:56:58 INFO - 'LOGNAME': 'cltbld', 19:56:58 INFO - 'MAIL': '/var/mail/cltbld', 19:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:58 INFO - 'MOZ_NO_REMOTE': '1', 19:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:58 INFO - 'NO_EM_RESTART': '1', 19:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:58 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:58 INFO - 'SHELL': '/bin/bash', 19:56:58 INFO - 'SHLVL': '1', 19:56:58 INFO - 'TERM': 'linux', 19:56:58 INFO - 'TMOUT': '86400', 19:56:58 INFO - 'USER': 'cltbld', 19:56:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', 19:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:58 INFO - '_': '/tools/buildbot/bin/python'} 19:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:58 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)) 19:56:58 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)) 19:56:58 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)) 19:56:58 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)) 19:56:58 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)) 19:56:58 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)) 19:56:58 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)) 19:56:58 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)) 19:56:58 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)) 19:56:58 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)) 19:56:58 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)) 19:56:58 INFO - Cleaning up... 19:56:58 INFO - Return code: 0 19:56:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:56: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')]} 19:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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')]} 19:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbb0a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2639630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca840>, '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 0x26376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', '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 19:56: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', 'jsonschema'] in /builds/slave/test-pgo/build 19:56: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 jsonschema 19:56:58 INFO - Using env: {'DISPLAY': ':0', 19:56:58 INFO - 'HOME': '/home/cltbld', 19:56:58 INFO - 'LANG': 'en_US.UTF-8', 19:56:58 INFO - 'LANGUAGE': 'en_US:en', 19:56:58 INFO - 'LOGNAME': 'cltbld', 19:56:58 INFO - 'MAIL': '/var/mail/cltbld', 19:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:58 INFO - 'MOZ_NO_REMOTE': '1', 19:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:58 INFO - 'NO_EM_RESTART': '1', 19:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:58 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:58 INFO - 'SHELL': '/bin/bash', 19:56:58 INFO - 'SHLVL': '1', 19:56:58 INFO - 'TERM': 'linux', 19:56:58 INFO - 'TMOUT': '86400', 19:56:58 INFO - 'USER': 'cltbld', 19:56:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', 19:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:58 INFO - '_': '/tools/buildbot/bin/python'} 19:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:58 INFO - Downloading/unpacking jsonschema 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:57:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:57:00 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 19:57:00 INFO - Downloading/unpacking functools32 (from jsonschema) 19:57: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 19:57: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 19:57: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 19:57: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 19:57: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 19:57: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 19:57:00 INFO - Downloading functools32-3.2.3-2.tar.gz 19:57:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:57:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:57:00 INFO - warning: no files found matching '*.txt' 19:57:00 INFO - no previously-included directories found matching 'build' 19:57:00 INFO - no previously-included directories found matching 'dist' 19:57:00 INFO - no previously-included directories found matching '.git*' 19:57:00 INFO - Installing collected packages: jsonschema, functools32 19:57:00 INFO - Running setup.py install for functools32 19:57:00 INFO - warning: no files found matching '*.txt' 19:57:00 INFO - no previously-included directories found matching 'build' 19:57:00 INFO - no previously-included directories found matching 'dist' 19:57:00 INFO - no previously-included directories found matching '.git*' 19:57:00 INFO - Successfully installed jsonschema functools32 19:57:00 INFO - Cleaning up... 19:57:00 INFO - Return code: 0 19:57:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:57:00 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')]} 19:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:00 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')]} 19:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:00 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 0x7fcbb0a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2639630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca840>, '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 0x26376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', '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 19:57:00 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 19:57:00 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 19:57:00 INFO - Using env: {'DISPLAY': ':0', 19:57:00 INFO - 'HOME': '/home/cltbld', 19:57:00 INFO - 'LANG': 'en_US.UTF-8', 19:57:00 INFO - 'LANGUAGE': 'en_US:en', 19:57:00 INFO - 'LOGNAME': 'cltbld', 19:57:00 INFO - 'MAIL': '/var/mail/cltbld', 19:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:00 INFO - 'MOZ_NO_REMOTE': '1', 19:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:00 INFO - 'NO_EM_RESTART': '1', 19:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:00 INFO - 'SHELL': '/bin/bash', 19:57:00 INFO - 'SHLVL': '1', 19:57:00 INFO - 'TERM': 'linux', 19:57:00 INFO - 'TMOUT': '86400', 19:57:00 INFO - 'USER': 'cltbld', 19:57:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', 19:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:00 INFO - '_': '/tools/buildbot/bin/python'} 19:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:00 INFO - Downloading/unpacking flake8 19:57: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 19:57: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 19:57: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 19:57: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 19:57: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 19:57: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 19:57:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:57:02 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 19:57:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:57:02 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 19:57:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:02 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 19:57:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:57:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:57:03 INFO - no previously-included directories found matching 'docs/_build' 19:57:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:57:03 INFO - Running setup.py install for pep8 19:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:57:03 INFO - no previously-included directories found matching 'docs/_build' 19:57:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:57:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:57:03 INFO - Cleaning up... 19:57:03 INFO - Return code: 0 19:57:03 INFO - Running post-action listener: _resource_record_post_action 19:57:03 INFO - Running post-action listener: _start_resource_monitoring 19:57:03 INFO - Starting resource monitoring. 19:57:03 INFO - ##### 19:57:03 INFO - ##### Running install step. 19:57:03 INFO - ##### 19:57:03 INFO - Running pre-action listener: _resource_record_pre_action 19:57:03 INFO - Running main action method: install 19:57:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:57:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:57:03 INFO - Reading from file tmpfile_stdout 19:57:03 INFO - Detecting whether we're running mozinstall >=1.0... 19:57:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:57:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:57:03 INFO - Reading from file tmpfile_stdout 19:57:03 INFO - Output received: 19:57:03 INFO - Usage: mozinstall [options] installer 19:57:03 INFO - Options: 19:57:03 INFO - -h, --help show this help message and exit 19:57:03 INFO - -d DEST, --destination=DEST 19:57:03 INFO - Directory to install application into. [default: 19:57:03 INFO - "/builds/slave/test-pgo"] 19:57:03 INFO - --app=APP Application being installed. [default: firefox] 19:57:03 INFO - mkdir: /builds/slave/test-pgo/build/application 19:57:03 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'] 19:57:03 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 19:57:19 INFO - Reading from file tmpfile_stdout 19:57:19 INFO - Output received: 19:57:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:57:19 INFO - Running post-action listener: _resource_record_post_action 19:57:19 INFO - ##### 19:57:19 INFO - ##### Running run-tests step. 19:57:19 INFO - ##### 19:57:19 INFO - Running pre-action listener: _resource_record_pre_action 19:57:19 INFO - Running main action method: run_tests 19:57:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:57:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:57:19 INFO - Python 2.7.3 19:57:19 INFO - Return code: 0 19:57:19 INFO - grabbing minidump binary from tooltool 19:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:19 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 0x26ca840>, '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 0x26376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:57:19 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 19:57:19 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 19:57:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:57:19 INFO - Return code: 0 19:57:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:57:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:57:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:57:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:57:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:57:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:57:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:57:20 INFO - Return code: 0 19:57:20 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/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 19:57:20 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/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 19:57:20 INFO - Using env: {'DISPLAY': ':0', 19:57:20 INFO - 'HOME': '/home/cltbld', 19:57:20 INFO - 'LANG': 'en_US.UTF-8', 19:57:20 INFO - 'LANGUAGE': 'en_US:en', 19:57:20 INFO - 'LOGNAME': 'cltbld', 19:57:20 INFO - 'MAIL': '/var/mail/cltbld', 19:57:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:57:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:20 INFO - 'MOZ_NO_REMOTE': '1', 19:57:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:57:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:20 INFO - 'NO_EM_RESTART': '1', 19:57:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:20 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:57:20 INFO - 'SHELL': '/bin/bash', 19:57:20 INFO - 'SHLVL': '1', 19:57:20 INFO - 'TERM': 'linux', 19:57:20 INFO - 'TMOUT': '86400', 19:57:20 INFO - 'USER': 'cltbld', 19:57:20 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027', 19:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:20 INFO - '_': '/tools/buildbot/bin/python'} 19:57:20 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/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 19:57:21 INFO - mozversion application_buildid: 20160107173008 19:57:21 INFO - mozversion application_changeset: 05079951b25fbdd4bacb67af7a8228b75caf8367 19:57:21 INFO - mozversion application_display_name: Nightly 19:57:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:57:21 INFO - mozversion application_name: Firefox 19:57:21 INFO - mozversion application_remotingname: firefox 19:57:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 19:57:21 INFO - mozversion application_vendor: Mozilla 19:57:21 INFO - mozversion application_version: 46.0a1 19:57:21 INFO - mozversion platform_buildid: 20160107173008 19:57:21 INFO - mozversion platform_changeset: 05079951b25fbdd4bacb67af7a8228b75caf8367 19:57:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 19:57:21 INFO - mozversion platform_version: 46.0a1 19:57:21 INFO - using testdate: 1452225441 19:57:21 INFO - actual date: 1452225441 19:57:21 INFO - starting webserver on 'localhost:41258' 19:57:21 INFO - SUITE-START | Running 3 tests 19:57:21 INFO - TEST-START | dromaeo_css 19:57:21 INFO - operating with platform_type : linux_ 19:57:21 INFO - Initialising browser for dromaeo_css test... 19:57:21 INFO - TEST-INFO | started process 11972 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAeldNN/profile http://localhost:41258/getInfo.html) 19:57:25 INFO - PROCESS | 11972 | __metrics Screen width/height:1600/1200 19:57:25 INFO - PROCESS | 11972 | colorDepth:24 19:57:25 INFO - PROCESS | 11972 | Browser inner width/height: 1024/697 19:57:25 INFO - PROCESS | 11972 | __metrics 19:57:25 INFO - PROCESS | 11972 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:57:25 INFO - PROCESS | 11972 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:57:26 INFO - TEST-INFO | 11972: exit 0 19:57:26 INFO - Browser initialized. 19:57:26 INFO - Running cycle 1/1 for dromaeo_css test... 19:57:26 INFO - TEST-INFO | started process 12068 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAeldNN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:57:38 INFO - PROCESS | 12068 | RSS: Main: 149979136 19:57:38 INFO - PROCESS | 12068 | 19:58:29 INFO - PROCESS | 12068 | 1452225509536 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] 20:00:37 INFO - PROCESS | 12068 | Cycle 1(1): loaded http://localhost:41258/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41258/tests/dromaeo/cssquery-ext.html) 20:00:38 INFO - PROCESS | 12068 | RSS: Main: 270766080 20:00:38 INFO - PROCESS | 12068 | 20:03:41 INFO - PROCESS | 12068 | Cycle 1(1): loaded http://localhost:41258/tests/dromaeo/cssquery-ext.html (next: http://localhost:41258/tests/dromaeo/cssquery-jquery.html) 20:03:42 INFO - PROCESS | 12068 | RSS: Main: 241438720 20:03:42 INFO - PROCESS | 12068 | 20:06:43 INFO - PROCESS | 12068 | Cycle 1(1): loaded http://localhost:41258/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41258/tests/dromaeo/cssquery-mootools.html) 20:06:44 INFO - PROCESS | 12068 | RSS: Main: 237228032 20:06:44 INFO - PROCESS | 12068 | 20:09:46 INFO - PROCESS | 12068 | Cycle 1(1): loaded http://localhost:41258/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41258/tests/dromaeo/cssquery-prototype.html) 20:09:46 INFO - PROCESS | 12068 | RSS: Main: 213651456 20:09:46 INFO - PROCESS | 12068 | 20:12:49 INFO - PROCESS | 12068 | Cycle 1(1): loaded http://localhost:41258/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41258/tests/dromaeo/cssquery-yui.html) 20:12:50 INFO - PROCESS | 12068 | RSS: Main: 220405760 20:12:50 INFO - PROCESS | 12068 | 20:15:52 INFO - PROCESS | 12068 | Cycle 1(1): loaded http://localhost:41258/tests/dromaeo/cssquery-yui.html (next: http://localhost:41258/tests/dromaeo/cssquery-dojo.html) 20:15:53 INFO - PROCESS | 12068 | RSS: Main: 269201408 20:15:53 INFO - PROCESS | 12068 | 20:15:53 INFO - PROCESS | 12068 | __start_tp_report 20:15:53 INFO - PROCESS | 12068 | _x_x_mozilla_page_load 20:15:53 INFO - PROCESS | 12068 | _x_x_mozilla_page_load_details 20:15:53 INFO - PROCESS | 12068 | |i|pagename|runs| 20:15:53 INFO - PROCESS | 12068 | |0;dojo.html;3106.270026543762;3157.668444813296;3197.8560964756584;3201.9679803201975;3221.677832216779;5041.924371134432;5044.520770526803;5083.694978301304;5144.356955380577;5167.715775632339;5103.897922041557;5114.565261952729;5175.767090480928;5185.870353241171;5242.082635538784;4645.86062418128;4681.976590117053;4737.834175803848;4785.784639691222;4791.928121078169;4734.076855013273;4738.881527961811;4758.762061896909;4794.256890182028;4850.126977144113;4579.564941330568;4637.953620463786;4677.321788340689;4734.455537613184;4739.857804265877;4685.81256749733;4695.413073365829;4703.976480117578;4720.905581888377;4761.500042495522;4652.767361631905;4673.532646735333;4697.929531057037;4718.292256161569;4737.478877323491;4944.134776414113;4964.478729733362;5038.193888977783;5056.367954005749;5079.085764562377;5464.617476776627;5483.259759932398;5487.506124448819;5489.094299440588;5495.587830912697;5465.289512363407;5495.6153069285165;5498.972505137489;5500.477454641803;5503.559715222773;5050.393952725696;5051.696898186121;5134.7689353978785;5143.974280128576;5151.0470562945975;5608.355039170548;5612.102063669793;5617.971910140505;5619.269494965628;5658.179563963202;5403.459654034565;5404.216388623628;5412.83761487156;5413.269208656781;5417.295751552352;5399.0281749285505;5438.700871452029;5443.673379597237;5490.368607610176;5561.721913904288;5515.090010148361;5519.172124181325;5532.723363831873;5537.58468114893;5539.14143307788;5432.429594892479;5463.9180412293845;5465.316835395575;5466.617336786387;5518.392976772552;4225.091605304874;4283.593058659422;4294.248506511348;4369.235383807821;4369.956300437018;3862.9613703863165;3878.340682083996;3884.941725874114;3922.941155882664;3926.09699769049;5066.594672426197;5069.112905241568;5073.188289873602;5077.136886729265;5084.46613105626;5390.865228369244;5407.594430417735;5477.945220547744;5506.03644362235;5507.504324610804;4988.625853061035;5003.199488081889;5004.2493625956395;5021.472745361684;5061.164907790247;4666.090112428112;4673.322368256584;4683.180443422388;4686.36734040907;4723.409573803275;5536.363318218457;5547.528460080938;5645.858853528613;5649.943500564942;5654.264945557051;5473.808416705556;5502.614816962774;5534.695591742332;5540.750666219949;5544.473275038865;5620.072688006433;5657.264555607745;5658.094704847204;5661.377248502579;5663.122216056518;5321.680699158062;5407.378151512627;5425.484578964992;5464.316960379952;5486.31421072366;5480.506754392124;5498.45015498447;5506.03644362227;5513.090340094;5515.806946756844;5275.287836142072;5308.840734777963;5371.946280537301;5383.192521121863;5432.511074003359;5246.08193566132;5315.867103322448;5321.3880403754065;5344.839654810362;5357.517823395913;5273.209018647233;5287.286216360742;5288.048151332797;5288.920666189933;5290.68255904647;5317.016351974742;5338.1992701093595;5356.5714742821265;5359.464053594609;5412.729363531729;5226.9215961761365;5282.4717528246865;5329.333833270841;5332.173513105475;5377.758000889891 20:15:53 INFO - PROCESS | 12068 | |1;ext.html;524.9737513124344;528.8307741522711;532.1299675031322;546.8660178256326;556.1463154058521;27505.312367190807;28203;34762.82618586907;35185.648143518556;35254.64745352546;37762;38089.42865857014;38264.80867595658;38269.425958610576;38303.808480957625;8248.257656810885;8505.914940850605;8506.36202284828;8511;8521.573921303941;7406.185319614838;7590.620468976556;9850.113489785917;10117;10122;9828.606855725762;9936.05607467293;9938.15525680318;9943.055409736064;9949;7387.298206670358;7617.314441700219;9701.320907536476;9862.60549578016;9882.456464894392;7358.337749602561;9806.803863922752;10020.198384129251;10020.348677336022;10043.096121349041;35012.29975400478;35463;35492.82253588716;35495;35512.28975420477;3268.084936217863;3270.427675156862;3550.946735798965;3767.0958969847316;3945.526536815572;27390.178294651192;27536.862315688493;27825.304367390774;28512.714872851215;29314.853425732734;3820.6943444524372;3867.9540011008658;3907.7459965102175;3953.7034722395647;3969.28552860485;262930;266002;267201;267500;267738;50538.241926371134;55825.162622560696;56127.438725613036;56189.43810561842;56227;44780.3282950756;59424;59794;60163;60168.699156503935;14836.109833409813;15096.094234345974;15110.471133510275;15120.319585618674;15131.243437828065;11609.36148511823;11617.419129043514;11669.124815638861;11689.240199387013;11691.356975366267;18074.096295185187;18502.44492665222;18531.166097525373;18610.906945465187;18625.906870465562;6827.112475378269;6893.138357705287;6918.965405172942;7060.117485314336;7064.823379415453;906.4425378392241;969.7672558585889;973.1922504321537;982.3909176310733;982.5774916785708;24464;24827.62758558623;24839.751602483742;24886.626700599507;24888.253352399457;1014.3761586624173;1020.9642662506776;1034.8654674892216;1047.0890325416935;1131.6265632341308;12924.41840117197;13792.172469651852;13831.239281839595;14817.481388151364;15170.08491830971;315893;319560;319783;320019;320754;49434;49597;49721.502784972414;49732.50267497351;49850.750746246034;1225.66906935127;1227.643983244849;1246.5325502936398;1284.3770771175973;1315.6710822294426;21579.352619420813;26002;26199.607005894544;26443.735562644128;26459;42525.149497010505;42528.362074568286;42555.36166957436;42734.35898461588;42894;270739;273738;291292;292721;295087;24953.87523062373;29720.256993575334;30297.24256893595;30562;30684.386312273182;34642.307153857284;35766.821165895046;36071;36390.454143188406;36411.81794091013;30447.695523044487;30512.237194070327;30872.228194295323;33511;34432.48351274783;31205.375892482476;33274;33896.491552626234;34312.485312720826;34546.309073818884;31878;31896.8405157982;32112.678873210967;32139.51790723188;33921.660783392836;30330.54504182395;30385.544216837206;31119.844400777853;31219.687803121677;31391.529127063568;23458.882705586362;24112.156074537306;24184.395390114685;24268.878655606608;24515.877420612782 20:15:53 INFO - PROCESS | 12068 | |2;jquery.html;357.85685725709715;358.76500891915805;361.1711122972777;361.28285353573153;364.52247555702024;13418.93290533546;13458.730825383487;16674.833251667478;16790;17796.733049004277;14939.327730252138;15282.312295946682;15742.29159687814;15742.763858542103;16025.679486410265;4897.559219670229;5349.54528865045;5353.0899747043095;5355.3305836770405;5357.383900851393;3974.264761019206;4133.987173142569;5231.450697676746;5334.839954801362;5602.7758889644365;5714.085746280575;5715.771369145229;5786.942130578683;5787.594868359217;5823.796167134151;6380.744770209186;6649.235337936151;6670.232923213795;6677.732890684367;6679.332066793306;6112.6638034908065;6327.746890124389;6329.303776584572;6332.905006424908;6363.268224154235;20886.47783805402;21274.404419668586;21587.784122158733;22329.665055024027;22516.887415562982;2114.534802343482;2208.3043841189974;2244.6857439958417;2275.2377953385635;2745.272502786763;13376.799348009788;13480.460781568725;13647.522336718168;13792.586222413343;14076.155430674193;1879.9718004229946;1917.4343568647282;1957.314939771083;1967.36060780247;2012.3862222022278;59326;60517.39482605162;62411.687941560005;62846.37153628497;63903.3609663902;13770.793438098437;14604.853951460349;14670.266486675624;14714.19071951053;14718.264086795618;22363.310053840934;22548.436289092904;22551.436214094778;22692.205772798203;22732.2043728472;8726.956365218133;8739.344549158839;8766.474011559327;8782.648694052166;8923;7443.702251909971;7448.106227252764;7504.58724770132;7523.7366692165515;7532.7740167795055;7392.96303518479;7397.408207343399;7405.481616286916;7433.219511951167;7544.358729507943;2440.780329770329;2853.657561092682;2881.207667891347;2889.66768821584;2942.4703553360173;814.4380377539479;910.9863352049724;1027.6557353286582;1029.7100763061944;1033.3593172233263;15298.464553740565;15372;15500.612484687748;15753.212339382984;15858.207089645472;859.6131740716703;885.2475395913422;901.1619194149504;939.4410325856105;954.746992047108;7702.499337543042;8779.165979231962;9479.826194909994;9920;9986.400815951067;534853;536352;536552;538047;540818;52965;62999.055014174824;63991;66177.33822661712;68284;1088.5319312695458;1127.1377396291844;1134.7276653603242;1137.9715507112223;1141.7316930521154;13689.589312320646;14136.730022887932;14613.707725845636;14886.776698349317;15296.23518824032;29352.853235733684;29527.704722952494;30382.088537343032;30440.84779576088;31461.842690787314;38935.41596876106;39854;39927.2014559713;40013.79993100016;40212;6987.9301206987275;7057.894131587927;7155.821104472429;7165.426765858823;7250;10656.84014739795;10680.732981675521;10855.40295283767;10983.61557345489;11083.61207357771;9098.408603440756;9857.950710246403;10071.295009349275;10388.272820902464;10395.232810422096;9372.718818435458;9856.359336643096;9915.355501892354;10358.896411035794;10570.947145264225;3234.8382580871335;3966.8892710041237;7853.921460785319;10081;10182.490875456346;7050.189228238613;7176.856462870818;7179.138503379628;7189.496735228484;7205.603691797001;8792.912070879209;9525.333226674344;10040.146587539848;10158.89841101609;10199.337043092175 20:15:53 INFO - PROCESS | 12068 | |3;mootools.html;1302.4855182203037;1400.7268582626386;1416.4051098538616;1505.9623509412263;1678.2783403136655;6870.278620744824;7228.530145540536;7345.963270183648;7368.336849683527;7375.225601311852;7314.853702925939;7488.32605065544;7507.587082710463;7507.699692012313;7554.848903021936;2012.4264584593393;2071.388940262626;2246.7303923529116;2261.3555136786063;2280.817534597228;2295.540891821634;2306.9077236910503;2308.376738280663;2309.7343805462333;2311.687922130516;2174.7390313162364;2272.9318120456414;2275.931722048333;2278.4190031541934;2284.3489605462446;1964.7425647585485;2008.0562135796226;2206.7682893296133;2267.5238199978025;2272.397814579138;2272.136588096529;2285.371522831218;2320.2923108451914;2322.8954697038675;2324.837261391703;7480.17718051014;7538.321551060376;7550.5847178405165;7550.924490755132;7551.848963020764;4509.346144808985;4636.11913736389;4642.210824159901;4642.698224615389;4643.6517261205545;3006.8195908245357;3035.4991426414617;3056.770742194322;3086.4290106330177;3128.4212420702243;1000.8398656214971;1013.1742629756799;1029.6241871716845;1050.5430137890041;1060.5280650110703;10133.797324053552;10135.493225338703;10135.695929122212;10167.983201679846;10181.592736290539;4175.164967006611;4253.170631726845;4305.052888364555;4330.133973205371;4394.406755088022;8732.563371831384;8764.737057888273;8789.516576588221;8794.252488538417;8799.296056315607;4696.81212751493;4713.905721885543;4718.05638872227;4728.007118505084;4729.12511185425;4312.827486900489;4318.1363727254675;4318.3090705486975;4319.4816622005565;4320.4599425071865;3665.120371110914;3705.1107734144152;3718.5723641781;3731.1231860512758;3756.887293381203;1194.6296648038963;1203.3080978437433;1204.1330242225583;1208.3354155214597;1208.8065909454444;1002.8746406699163;1241.0878004666563;1265.474827946392;1282.2947378941544;1315.0860152194134;6385.904211436832;7014.579125252501;7133.89299160513;7140.642967851691;7143.178534468499;570.1419363857368;585.0785013603592;585.1749033862319;586.2730214534032;591.1369400675062;5168.095583272912;5176.715280659525;5205.765740541685;5206.479352064764;5219.112750832368;8498.235158835734;8826.911730882737;8866.822663546693;8992.46045237288;9044.592993315317;8941.59762810675;9094.272458203328;9110.726678199664;9114.316426268057;9133.543322833964;6767.39093481589;6780.627065511346;6918.06606108179;6981.82545436358;6992.0910281663055;6942.340477654615;6948.200956890022;6954.860902782018;6972.616506092214;6984.16190057176;7796.454248202572;8020.478668886503;8197.139300373376;8216.876746848682;8226.42415030966;8229.753107406548;8328;8388.328933685412;8501.234888860032;8505.91494085076;6589.505787066085;6732.225794033749;6732.865342693217;6752.797416077526;6758.594484330956;7284.307990740871;7307.415406767552;7310.378617817332;7331.120265568166;7335.743248986473;6513.609183449008;6678.198616166092;6680.6993685283305;6726.7981960541265;6827.385535301847;6705.966470167618;6711.597304161766;6761.93238067613;6813.863722725617;6855.211650660238;5978.940210597838;6210.689465526796;6862.759803406857;6874.8625027500175;6913.861722765617;6201.534884883562;6229.345918678474;6246.531510136849;6251.937480625135;6277.1525844010475;6268.122462855295;6302.842428939313;6310.7475700971445;6315.810525684236;6321.399467050623 20:15:53 INFO - PROCESS | 12068 | |4;prototype.html;340.1971347619617;340.5980942487864;343.3990516595957;347.81391955303917;349.4565949947832;5695.829125126253;5800.071988481844;5835.387284335147;5847.912281315778;5907.556933230009;5662.6602403855795;5762.510186634131;5783.797567085153;5789.623674461157;5803.767849286034;4552;4555.521670224628;4557.863264102066;4561.771911404433;4562.110388474249;4354.47746270448;4419.4033805436175;4421.491528474218;4425.601695847373;4554.476235232941;4378.211921854065;4483.574060464267;4521.276595744682;4523.321501774727;4527.09458108378;4510.052888893337;4517.07399983006;4518.52555481673;4520.208963431386;4535.909281814362;3976.2445135424177;3989.7606143631474;3999.8200080996426;4007.0383108054148;4010.578889216649;5370.650907691027;5525;5527.861803454905;5529.502344788988;5580.246666699984;5116.590672746172;5119.078565858144;5128.051310507568;5128.743562821844;5129.6409251352425;5899.056151015817;6182.598131121463;6194.752209911598;6205.627662340274;6220.906686399708;4147.605977432139;4186.539480657125;4260.531341552458;4284.378765079077;4293.914121717579;6359.109724638554;6371.203599550056;6378.61728296299;6379.298277189506;6446.645434501101;4408.6913916026215;4432.312991486325;4433.202023635777;4433.889152771142;4434.11317736454;4307.750752281803;4427.136708341907;4493.191225579427;4493.662975276868;4496.572825581565;5090.490950904954;5098.08234517783;5152.587792976553;5158.38099428071;5160;6221.844453888599;6226.5641405102115;6230.283517395557;6235.875282494325;6236.126942228092;1569.5683686985942;1596.1221328269405;1596.6407558299522;1596.9600759981092;1597.193417324267;1062.2564205056492;1062.8140075486758;1069.4118234970736;1074.9516271767789;1091.879893211746;5813.389594092644;5820.650760954356;5826.126081087871;5829.242198514166;5834.67909264986;6380.234371875405;6380.872382552323;6382.648954307465;6388.456981156561;6396.520260980352;5808.448197421239;5816.243888294494;5816.41835816415;5819.127130930395;5824.126381042877;3330.4338262495435;3452.9654703453148;3454.1709989602314;3455.4989526518516;3456.2569047654874;6541.411272985454;6543.509236807258;6549.083128362033;6551.4103730664465;6556.27880933097;6522.543421960512;6538.771143009972;6563.343665633399;6565.638889861008;6569.244536878225;6346.936530634727;6517.543771936013;6610.86778264432;6616.206055273302;6627;6179.567430279837;6340.461060809883;6428.164338635947;6433.903491447726;6448.5163612730175;6236.875262494816;6357.682115894279;6367.586106903036;6399.456046236122;6399.680015999088;6604.63674497888;6608.372204640552;6609.4712423005085;6612.867742645024;6622.039804228263;4307.741535507755;4316.201502722007;4354.042110735633;4355.782210889506;4364.541723119027;6367.076773867856;6367.363263673596;6379.393957574023;6442.09810626522;6444.967775161094;6258.374162583706;6264.185655864709;6265.746850629801;6269.153664255449;6269.843253918689;6072.726727297194;6258.593191442542;6261.405166509175;6263.342349053284;6268.843278918063;6147.354527774698;6157.953147964947;6186.536009799193;6187.81436556904;6188.412100850412;6262.624242545462;6268.561200716089;6282.497400207881;6309;6326.145970294136;6071.119687645179;6103.267607887082;6128.387161283836;6158.199434073542;6175.783847565313 20:15:53 INFO - PROCESS | 12068 | |5;yui.html;769.3883362726632;843.0220943705303;847.6800205978323;852.1010334097532;886.2112719679486;13231.404586793593;13427.664308392308;13428.127171733842;13433.798493022612;13438.46246150153;12510.937445312784;12573.622791316253;12578.559750408738;12600;12611.117221794479;658.5456035335627;668.3817468841327;789.928906398424;790.2690011739147;804.0431886055575;797.3860127701666;799.4244144216156;803.2569872867604;804.9275565199131;805.4241217529466;838.9454685445457;845.5096044294295;845.8392905347995;846.9534175620338;847.0343808058818;684.3874732114755;692.1728534401392;804.5414113955048;810.2019510781934;823.5429336718119;603.4779915373215;604.749029152901;606.0787602843653;606.5117580347818;606.9666168360739;12812.29532375719;12876.742465150644;12884.54904078362;12904.483820647163;12913.096083274175;11521.539138434453;11544.538218471334;11815.350155741431;11982.161248712593;12152.817707734392;10536.789264214749;10578.471076446147;10585.576576936914;10591.470426478721;11566.595169169123;4282.909999405168;4301.65586753059;4354.172707185625;4387.166438376698;4483.439570053743;41104;41435.58564414347;41766.16467670629;41794.79102604498;41828.1634367311;9781.951090244504;10039.397636141855;10168.898311016943;10200.693979180636;10310.020548047924;17178;17540.298388064588;17560.560985975197;17668.469945901386;17761.289548418175;7052.541584796972;7234.674439650228;7276.708931642781;7325.926740732631;7339.412846972229;4129.91740165195;4233.5882569391315;4241.130568233505;4247.150569886036;4340.891477713082;3078.2766049978236;3117.563541104247;3118.7193152616373;3124.7968882022597;3137.6705445928305;587.4448646029547;598.7545106506311;609.065085094378;609.3510411411833;617.728199592178;529.203548659273;533.8318429694634;546.3116473243662;580.8315588479294;593.8871614393252;7997.920020799834;8367.623456944451;8461.576921153917;8545.31637469001;8751.868721969175;582.0026861662473;680.1973671068088;680.3799035385724;692.3111504053498;708.6208878250111;3801.828917698655;3826.3877779555137;3939.1136994176654;3969.861054863066;4041.7372870763306;49554.25668614974;49863;49956.500434995185;50032;50102.248466273035;45217.773911130236;45465.77267113643;45544.178232870974;46367.76816115898;46614;41182.176356472104;41222.587774122476;41650.1669966599;41760.79119604383;41768.37347439791;7657.310842024244;7806.1803510632835;7913.604319783873;8012.679492820455;8068.515889046676;32348.83825580857;32974.83512582422;33585.32829343448;33704.157396064315;33758.49362259519;38842.417363739;38862.6113738859;41885;42491;44266.77866610646;11085.612003579836;11248.775024499628;11403.258788178742;11684.591039313584;11687.532498699957;11804.232724872856;11942.582009629621;12020.939895300467;12602.495900164258;12606.621801345975;11077.612283570037;11222.494987725735;11229.606963756229;11596.47815848272;11839.05287577009;11110.222284440011;11307.886921131012;11598.18812683104;11633.41832908368;11986.280823150639;10700;10891.836622450828;11214.887851121384;11243.831342530033;11314.377709226072;9158.313126515672;9696;9712.125908668253;9886.357386769838;9895.901040989498;8662.220400164015;9008.32437567172;9156.954215228881;9197;9796.51017449139 20:15:53 INFO - PROCESS | 12068 | __end_tp_report 20:15:53 INFO - PROCESS | 12068 | __start_cc_report 20:15:53 INFO - PROCESS | 12068 | _x_x_mozilla_cycle_collect,953 20:15:53 INFO - PROCESS | 12068 | __end_cc_report 20:15:53 INFO - PROCESS | 12068 | __startTimestamp1452226553159__endTimestamp 20:15:53 INFO - PROCESS | 12068 | 20:15:53 INFO - PROCESS | 12068 | ------- Summary: start ------- 20:15:53 INFO - PROCESS | 12068 | Number of tests: 6 20:15:53 INFO - PROCESS | 12068 | 20:15:53 INFO - PROCESS | 12068 | [#0] dojo.html Cycles:165 Average:5102.62 Median:5288.92 stddev:531.51 (10.0%) stddev-sans-first:509.55 20:15:53 INFO - PROCESS | 12068 | Values: 3106.3 3157.7 3197.9 3202.0 3221.7 5041.9 5044.5 5083.7 5144.4 5167.7 5103.9 5114.6 5175.8 5185.9 5242.1 4645.9 4682.0 4737.8 4785.8 4791.9 4734.1 4738.9 4758.8 4794.3 4850.1 4579.6 4638.0 4677.3 4734.5 4739.9 4685.8 4695.4 4704.0 4720.9 4761.5 4652.8 4673.5 4697.9 4718.3 4737.5 4944.1 4964.5 5038.2 5056.4 5079.1 5464.6 5483.3 5487.5 5489.1 5495.6 5465.3 5495.6 5499.0 5500.5 5503.6 5050.4 5051.7 5134.8 5144.0 5151.0 5608.4 5612.1 5618.0 5619.3 5658.2 5403.5 5404.2 5412.8 5413.3 5417.3 5399.0 5438.7 5443.7 5490.4 5561.7 5515.1 5519.2 5532.7 5537.6 5539.1 5432.4 5463.9 5465.3 5466.6 5518.4 4225.1 4283.6 4294.2 4369.2 4370.0 3863.0 3878.3 3884.9 3922.9 3926.1 5066.6 5069.1 5073.2 5077.1 5084.5 5390.9 5407.6 5477.9 5506.0 5507.5 4988.6 5003.2 5004.2 5021.5 5061.2 4666.1 4673.3 4683.2 4686.4 4723.4 5536.4 5547.5 5645.9 5649.9 5654.3 5473.8 5502.6 5534.7 5540.8 5544.5 5620.1 5657.3 5658.1 5661.4 5663.1 5321.7 5407.4 5425.5 5464.3 5486.3 5480.5 5498.5 5506.0 5513.1 5515.8 5275.3 5308.8 5371.9 5383.2 5432.5 5246.1 5315.9 5321.4 5344.8 5357.5 5273.2 5287.3 5288.0 5288.9 5290.7 5317.0 5338.2 5356.6 5359.5 5412.7 5226.9 5282.5 5329.3 5332.2 5377.8 20:15:53 INFO - PROCESS | 12068 | 20:15:53 INFO - PROCESS | 12068 | [#1] ext.html Cycles:180 Average:44429.01 Median:3269.26 stddev:76146.36 (2329.2%) stddev-sans-first:76288.61 20:15:53 INFO - PROCESS | 12068 | Values: 525.0 528.8 532.1 546.9 556.1 27505.3 28203.0 34762.8 35185.6 35254.6 37762.0 38089.4 38264.8 38269.4 38303.8 8248.3 8505.9 8506.4 8511.0 8521.6 7406.2 7590.6 9850.1 10117.0 10122.0 9828.6 9936.1 9938.2 9943.1 9949.0 7387.3 7617.3 9701.3 9862.6 9882.5 7358.3 9806.8 10020.2 10020.3 10043.1 35012.3 35463.0 35492.8 35495.0 35512.3 3268.1 3270.4 3550.9 3767.1 3945.5 27390.2 27536.9 27825.3 28512.7 29314.9 3820.7 3868.0 3907.7 3953.7 3969.3 262930.0 266002.0 267201.0 267500.0 267738.0 50538.2 55825.2 56127.4 56189.4 56227.0 44780.3 59424.0 59794.0 60163.0 60168.7 14836.1 15096.1 15110.5 15120.3 15131.2 11609.4 11617.4 11669.1 11689.2 11691.4 18074.1 18502.4 18531.2 18610.9 18625.9 6827.1 6893.1 6919.0 7060.1 7064.8 906.4 969.8 973.2 982.4 982.6 24464.0 24827.6 24839.8 24886.6 24888.3 1014.4 1021.0 1034.9 1047.1 1131.6 12924.4 13792.2 13831.2 14817.5 15170.1 315893.0 319560.0 319783.0 320019.0 320754.0 49434.0 49597.0 49721.5 49732.5 49850.8 1225.7 1227.6 1246.5 1284.4 1315.7 21579.4 26002.0 26199.6 26443.7 26459.0 42525.1 42528.4 42555.4 42734.4 42894.0 270739.0 273738.0 291292.0 292721.0 295087.0 24953.9 29720.3 30297.2 30562.0 30684.4 34642.3 35766.8 36071.0 36390.5 36411.8 30447.7 30512.2 30872.2 33511.0 34432.5 31205.4 33274.0 33896.5 34312.5 34546.3 31878.0 31896.8 32112.7 32139.5 33921.7 30330.5 30385.5 31119.8 31219.7 31391.5 23458.9 24112.2 24184.4 24268.9 24515.9 20:15:53 INFO - PROCESS | 12068 | 20:15:53 INFO - PROCESS | 12068 | [#2] jquery.html Cycles:180 Average:27771.43 Median:3970.58 stddev:87583.38 (2205.8%) stddev-sans-first:87804.89 20:15:53 INFO - PROCESS | 12068 | Values: 357.9 358.8 361.2 361.3 364.5 13418.9 13458.7 16674.8 16790.0 17796.7 14939.3 15282.3 15742.3 15742.8 16025.7 4897.6 5349.5 5353.1 5355.3 5357.4 3974.3 4134.0 5231.5 5334.8 5602.8 5714.1 5715.8 5786.9 5787.6 5823.8 6380.7 6649.2 6670.2 6677.7 6679.3 6112.7 6327.7 6329.3 6332.9 6363.3 20886.5 21274.4 21587.8 22329.7 22516.9 2114.5 2208.3 2244.7 2275.2 2745.3 13376.8 13480.5 13647.5 13792.6 14076.2 1880.0 1917.4 1957.3 1967.4 2012.4 59326.0 60517.4 62411.7 62846.4 63903.4 13770.8 14604.9 14670.3 14714.2 14718.3 22363.3 22548.4 22551.4 22692.2 22732.2 8727.0 8739.3 8766.5 8782.6 8923.0 7443.7 7448.1 7504.6 7523.7 7532.8 7393.0 7397.4 7405.5 7433.2 7544.4 2440.8 2853.7 2881.2 2889.7 2942.5 814.4 911.0 1027.7 1029.7 1033.4 15298.5 15372.0 15500.6 15753.2 15858.2 859.6 885.2 901.2 939.4 954.7 7702.5 8779.2 9479.8 9920.0 9986.4 534853.0 536352.0 536552.0 538047.0 540818.0 52965.0 62999.1 63991.0 66177.3 68284.0 1088.5 1127.1 1134.7 1138.0 1141.7 13689.6 14136.7 14613.7 14886.8 15296.2 29352.9 29527.7 30382.1 30440.8 31461.8 38935.4 39854.0 39927.2 40013.8 40212.0 6987.9 7057.9 7155.8 7165.4 7250.0 10656.8 10680.7 10855.4 10983.6 11083.6 9098.4 9858.0 10071.3 10388.3 10395.2 9372.7 9856.4 9915.4 10358.9 10570.9 3234.8 3966.9 7853.9 10081.0 10182.5 7050.2 7176.9 7179.1 7189.5 7205.6 8792.9 9525.3 10040.1 10158.9 10199.3 20:15:53 INFO - PROCESS | 12068 | 20:15:53 INFO - PROCESS | 12068 | [#3] mootools.html Cycles:180 Average:5266.40 Median:6090.24 stddev:2701.40 (44.4%) stddev-sans-first:2692.55 20:15:53 INFO - PROCESS | 12068 | Values: 1302.5 1400.7 1416.4 1506.0 1678.3 6870.3 7228.5 7346.0 7368.3 7375.2 7314.9 7488.3 7507.6 7507.7 7554.8 2012.4 2071.4 2246.7 2261.4 2280.8 2295.5 2306.9 2308.4 2309.7 2311.7 2174.7 2272.9 2275.9 2278.4 2284.3 1964.7 2008.1 2206.8 2267.5 2272.4 2272.1 2285.4 2320.3 2322.9 2324.8 7480.2 7538.3 7550.6 7550.9 7551.8 4509.3 4636.1 4642.2 4642.7 4643.7 3006.8 3035.5 3056.8 3086.4 3128.4 1000.8 1013.2 1029.6 1050.5 1060.5 10133.8 10135.5 10135.7 10168.0 10181.6 4175.2 4253.2 4305.1 4330.1 4394.4 8732.6 8764.7 8789.5 8794.3 8799.3 4696.8 4713.9 4718.1 4728.0 4729.1 4312.8 4318.1 4318.3 4319.5 4320.5 3665.1 3705.1 3718.6 3731.1 3756.9 1194.6 1203.3 1204.1 1208.3 1208.8 1002.9 1241.1 1265.5 1282.3 1315.1 6385.9 7014.6 7133.9 7140.6 7143.2 570.1 585.1 585.2 586.3 591.1 5168.1 5176.7 5205.8 5206.5 5219.1 8498.2 8826.9 8866.8 8992.5 9044.6 8941.6 9094.3 9110.7 9114.3 9133.5 6767.4 6780.6 6918.1 6981.8 6992.1 6942.3 6948.2 6954.9 6972.6 6984.2 7796.5 8020.5 8197.1 8216.9 8226.4 8229.8 8328.0 8388.3 8501.2 8505.9 6589.5 6732.2 6732.9 6752.8 6758.6 7284.3 7307.4 7310.4 7331.1 7335.7 6513.6 6678.2 6680.7 6726.8 6827.4 6706.0 6711.6 6761.9 6813.9 6855.2 5978.9 6210.7 6862.8 6874.9 6913.9 6201.5 6229.3 6246.5 6251.9 6277.2 6268.1 6302.8 6310.7 6315.8 6321.4 20:15:53 INFO - PROCESS | 12068 | 20:15:53 INFO - PROCESS | 12068 | [#4] prototype.html Cycles:180 Average:5179.50 Median:5817.77 stddev:1551.54 (26.7%) stddev-sans-first:1512.78 20:15:53 INFO - PROCESS | 12068 | Values: 340.2 340.6 343.4 347.8 349.5 5695.8 5800.1 5835.4 5847.9 5907.6 5662.7 5762.5 5783.8 5789.6 5803.8 4552.0 4555.5 4557.9 4561.8 4562.1 4354.5 4419.4 4421.5 4425.6 4554.5 4378.2 4483.6 4521.3 4523.3 4527.1 4510.1 4517.1 4518.5 4520.2 4535.9 3976.2 3989.8 3999.8 4007.0 4010.6 5370.7 5525.0 5527.9 5529.5 5580.2 5116.6 5119.1 5128.1 5128.7 5129.6 5899.1 6182.6 6194.8 6205.6 6220.9 4147.6 4186.5 4260.5 4284.4 4293.9 6359.1 6371.2 6378.6 6379.3 6446.6 4408.7 4432.3 4433.2 4433.9 4434.1 4307.8 4427.1 4493.2 4493.7 4496.6 5090.5 5098.1 5152.6 5158.4 5160.0 6221.8 6226.6 6230.3 6235.9 6236.1 1569.6 1596.1 1596.6 1597.0 1597.2 1062.3 1062.8 1069.4 1075.0 1091.9 5813.4 5820.7 5826.1 5829.2 5834.7 6380.2 6380.9 6382.6 6388.5 6396.5 5808.4 5816.2 5816.4 5819.1 5824.1 3330.4 3453.0 3454.2 3455.5 3456.3 6541.4 6543.5 6549.1 6551.4 6556.3 6522.5 6538.8 6563.3 6565.6 6569.2 6346.9 6517.5 6610.9 6616.2 6627.0 6179.6 6340.5 6428.2 6433.9 6448.5 6236.9 6357.7 6367.6 6399.5 6399.7 6604.6 6608.4 6609.5 6612.9 6622.0 4307.7 4316.2 4354.0 4355.8 4364.5 6367.1 6367.4 6379.4 6442.1 6445.0 6258.4 6264.2 6265.7 6269.2 6269.8 6072.7 6258.6 6261.4 6263.3 6268.8 6147.4 6158.0 6186.5 6187.8 6188.4 6262.6 6268.6 6282.5 6309.0 6326.1 6071.1 6103.3 6128.4 6158.2 6175.8 20:15:53 INFO - PROCESS | 12068 | 20:15:53 INFO - PROCESS | 12068 | [#5] yui.html Cycles:180 Average:12903.27 Median:23369.08 stddev:14112.84 (60.4%) stddev-sans-first:14123.01 20:15:53 INFO - PROCESS | 12068 | Values: 769.4 843.0 847.7 852.1 886.2 13231.4 13427.7 13428.1 13433.8 13438.5 12510.9 12573.6 12578.6 12600.0 12611.1 658.5 668.4 789.9 790.3 804.0 797.4 799.4 803.3 804.9 805.4 838.9 845.5 845.8 847.0 847.0 684.4 692.2 804.5 810.2 823.5 603.5 604.7 606.1 606.5 607.0 12812.3 12876.7 12884.5 12904.5 12913.1 11521.5 11544.5 11815.4 11982.2 12152.8 10536.8 10578.5 10585.6 10591.5 11566.6 4282.9 4301.7 4354.2 4387.2 4483.4 41104.0 41435.6 41766.2 41794.8 41828.2 9782.0 10039.4 10168.9 10200.7 10310.0 17178.0 17540.3 17560.6 17668.5 17761.3 7052.5 7234.7 7276.7 7325.9 7339.4 4129.9 4233.6 4241.1 4247.2 4340.9 3078.3 3117.6 3118.7 3124.8 3137.7 587.4 598.8 609.1 609.4 617.7 529.2 533.8 546.3 580.8 593.9 7997.9 8367.6 8461.6 8545.3 8751.9 582.0 680.2 680.4 692.3 708.6 3801.8 3826.4 3939.1 3969.9 4041.7 49554.3 49863.0 49956.5 50032.0 50102.2 45217.8 45465.8 45544.2 46367.8 46614.0 41182.2 41222.6 41650.2 41760.8 41768.4 7657.3 7806.2 7913.6 8012.7 8068.5 32348.8 32974.8 33585.3 33704.2 33758.5 38842.4 38862.6 41885.0 42491.0 44266.8 11085.6 11248.8 11403.3 11684.6 11687.5 11804.2 11942.6 12020.9 12602.5 12606.6 11077.6 11222.5 11229.6 11596.5 11839.1 11110.2 11307.9 11598.2 11633.4 11986.3 10700.0 10891.8 11214.9 11243.8 11314.4 9158.3 9696.0 9712.1 9886.4 9895.9 8662.2 9008.3 9157.0 9197.0 9796.5 20:15:53 INFO - PROCESS | 12068 | -------- Summary: end -------- 20:15:53 INFO - PROCESS | 12068 | 20:15:53 INFO - TEST-INFO | 12068: exit 0 20:15:53 INFO - TEST-OK | dromaeo_css | took 1112740ms 20:15:53 INFO - TEST-START | kraken 20:15:53 INFO - operating with platform_type : linux_ 20:15:53 INFO - Initialising browser for kraken test... 20:15:53 INFO - TEST-INFO | started process 12256 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzPOihF/profile http://localhost:41258/getInfo.html) 20:15:57 INFO - PROCESS | 12256 | __metrics Screen width/height:1600/1200 20:15:57 INFO - PROCESS | 12256 | colorDepth:24 20:15:57 INFO - PROCESS | 12256 | Browser inner width/height: 1024/697 20:15:57 INFO - PROCESS | 12256 | __metrics 20:15:57 INFO - PROCESS | 12256 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:15:57 INFO - PROCESS | 12256 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:15:58 INFO - TEST-INFO | 12256: exit 0 20:15:58 INFO - Browser initialized. 20:15:58 INFO - Running cycle 1/1 for kraken test... 20:15:58 INFO - TEST-INFO | started process 12341 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzPOihF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:10 INFO - PROCESS | 12341 | RSS: Main: 149954560 20:16:10 INFO - PROCESS | 12341 | 20:16:13 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41258/tests/kraken/driver.html?testName=audio-beat-detection) 20:16:13 INFO - PROCESS | 12341 | RSS: Main: 186535936 20:16:13 INFO - PROCESS | 12341 | 20:16:16 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41258/tests/kraken/driver.html?testName=audio-dft) 20:16:16 INFO - PROCESS | 12341 | RSS: Main: 176062464 20:16:16 INFO - PROCESS | 12341 | 20:16:19 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41258/tests/kraken/driver.html?testName=audio-fft) 20:16:20 INFO - PROCESS | 12341 | RSS: Main: 162148352 20:16:20 INFO - PROCESS | 12341 | 20:16:22 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41258/tests/kraken/driver.html?testName=audio-oscillator) 20:16:23 INFO - PROCESS | 12341 | RSS: Main: 162914304 20:16:23 INFO - PROCESS | 12341 | 20:16:25 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41258/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:16:25 INFO - PROCESS | 12341 | RSS: Main: 164446208 20:16:25 INFO - PROCESS | 12341 | 20:16:28 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41258/tests/kraken/driver.html?testName=imaging-darkroom) 20:16:29 INFO - PROCESS | 12341 | RSS: Main: 166432768 20:16:29 INFO - PROCESS | 12341 | 20:16:32 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41258/tests/kraken/driver.html?testName=imaging-desaturate) 20:16:33 INFO - PROCESS | 12341 | RSS: Main: 167333888 20:16:33 INFO - PROCESS | 12341 | 20:16:35 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41258/tests/kraken/driver.html?testName=json-parse-financial) 20:16:36 INFO - PROCESS | 12341 | RSS: Main: 165830656 20:16:36 INFO - PROCESS | 12341 | 20:16:38 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41258/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:16:38 INFO - PROCESS | 12341 | RSS: Main: 176267264 20:16:38 INFO - PROCESS | 12341 | 20:16:40 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41258/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:16:41 INFO - PROCESS | 12341 | RSS: Main: 172408832 20:16:41 INFO - PROCESS | 12341 | 20:16:43 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41258/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:16:43 INFO - PROCESS | 12341 | RSS: Main: 187703296 20:16:43 INFO - PROCESS | 12341 | 20:16:46 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:16:46 INFO - PROCESS | 12341 | RSS: Main: 190779392 20:16:46 INFO - PROCESS | 12341 | 20:16:49 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:16:49 INFO - PROCESS | 12341 | RSS: Main: 190455808 20:16:49 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | Cycle 1(1): loaded http://localhost:41258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41258/tests/kraken/driver.html?testName=ai-astar) 20:16:51 INFO - PROCESS | 12341 | RSS: Main: 249004032 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | __start_tp_report 20:16:51 INFO - PROCESS | 12341 | _x_x_mozilla_page_load 20:16:51 INFO - PROCESS | 12341 | _x_x_mozilla_page_load_details 20:16:51 INFO - PROCESS | 12341 | |i|pagename|runs| 20:16:51 INFO - PROCESS | 12341 | |0;ai-astar;111;111;106;113;112;111;100;111;110;112 20:16:51 INFO - PROCESS | 12341 | |1;audio-beat-detection;150;125;148;159;124;148;154;123;162;130 20:16:51 INFO - PROCESS | 12341 | |2;audio-dft;161;163;161;162;162;162;161;165;163;159 20:16:51 INFO - PROCESS | 12341 | |3;audio-fft;71;72;81;94;72;71;72;118;94;74 20:16:51 INFO - PROCESS | 12341 | |4;audio-oscillator;96;96;145;99;96;96;140;96;97;139 20:16:51 INFO - PROCESS | 12341 | |5;imaging-gaussian-blur;110;109;110;109;109;109;109;109;109;108 20:16:51 INFO - PROCESS | 12341 | |6;imaging-darkroom;145;146;145;145;146;146;146;145;145;145 20:16:51 INFO - PROCESS | 12341 | |7;imaging-desaturate;96;95;95;96;96;95;96;96;97;96 20:16:51 INFO - PROCESS | 12341 | |8;json-parse-financial;60;58;57;57;59;57;59;71;55;56 20:16:51 INFO - PROCESS | 12341 | |9;json-stringify-tinderbox;66;66;66;66;67;66;67;67;66;67 20:16:51 INFO - PROCESS | 12341 | |10;stanford-crypto-aes;85;85;84;85;92;85;92;84;86;85 20:16:51 INFO - PROCESS | 12341 | |11;stanford-crypto-ccm;120;123;122;115;128;113;118;129;125;117 20:16:51 INFO - PROCESS | 12341 | |12;stanford-crypto-pbkdf2;139;141;149;156;150;141;151;159;148;140 20:16:51 INFO - PROCESS | 12341 | |13;stanford-crypto-sha256-iterative;67;70;69;68;71;70;67;69;70;70 20:16:51 INFO - PROCESS | 12341 | __end_tp_report 20:16:51 INFO - PROCESS | 12341 | __start_cc_report 20:16:51 INFO - PROCESS | 12341 | _x_x_mozilla_cycle_collect,977 20:16:51 INFO - PROCESS | 12341 | __end_cc_report 20:16:51 INFO - PROCESS | 12341 | __startTimestamp1452226611825__endTimestamp 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | ------- Summary: start ------- 20:16:51 INFO - PROCESS | 12341 | Number of tests: 14 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.89 (3.5%) stddev-sans-first:4.10 20:16:51 INFO - PROCESS | 12341 | Values: 111.0 111.0 106.0 113.0 112.0 111.0 100.0 111.0 110.0 112.0 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:149.00 stddev:15.22 (10.2%) stddev-sans-first:15.89 20:16:51 INFO - PROCESS | 12341 | Values: 150.0 125.0 148.0 159.0 124.0 148.0 154.0 123.0 162.0 130.0 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.60 (1.0%) stddev-sans-first:1.66 20:16:51 INFO - PROCESS | 12341 | Values: 161.0 163.0 161.0 162.0 162.0 162.0 161.0 165.0 163.0 159.0 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#3] audio-fft Cycles:10 Average:81.90 Median:73.00 stddev:15.60 (21.4%) stddev-sans-first:16.04 20:16:51 INFO - PROCESS | 12341 | Values: 71.0 72.0 81.0 94.0 72.0 71.0 72.0 118.0 94.0 74.0 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:21.69 (22.6%) stddev-sans-first:22.41 20:16:51 INFO - PROCESS | 12341 | Values: 96.0 96.0 145.0 99.0 96.0 96.0 140.0 96.0 97.0 139.0 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 20:16:51 INFO - PROCESS | 12341 | Values: 110.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 108.0 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:16:51 INFO - PROCESS | 12341 | Values: 145.0 146.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 20:16:51 INFO - PROCESS | 12341 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 97.0 96.0 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:58.50 stddev:4.51 (7.7%) stddev-sans-first:4.76 20:16:51 INFO - PROCESS | 12341 | Values: 60.0 58.0 57.0 57.0 59.0 57.0 59.0 71.0 55.0 56.0 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 20:16:51 INFO - PROCESS | 12341 | Values: 66.0 66.0 66.0 66.0 67.0 66.0 67.0 67.0 66.0 67.0 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:85.00 stddev:3.06 (3.6%) stddev-sans-first:3.21 20:16:51 INFO - PROCESS | 12341 | Values: 85.0 85.0 84.0 85.0 92.0 85.0 92.0 84.0 86.0 85.0 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:122.50 stddev:5.37 (4.4%) stddev-sans-first:5.69 20:16:51 INFO - PROCESS | 12341 | Values: 120.0 123.0 122.0 115.0 128.0 113.0 118.0 129.0 125.0 117.0 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:149.50 stddev:6.98 (4.7%) stddev-sans-first:6.71 20:16:51 INFO - PROCESS | 12341 | Values: 139.0 141.0 149.0 156.0 150.0 141.0 151.0 159.0 148.0 140.0 20:16:51 INFO - PROCESS | 12341 | 20:16:51 INFO - PROCESS | 12341 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:70.00 stddev:1.37 (2.0%) stddev-sans-first:1.22 20:16:51 INFO - PROCESS | 12341 | Values: 67.0 70.0 69.0 68.0 71.0 70.0 67.0 69.0 70.0 70.0 20:16:51 INFO - PROCESS | 12341 | -------- Summary: end -------- 20:16:51 INFO - PROCESS | 12341 | 20:16:52 INFO - TEST-INFO | 12341: exit 0 20:16:52 INFO - TEST-OK | kraken | took 58892ms 20:16:52 INFO - TEST-START | v8_7 20:16:52 INFO - operating with platform_type : linux_ 20:16:52 INFO - Initialising browser for v8_7 test... 20:16:52 INFO - TEST-INFO | started process 12588 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFghmMf/profile http://localhost:41258/getInfo.html) 20:16:56 INFO - PROCESS | 12588 | __metrics Screen width/height:1600/1200 20:16:56 INFO - PROCESS | 12588 | colorDepth:24 20:16:56 INFO - PROCESS | 12588 | Browser inner width/height: 1024/697 20:16:56 INFO - PROCESS | 12588 | __metrics 20:16:56 INFO - PROCESS | 12588 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:16:56 INFO - PROCESS | 12588 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:16:57 INFO - TEST-INFO | 12588: exit 0 20:16:57 INFO - Browser initialized. 20:16:57 INFO - Running cycle 1/1 for v8_7 test... 20:16:57 INFO - TEST-INFO | started process 12674 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFghmMf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:09 INFO - PROCESS | 12674 | RSS: Main: 150028288 20:17:09 INFO - PROCESS | 12674 | 20:17:31 INFO - PROCESS | 12674 | Cycle 1(1): loaded http://localhost:41258/tests/v8_7/run.html (next: http://localhost:41258/tests/v8_7/run.html) 20:17:32 INFO - PROCESS | 12674 | RSS: Main: 547184640 20:17:32 INFO - PROCESS | 12674 | 20:17:32 INFO - PROCESS | 12674 | __start_tp_report 20:17:32 INFO - PROCESS | 12674 | _x_x_mozilla_page_load 20:17:32 INFO - PROCESS | 12674 | _x_x_mozilla_page_load_details 20:17:32 INFO - PROCESS | 12674 | |i|pagename|runs| 20:17:32 INFO - PROCESS | 12674 | |0;Richards;166.6944490748458 20:17:32 INFO - PROCESS | 12674 | |1;DeltaBlue;190.15021867275146 20:17:32 INFO - PROCESS | 12674 | |2;Encrypt;280.74115665356544 20:17:32 INFO - PROCESS | 12674 | |3;Decrypt;5301.587301587301 20:17:32 INFO - PROCESS | 12674 | |4;RayTrace;1119.8208286674133 20:17:32 INFO - PROCESS | 12674 | |5;Earley;791.7656373713381 20:17:32 INFO - PROCESS | 12674 | |6;Boyer;12353.658536585366 20:17:32 INFO - PROCESS | 12674 | |7;RegExp;42744.68085106383 20:17:32 INFO - PROCESS | 12674 | |8;Splay;595.7193816884661 20:17:32 INFO - PROCESS | 12674 | |9;NavierStokes;4840.579710144928 20:17:32 INFO - PROCESS | 12674 | __end_tp_report 20:17:32 INFO - PROCESS | 12674 | __startTimestamp1452226652204__endTimestamp 20:17:32 INFO - PROCESS | 12674 | 20:17:32 INFO - PROCESS | 12674 | ------- Summary: start ------- 20:17:32 INFO - PROCESS | 12674 | Number of tests: 10 20:17:32 INFO - PROCESS | 12674 | 20:17:32 INFO - PROCESS | 12674 | [#0] Richards Cycles:1 Average:166.69 Median:166.69 stddev:0.00 (0.0%) 20:17:32 INFO - PROCESS | 12674 | Values: 166.7 20:17:32 INFO - PROCESS | 12674 | 20:17:32 INFO - PROCESS | 12674 | [#1] DeltaBlue Cycles:1 Average:190.15 Median:190.15 stddev:0.00 (0.0%) 20:17:32 INFO - PROCESS | 12674 | Values: 190.2 20:17:32 INFO - PROCESS | 12674 | 20:17:32 INFO - PROCESS | 12674 | [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 20:17:32 INFO - PROCESS | 12674 | Values: 280.7 20:17:32 INFO - PROCESS | 12674 | 20:17:32 INFO - PROCESS | 12674 | [#3] Decrypt Cycles:1 Average:5301.59 Median:5301.59 stddev:0.00 (0.0%) 20:17:32 INFO - PROCESS | 12674 | Values: 5301.6 20:17:32 INFO - PROCESS | 12674 | 20:17:32 INFO - PROCESS | 12674 | [#4] RayTrace Cycles:1 Average:1119.82 Median:1119.82 stddev:0.00 (0.0%) 20:17:32 INFO - PROCESS | 12674 | Values: 1119.8 20:17:32 INFO - PROCESS | 12674 | 20:17:32 INFO - PROCESS | 12674 | [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 20:17:32 INFO - PROCESS | 12674 | Values: 791.8 20:17:32 INFO - PROCESS | 12674 | 20:17:32 INFO - PROCESS | 12674 | [#6] Boyer Cycles:1 Average:12353.66 Median:12353.66 stddev:0.00 (0.0%) 20:17:32 INFO - PROCESS | 12674 | Values: 12353.7 20:17:32 INFO - PROCESS | 12674 | 20:17:32 INFO - PROCESS | 12674 | [#7] RegExp Cycles:1 Average:42744.68 Median:42744.68 stddev:0.00 (0.0%) 20:17:32 INFO - PROCESS | 12674 | Values: 42744.7 20:17:32 INFO - PROCESS | 12674 | 20:17:32 INFO - PROCESS | 12674 | [#8] Splay Cycles:1 Average:595.72 Median:595.72 stddev:0.00 (0.0%) 20:17:32 INFO - PROCESS | 12674 | Values: 595.7 20:17:32 INFO - PROCESS | 12674 | 20:17:32 INFO - PROCESS | 12674 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:17:32 INFO - PROCESS | 12674 | Values: 4840.6 20:17:32 INFO - PROCESS | 12674 | -------- Summary: end -------- 20:17:32 INFO - PROCESS | 12674 | 20:17:32 INFO - TEST-INFO | 12674: exit 0 20:17:33 INFO - TEST-OK | v8_7 | took 40246ms 20:17:33 INFO - SUITE-END | took 1211s 20:17:33 INFO - Completed test suite (00:20:12) 20:17:33 INFO - Working with test: dromaeo_css 20:17:33 INFO - Generating results file: dromaeo_css 20:17:33 INFO - Working with test: kraken 20:17:33 INFO - Generating results file: kraken 20:17:33 INFO - javascript benchmark 20:17:33 INFO - Working with test: v8_7 20:17:33 INFO - Generating results file: v8_7 20:17:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:17:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 20:17:33 INFO - process_Request line: dromaeo_css 6762.76 graph.html#tests=[[72,201,35]] 20:17:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:17:33 INFO - process_Request line: kraken 1505.20 graph.html#tests=[[232,201,35]] 20:17:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:17:33 INFO - process_Request line: v8_7 19940.89 graph.html#tests=[[230,201,35]] 20:17:33 INFO - RETURN: dromaeo_css: 6762.76 20:17:33 INFO - RETURN: kraken: 1505.20 20:17:33 INFO - RETURN: v8_7: 19940.89 20:17:33 INFO - javascript benchmark 20:17:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3106.270026543762, 3157.668444813296, 3197.8560964756584, 3201.9679803201975, 3221.677832216779, 5041.924371134432, 5044.520770526803, 5083.694978301304, 5144.356955380577, 5167.715775632339, 5103.897922041557, 5114.565261952729, 5175.767090480928, 5185.870353241171, 5242.082635538784, 4645.86062418128, 4681.976590117053, 4737.834175803848, 4785.784639691222, 4791.928121078169, 4734.076855013273, 4738.881527961811, 4758.762061896909, 4794.256890182028, 4850.126977144113, 4579.564941330568, 4637.953620463786, 4677.321788340689, 4734.455537613184, 4739.857804265877, 4685.81256749733, 4695.413073365829, 4703.976480117578, 4720.905581888377, 4761.500042495522, 4652.767361631905, 4673.532646735333, 4697.929531057037, 4718.292256161569, 4737.478877323491, 4944.134776414113, 4964.478729733362, 5038.193888977783, 5056.367954005749, 5079.085764562377, 5464.617476776627, 5483.259759932398, 5487.506124448819, 5489.094299440588, 5495.587830912697, 5465.289512363407, 5495.6153069285165, 5498.972505137489, 5500.477454641803, 5503.559715222773, 5050.393952725696, 5051.696898186121, 5134.7689353978785, 5143.974280128576, 5151.0470562945975, 5608.355039170548, 5612.102063669793, 5617.971910140505, 5619.269494965628, 5658.179563963202, 5403.459654034565, 5404.216388623628, 5412.83761487156, 5413.269208656781, 5417.295751552352, 5399.0281749285505, 5438.700871452029, 5443.673379597237, 5490.368607610176, 5561.721913904288, 5515.090010148361, 5519.172124181325, 5532.723363831873, 5537.58468114893, 5539.14143307788, 5432.429594892479, 5463.9180412293845, 5465.316835395575, 5466.617336786387, 5518.392976772552, 4225.091605304874, 4283.593058659422, 4294.248506511348, 4369.235383807821, 4369.956300437018, 3862.9613703863165, 3878.340682083996, 3884.941725874114, 3922.941155882664, 3926.09699769049, 5066.594672426197, 5069.112905241568, 5073.188289873602, 5077.136886729265, 5084.46613105626, 5390.865228369244, 5407.594430417735, 5477.945220547744, 5506.03644362235, 5507.504324610804, 4988.625853061035, 5003.199488081889, 5004.2493625956395, 5021.472745361684, 5061.164907790247, 4666.090112428112, 4673.322368256584, 4683.180443422388, 4686.36734040907, 4723.409573803275, 5536.363318218457, 5547.528460080938, 5645.858853528613, 5649.943500564942, 5654.264945557051, 5473.808416705556, 5502.614816962774, 5534.695591742332, 5540.750666219949, 5544.473275038865, 5620.072688006433, 5657.264555607745, 5658.094704847204, 5661.377248502579, 5663.122216056518, 5321.680699158062, 5407.378151512627, 5425.484578964992, 5464.316960379952, 5486.31421072366, 5480.506754392124, 5498.45015498447, 5506.03644362227, 5513.090340094, 5515.806946756844, 5275.287836142072, 5308.840734777963, 5371.946280537301, 5383.192521121863, 5432.511074003359, 5246.08193566132, 5315.867103322448, 5321.3880403754065, 5344.839654810362, 5357.517823395913, 5273.209018647233, 5287.286216360742, 5288.048151332797, 5288.920666189933, 5290.68255904647, 5317.016351974742, 5338.1992701093595, 5356.5714742821265, 5359.464053594609, 5412.729363531729, 5226.9215961761365, 5282.4717528246865, 5329.333833270841, 5332.173513105475, 5377.758000889891], "unit": "score", "name": "dojo.html", "value": 5070.624967051681}, {"lowerIsBetter": false, "replicates": [524.9737513124344, 528.8307741522711, 532.1299675031322, 546.8660178256326, 556.1463154058521, 27505.312367190807, 28203.0, 34762.82618586907, 35185.648143518556, 35254.64745352546, 37762.0, 38089.42865857014, 38264.80867595658, 38269.425958610576, 38303.808480957625, 8248.257656810885, 8505.914940850605, 8506.36202284828, 8511.0, 8521.573921303941, 7406.185319614838, 7590.620468976556, 9850.113489785917, 10117.0, 10122.0, 9828.606855725762, 9936.05607467293, 9938.15525680318, 9943.055409736064, 9949.0, 7387.298206670358, 7617.314441700219, 9701.320907536476, 9862.60549578016, 9882.456464894392, 7358.337749602561, 9806.803863922752, 10020.198384129251, 10020.348677336022, 10043.096121349041, 35012.29975400478, 35463.0, 35492.82253588716, 35495.0, 35512.28975420477, 3268.084936217863, 3270.427675156862, 3550.946735798965, 3767.0958969847316, 3945.526536815572, 27390.178294651192, 27536.862315688493, 27825.304367390774, 28512.714872851215, 29314.853425732734, 3820.6943444524372, 3867.9540011008658, 3907.7459965102175, 3953.7034722395647, 3969.28552860485, 262930.0, 266002.0, 267201.0, 267500.0, 267738.0, 50538.241926371134, 55825.162622560696, 56127.438725613036, 56189.43810561842, 56227.0, 44780.3282950756, 59424.0, 59794.0, 60163.0, 60168.699156503935, 14836.109833409813, 15096.094234345974, 15110.471133510275, 15120.319585618674, 15131.243437828065, 11609.36148511823, 11617.419129043514, 11669.124815638861, 11689.240199387013, 11691.356975366267, 18074.096295185187, 18502.44492665222, 18531.166097525373, 18610.906945465187, 18625.906870465562, 6827.112475378269, 6893.138357705287, 6918.965405172942, 7060.117485314336, 7064.823379415453, 906.4425378392241, 969.7672558585889, 973.1922504321537, 982.3909176310733, 982.5774916785708, 24464.0, 24827.62758558623, 24839.751602483742, 24886.626700599507, 24888.253352399457, 1014.3761586624173, 1020.9642662506776, 1034.8654674892216, 1047.0890325416935, 1131.6265632341308, 12924.41840117197, 13792.172469651852, 13831.239281839595, 14817.481388151364, 15170.08491830971, 315893.0, 319560.0, 319783.0, 320019.0, 320754.0, 49434.0, 49597.0, 49721.502784972414, 49732.50267497351, 49850.750746246034, 1225.66906935127, 1227.643983244849, 1246.5325502936398, 1284.3770771175973, 1315.6710822294426, 21579.352619420813, 26002.0, 26199.607005894544, 26443.735562644128, 26459.0, 42525.149497010505, 42528.362074568286, 42555.36166957436, 42734.35898461588, 42894.0, 270739.0, 273738.0, 291292.0, 292721.0, 295087.0, 24953.87523062373, 29720.256993575334, 30297.24256893595, 30562.0, 30684.386312273182, 34642.307153857284, 35766.821165895046, 36071.0, 36390.454143188406, 36411.81794091013, 30447.695523044487, 30512.237194070327, 30872.228194295323, 33511.0, 34432.48351274783, 31205.375892482476, 33274.0, 33896.491552626234, 34312.485312720826, 34546.309073818884, 31878.0, 31896.8405157982, 32112.678873210967, 32139.51790723188, 33921.660783392836, 30330.54504182395, 30385.544216837206, 31119.844400777853, 31219.687803121677, 31391.529127063568, 23458.882705586362, 24112.156074537306, 24184.395390114685, 24268.878655606608, 24515.877420612782], "unit": "score", "name": "ext.html", "value": 17565.328256898676}, {"lowerIsBetter": false, "replicates": [357.85685725709715, 358.76500891915805, 361.1711122972777, 361.28285353573153, 364.52247555702024, 13418.93290533546, 13458.730825383487, 16674.833251667478, 16790.0, 17796.733049004277, 14939.327730252138, 15282.312295946682, 15742.29159687814, 15742.763858542103, 16025.679486410265, 4897.559219670229, 5349.54528865045, 5353.0899747043095, 5355.3305836770405, 5357.383900851393, 3974.264761019206, 4133.987173142569, 5231.450697676746, 5334.839954801362, 5602.7758889644365, 5714.085746280575, 5715.771369145229, 5786.942130578683, 5787.594868359217, 5823.796167134151, 6380.744770209186, 6649.235337936151, 6670.232923213795, 6677.732890684367, 6679.332066793306, 6112.6638034908065, 6327.746890124389, 6329.303776584572, 6332.905006424908, 6363.268224154235, 20886.47783805402, 21274.404419668586, 21587.784122158733, 22329.665055024027, 22516.887415562982, 2114.534802343482, 2208.3043841189974, 2244.6857439958417, 2275.2377953385635, 2745.272502786763, 13376.799348009788, 13480.460781568725, 13647.522336718168, 13792.586222413343, 14076.155430674193, 1879.9718004229946, 1917.4343568647282, 1957.314939771083, 1967.36060780247, 2012.3862222022278, 59326.0, 60517.39482605162, 62411.687941560005, 62846.37153628497, 63903.3609663902, 13770.793438098437, 14604.853951460349, 14670.266486675624, 14714.19071951053, 14718.264086795618, 22363.310053840934, 22548.436289092904, 22551.436214094778, 22692.205772798203, 22732.2043728472, 8726.956365218133, 8739.344549158839, 8766.474011559327, 8782.648694052166, 8923.0, 7443.702251909971, 7448.106227252764, 7504.58724770132, 7523.7366692165515, 7532.7740167795055, 7392.96303518479, 7397.408207343399, 7405.481616286916, 7433.219511951167, 7544.358729507943, 2440.780329770329, 2853.657561092682, 2881.207667891347, 2889.66768821584, 2942.4703553360173, 814.4380377539479, 910.9863352049724, 1027.6557353286582, 1029.7100763061944, 1033.3593172233263, 15298.464553740565, 15372.0, 15500.612484687748, 15753.212339382984, 15858.207089645472, 859.6131740716703, 885.2475395913422, 901.1619194149504, 939.4410325856105, 954.746992047108, 7702.499337543042, 8779.165979231962, 9479.826194909994, 9920.0, 9986.400815951067, 534853.0, 536352.0, 536552.0, 538047.0, 540818.0, 52965.0, 62999.055014174824, 63991.0, 66177.33822661712, 68284.0, 1088.5319312695458, 1127.1377396291844, 1134.7276653603242, 1137.9715507112223, 1141.7316930521154, 13689.589312320646, 14136.730022887932, 14613.707725845636, 14886.776698349317, 15296.23518824032, 29352.853235733684, 29527.704722952494, 30382.088537343032, 30440.84779576088, 31461.842690787314, 38935.41596876106, 39854.0, 39927.2014559713, 40013.79993100016, 40212.0, 6987.9301206987275, 7057.894131587927, 7155.821104472429, 7165.426765858823, 7250.0, 10656.84014739795, 10680.732981675521, 10855.40295283767, 10983.61557345489, 11083.61207357771, 9098.408603440756, 9857.950710246403, 10071.295009349275, 10388.272820902464, 10395.232810422096, 9372.718818435458, 9856.359336643096, 9915.355501892354, 10358.896411035794, 10570.947145264225, 3234.8382580871335, 3966.8892710041237, 7853.921460785319, 10081.0, 10182.490875456346, 7050.189228238613, 7176.856462870818, 7179.138503379628, 7189.496735228484, 7205.603691797001, 8792.912070879209, 9525.333226674344, 10040.146587539848, 10158.89841101609, 10199.337043092175], "unit": "score", "name": "jquery.html", "value": 8688.248004607987}, {"lowerIsBetter": false, "replicates": [1302.4855182203037, 1400.7268582626386, 1416.4051098538616, 1505.9623509412263, 1678.2783403136655, 6870.278620744824, 7228.530145540536, 7345.963270183648, 7368.336849683527, 7375.225601311852, 7314.853702925939, 7488.32605065544, 7507.587082710463, 7507.699692012313, 7554.848903021936, 2012.4264584593393, 2071.388940262626, 2246.7303923529116, 2261.3555136786063, 2280.817534597228, 2295.540891821634, 2306.9077236910503, 2308.376738280663, 2309.7343805462333, 2311.687922130516, 2174.7390313162364, 2272.9318120456414, 2275.931722048333, 2278.4190031541934, 2284.3489605462446, 1964.7425647585485, 2008.0562135796226, 2206.7682893296133, 2267.5238199978025, 2272.397814579138, 2272.136588096529, 2285.371522831218, 2320.2923108451914, 2322.8954697038675, 2324.837261391703, 7480.17718051014, 7538.321551060376, 7550.5847178405165, 7550.924490755132, 7551.848963020764, 4509.346144808985, 4636.11913736389, 4642.210824159901, 4642.698224615389, 4643.6517261205545, 3006.8195908245357, 3035.4991426414617, 3056.770742194322, 3086.4290106330177, 3128.4212420702243, 1000.8398656214971, 1013.1742629756799, 1029.6241871716845, 1050.5430137890041, 1060.5280650110703, 10133.797324053552, 10135.493225338703, 10135.695929122212, 10167.983201679846, 10181.592736290539, 4175.164967006611, 4253.170631726845, 4305.052888364555, 4330.133973205371, 4394.406755088022, 8732.563371831384, 8764.737057888273, 8789.516576588221, 8794.252488538417, 8799.296056315607, 4696.81212751493, 4713.905721885543, 4718.05638872227, 4728.007118505084, 4729.12511185425, 4312.827486900489, 4318.1363727254675, 4318.3090705486975, 4319.4816622005565, 4320.4599425071865, 3665.120371110914, 3705.1107734144152, 3718.5723641781, 3731.1231860512758, 3756.887293381203, 1194.6296648038963, 1203.3080978437433, 1204.1330242225583, 1208.3354155214597, 1208.8065909454444, 1002.8746406699163, 1241.0878004666563, 1265.474827946392, 1282.2947378941544, 1315.0860152194134, 6385.904211436832, 7014.579125252501, 7133.89299160513, 7140.642967851691, 7143.178534468499, 570.1419363857368, 585.0785013603592, 585.1749033862319, 586.2730214534032, 591.1369400675062, 5168.095583272912, 5176.715280659525, 5205.765740541685, 5206.479352064764, 5219.112750832368, 8498.235158835734, 8826.911730882737, 8866.822663546693, 8992.46045237288, 9044.592993315317, 8941.59762810675, 9094.272458203328, 9110.726678199664, 9114.316426268057, 9133.543322833964, 6767.39093481589, 6780.627065511346, 6918.06606108179, 6981.82545436358, 6992.0910281663055, 6942.340477654615, 6948.200956890022, 6954.860902782018, 6972.616506092214, 6984.16190057176, 7796.454248202572, 8020.478668886503, 8197.139300373376, 8216.876746848682, 8226.42415030966, 8229.753107406548, 8328.0, 8388.328933685412, 8501.234888860032, 8505.91494085076, 6589.505787066085, 6732.225794033749, 6732.865342693217, 6752.797416077526, 6758.594484330956, 7284.307990740871, 7307.415406767552, 7310.378617817332, 7331.120265568166, 7335.743248986473, 6513.609183449008, 6678.198616166092, 6680.6993685283305, 6726.7981960541265, 6827.385535301847, 6705.966470167618, 6711.597304161766, 6761.93238067613, 6813.863722725617, 6855.211650660238, 5978.940210597838, 6210.689465526796, 6862.759803406857, 6874.8625027500175, 6913.861722765617, 6201.534884883562, 6229.345918678474, 6246.531510136849, 6251.937480625135, 6277.1525844010475, 6268.122462855295, 6302.842428939313, 6310.7475700971445, 6315.810525684236, 6321.399467050623], "unit": "score", "name": "mootools.html", "value": 4303.395963147054}, {"lowerIsBetter": false, "replicates": [340.1971347619617, 340.5980942487864, 343.3990516595957, 347.81391955303917, 349.4565949947832, 5695.829125126253, 5800.071988481844, 5835.387284335147, 5847.912281315778, 5907.556933230009, 5662.6602403855795, 5762.510186634131, 5783.797567085153, 5789.623674461157, 5803.767849286034, 4552.0, 4555.521670224628, 4557.863264102066, 4561.771911404433, 4562.110388474249, 4354.47746270448, 4419.4033805436175, 4421.491528474218, 4425.601695847373, 4554.476235232941, 4378.211921854065, 4483.574060464267, 4521.276595744682, 4523.321501774727, 4527.09458108378, 4510.052888893337, 4517.07399983006, 4518.52555481673, 4520.208963431386, 4535.909281814362, 3976.2445135424177, 3989.7606143631474, 3999.8200080996426, 4007.0383108054148, 4010.578889216649, 5370.650907691027, 5525.0, 5527.861803454905, 5529.502344788988, 5580.246666699984, 5116.590672746172, 5119.078565858144, 5128.051310507568, 5128.743562821844, 5129.6409251352425, 5899.056151015817, 6182.598131121463, 6194.752209911598, 6205.627662340274, 6220.906686399708, 4147.605977432139, 4186.539480657125, 4260.531341552458, 4284.378765079077, 4293.914121717579, 6359.109724638554, 6371.203599550056, 6378.61728296299, 6379.298277189506, 6446.645434501101, 4408.6913916026215, 4432.312991486325, 4433.202023635777, 4433.889152771142, 4434.11317736454, 4307.750752281803, 4427.136708341907, 4493.191225579427, 4493.662975276868, 4496.572825581565, 5090.490950904954, 5098.08234517783, 5152.587792976553, 5158.38099428071, 5160.0, 6221.844453888599, 6226.5641405102115, 6230.283517395557, 6235.875282494325, 6236.126942228092, 1569.5683686985942, 1596.1221328269405, 1596.6407558299522, 1596.9600759981092, 1597.193417324267, 1062.2564205056492, 1062.8140075486758, 1069.4118234970736, 1074.9516271767789, 1091.879893211746, 5813.389594092644, 5820.650760954356, 5826.126081087871, 5829.242198514166, 5834.67909264986, 6380.234371875405, 6380.872382552323, 6382.648954307465, 6388.456981156561, 6396.520260980352, 5808.448197421239, 5816.243888294494, 5816.41835816415, 5819.127130930395, 5824.126381042877, 3330.4338262495435, 3452.9654703453148, 3454.1709989602314, 3455.4989526518516, 3456.2569047654874, 6541.411272985454, 6543.509236807258, 6549.083128362033, 6551.4103730664465, 6556.27880933097, 6522.543421960512, 6538.771143009972, 6563.343665633399, 6565.638889861008, 6569.244536878225, 6346.936530634727, 6517.543771936013, 6610.86778264432, 6616.206055273302, 6627.0, 6179.567430279837, 6340.461060809883, 6428.164338635947, 6433.903491447726, 6448.5163612730175, 6236.875262494816, 6357.682115894279, 6367.586106903036, 6399.456046236122, 6399.680015999088, 6604.63674497888, 6608.372204640552, 6609.4712423005085, 6612.867742645024, 6622.039804228263, 4307.741535507755, 4316.201502722007, 4354.042110735633, 4355.782210889506, 4364.541723119027, 6367.076773867856, 6367.363263673596, 6379.393957574023, 6442.09810626522, 6444.967775161094, 6258.374162583706, 6264.185655864709, 6265.746850629801, 6269.153664255449, 6269.843253918689, 6072.726727297194, 6258.593191442542, 6261.405166509175, 6263.342349053284, 6268.843278918063, 6147.354527774698, 6157.953147964947, 6186.536009799193, 6187.81436556904, 6188.412100850412, 6262.624242545462, 6268.561200716089, 6282.497400207881, 6309.0, 6326.145970294136, 6071.119687645179, 6103.267607887082, 6128.387161283836, 6158.199434073542, 6175.783847565313], "unit": "score", "name": "prototype.html", "value": 4682.31297467545}, {"lowerIsBetter": false, "replicates": [769.3883362726632, 843.0220943705303, 847.6800205978323, 852.1010334097532, 886.2112719679486, 13231.404586793593, 13427.664308392308, 13428.127171733842, 13433.798493022612, 13438.46246150153, 12510.937445312784, 12573.622791316253, 12578.559750408738, 12600.0, 12611.117221794479, 658.5456035335627, 668.3817468841327, 789.928906398424, 790.2690011739147, 804.0431886055575, 797.3860127701666, 799.4244144216156, 803.2569872867604, 804.9275565199131, 805.4241217529466, 838.9454685445457, 845.5096044294295, 845.8392905347995, 846.9534175620338, 847.0343808058818, 684.3874732114755, 692.1728534401392, 804.5414113955048, 810.2019510781934, 823.5429336718119, 603.4779915373215, 604.749029152901, 606.0787602843653, 606.5117580347818, 606.9666168360739, 12812.29532375719, 12876.742465150644, 12884.54904078362, 12904.483820647163, 12913.096083274175, 11521.539138434453, 11544.538218471334, 11815.350155741431, 11982.161248712593, 12152.817707734392, 10536.789264214749, 10578.471076446147, 10585.576576936914, 10591.470426478721, 11566.595169169123, 4282.909999405168, 4301.65586753059, 4354.172707185625, 4387.166438376698, 4483.439570053743, 41104.0, 41435.58564414347, 41766.16467670629, 41794.79102604498, 41828.1634367311, 9781.951090244504, 10039.397636141855, 10168.898311016943, 10200.693979180636, 10310.020548047924, 17178.0, 17540.298388064588, 17560.560985975197, 17668.469945901386, 17761.289548418175, 7052.541584796972, 7234.674439650228, 7276.708931642781, 7325.926740732631, 7339.412846972229, 4129.91740165195, 4233.5882569391315, 4241.130568233505, 4247.150569886036, 4340.891477713082, 3078.2766049978236, 3117.563541104247, 3118.7193152616373, 3124.7968882022597, 3137.6705445928305, 587.4448646029547, 598.7545106506311, 609.065085094378, 609.3510411411833, 617.728199592178, 529.203548659273, 533.8318429694634, 546.3116473243662, 580.8315588479294, 593.8871614393252, 7997.920020799834, 8367.623456944451, 8461.576921153917, 8545.31637469001, 8751.868721969175, 582.0026861662473, 680.1973671068088, 680.3799035385724, 692.3111504053498, 708.6208878250111, 3801.828917698655, 3826.3877779555137, 3939.1136994176654, 3969.861054863066, 4041.7372870763306, 49554.25668614974, 49863.0, 49956.500434995185, 50032.0, 50102.248466273035, 45217.773911130236, 45465.77267113643, 45544.178232870974, 46367.76816115898, 46614.0, 41182.176356472104, 41222.587774122476, 41650.1669966599, 41760.79119604383, 41768.37347439791, 7657.310842024244, 7806.1803510632835, 7913.604319783873, 8012.679492820455, 8068.515889046676, 32348.83825580857, 32974.83512582422, 33585.32829343448, 33704.157396064315, 33758.49362259519, 38842.417363739, 38862.6113738859, 41885.0, 42491.0, 44266.77866610646, 11085.612003579836, 11248.775024499628, 11403.258788178742, 11684.591039313584, 11687.532498699957, 11804.232724872856, 11942.582009629621, 12020.939895300467, 12602.495900164258, 12606.621801345975, 11077.612283570037, 11222.494987725735, 11229.606963756229, 11596.47815848272, 11839.05287577009, 11110.222284440011, 11307.886921131012, 11598.18812683104, 11633.41832908368, 11986.280823150639, 10700.0, 10891.836622450828, 11214.887851121384, 11243.831342530033, 11314.377709226072, 9158.313126515672, 9696.0, 9712.125908668253, 9886.357386769838, 9895.901040989498, 8662.220400164015, 9008.32437567172, 9156.954215228881, 9197.0, 9796.51017449139], "unit": "score", "name": "yui.html", "value": 6134.549787953665}], "name": "dromaeo_css", "value": 6762.76016999807}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 106.0, 113.0, 112.0, 111.0, 100.0, 111.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 148.0, 159.0, 124.0, 148.0, 154.0, 123.0, 162.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 142.3}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 161.0, 162.0, 162.0, 162.0, 161.0, 165.0, 163.0, 159.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 81.0, 94.0, 72.0, 71.0, 72.0, 118.0, 94.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 145.0, 99.0, 96.0, 96.0, 140.0, 96.0, 97.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 57.0, 57.0, 59.0, 57.0, 59.0, 71.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 84.0, 85.0, 92.0, 85.0, 92.0, 84.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [120.0, 123.0, 122.0, 115.0, 128.0, 113.0, 118.0, 129.0, 125.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [139.0, 141.0, 149.0, 156.0, 150.0, 141.0, 151.0, 159.0, 148.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 69.0, 68.0, 71.0, 70.0, 67.0, 69.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1505.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.6944490748458], "unit": "score", "name": "Richards", "value": 211.77669800000004}, {"lowerIsBetter": false, "replicates": [190.15021867275146], "unit": "score", "name": "DeltaBlue", "value": 347.714562}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [5301.587301587301], "unit": "score", "name": "Decrypt", "value": 50.20779341317366}, {"lowerIsBetter": false, "replicates": [1119.8208286674133], "unit": "score", "name": "RayTrace", "value": 660.8101769999998}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12353.658536585366], "unit": "score", "name": "Boyer", "value": 53.948633761105626}, {"lowerIsBetter": false, "replicates": [42744.68085106383], "unit": "score", "name": "RegExp", "value": 21.312242409158777}, {"lowerIsBetter": false, "replicates": [595.7193816884661], "unit": "score", "name": "Splay", "value": 136.79427345309378}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19940.88782662732}]} 20:17:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19940.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1505.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6762.76"}}} 20:17:33 INFO - Return code: 0 20:17:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:17:33 INFO - # TBPL SUCCESS # 20:17:33 INFO - Running post-action listener: _resource_record_post_action 20:17:33 INFO - Running post-run listener: _resource_record_post_run 20:17:34 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 561950720; Read time: 0; Write time: 443960 20:17:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 250478592; Read time: 0; Write time: 241420 20:17:34 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 311291904; Read time: 0; Write time: 202520 20:17:34 INFO - Running post-run listener: _upload_blobber_files 20:17:34 INFO - Blob upload gear active. 20:17:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:17:34 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 20:17:34 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'] 20:17:34 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 20:17:35 INFO - (blobuploader) - INFO - Open directory for files ... 20:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:17:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:36 INFO - (blobuploader) - INFO - Done attempting. 20:17:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:17:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:17:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:36 INFO - (blobuploader) - INFO - Done attempting. 20:17:36 INFO - (blobuploader) - INFO - Iteration through files over. 20:17:36 INFO - Return code: 0 20:17:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:17:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:17:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c3ffe78e3af1fed03d8d3546a0be551002a1d303db84d7f5f2f45c8fd5b62d397ca5077c04cbc4da642be10797b293efe9d9c712471943510bdb85b5807fec2f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/3858d28626df8700e2f704ffbb483846d24a4e6fcb7f8928e41444976233af572160ac05f19361cdc0da13e8ee0890feaf43713e2afc5da99762bdae5f59e274"} 20:17:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:17:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:17:36 INFO - Contents: 20:17:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c3ffe78e3af1fed03d8d3546a0be551002a1d303db84d7f5f2f45c8fd5b62d397ca5077c04cbc4da642be10797b293efe9d9c712471943510bdb85b5807fec2f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/3858d28626df8700e2f704ffbb483846d24a4e6fcb7f8928e41444976233af572160ac05f19361cdc0da13e8ee0890feaf43713e2afc5da99762bdae5f59e274"} 20:17:36 INFO - Copying logs to upload dir... 20:17:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.089841 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-07 20:17:36.672770) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 20:17:36.676209) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027 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/c3ffe78e3af1fed03d8d3546a0be551002a1d303db84d7f5f2f45c8fd5b62d397ca5077c04cbc4da642be10797b293efe9d9c712471943510bdb85b5807fec2f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/3858d28626df8700e2f704ffbb483846d24a4e6fcb7f8928e41444976233af572160ac05f19361cdc0da13e8ee0890feaf43713e2afc5da99762bdae5f59e274"} build_url:https://queue.taskcluster.net/v1/task/HK8LNKtoS5CpPXLMkHhseA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/HK8LNKtoS5CpPXLMkHhseA/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/c3ffe78e3af1fed03d8d3546a0be551002a1d303db84d7f5f2f45c8fd5b62d397ca5077c04cbc4da642be10797b293efe9d9c712471943510bdb85b5807fec2f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/3858d28626df8700e2f704ffbb483846d24a4e6fcb7f8928e41444976233af572160ac05f19361cdc0da13e8ee0890feaf43713e2afc5da99762bdae5f59e274"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 20:17:36.701747) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 20:17:36.702124) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452224169.265314-2044944027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 20:17:36.785917) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 20:17:36.786279) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 20:17:36.786626) ========= ========= Total master_lag: 0.26 =========