builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1450708839.75 results: success (0) buildid: 20151221043014 builduid: e86d24fbe59949d89d1e43310c37cc4b revision: a8acaa9868df4aa8d801725cfa9ef744640fc402 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:39.747435) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:39.747910) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:39.748222) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006319 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:39.791072) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:39.791366) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:39.822501) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:39.822775) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:39.871767) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:39.872061) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:39.872417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:39.872701) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 06:40:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-21 06:40:40 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193115 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:40.079966) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:40.080348) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013793 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:40.129880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 06:40:40.130237) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a8acaa9868df4aa8d801725cfa9ef744640fc402 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a8acaa9868df4aa8d801725cfa9ef744640fc402 --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=b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 06:40:40,341 truncating revision to first 12 chars 2015-12-21 06:40:40,341 Setting DEBUG logging. 2015-12-21 06:40:40,341 attempt 1/10 2015-12-21 06:40:40,341 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a8acaa9868df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 06:40:41,357 unpacking tar archive at: mozilla-central-a8acaa9868df/testing/mozharness/ program finished with exit code 0 elapsedTime=1.298063 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 06:40:41.441527) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:41.441844) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:41.451222) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:41.451521) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 06:40:41.452014) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-12-21 06:40:41.452323) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:40:41 INFO - MultiFileLogger online at 20151221 06:40:41 in /builds/slave/test-pgo 06:40:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:40:41 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:40:41 INFO - {'append_to_log': False, 06:40:41 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:40:41 INFO - 'blob_upload_branch': 'Firefox', 06:40:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:40:41 INFO - 'branch': 'Firefox', 06:40:41 INFO - 'buildbot_json_path': 'buildprops.json', 06:40:41 INFO - 'config_files': ('talos/linux_config.py',), 06:40:41 INFO - 'default_actions': ('clobber', 06:40:41 INFO - 'read-buildbot-config', 06:40:41 INFO - 'download-and-extract', 06:40:41 INFO - 'populate-webroot', 06:40:41 INFO - 'create-virtualenv', 06:40:41 INFO - 'install', 06:40:41 INFO - 'run-tests'), 06:40:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:40:41 INFO - 'download_minidump_stackwalk': True, 06:40:41 INFO - 'download_symbols': 'ondemand', 06:40:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:40:41 INFO - 'tooltool.py': '/tools/tooltool.py', 06:40:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:40:41 INFO - '/tools/misc-python/virtualenv.py')}, 06:40:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:40:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:40:41 INFO - 'installer_path': 'installer.exe', 06:40:41 INFO - 'log_level': 'info', 06:40:41 INFO - 'log_name': 'talos', 06:40:41 INFO - 'log_to_console': True, 06:40:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:40:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:40:41 INFO - 'opt_config_files': (), 06:40:41 INFO - 'pip_index': False, 06:40:41 INFO - 'sps_profile': False, 06:40:41 INFO - 'sps_profile_interval': 0, 06:40:41 INFO - 'suite': 'dromaeojs-e10s', 06:40:41 INFO - 'system_bits': '64', 06:40:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:40:41 INFO - 'title': 'talos-linux64-ix-001', 06:40:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:40:41 INFO - 'use_talos_json': True, 06:40:41 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:40:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:40:41 INFO - 'work_dir': 'build'} 06:40:41 INFO - ##### 06:40:41 INFO - ##### Running clobber step. 06:40:41 INFO - ##### 06:40:41 INFO - Running pre-action listener: _resource_record_pre_action 06:40:41 INFO - Running main action method: clobber 06:40:41 INFO - rmtree: /builds/slave/test-pgo/build 06:40:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:40:42 INFO - Running post-action listener: _resource_record_post_action 06:40:42 INFO - ##### 06:40:42 INFO - ##### Running read-buildbot-config step. 06:40:42 INFO - ##### 06:40:42 INFO - Running pre-action listener: _resource_record_pre_action 06:40:42 INFO - Running main action method: read_buildbot_config 06:40:42 INFO - Using buildbot properties: 06:40:42 INFO - { 06:40:42 INFO - "project": "", 06:40:42 INFO - "product": "firefox", 06:40:42 INFO - "script_repo_revision": "production", 06:40:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:40:42 INFO - "repository": "", 06:40:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:40:42 INFO - "buildid": "20151221043014", 06:40:42 INFO - "pgo_build": "True", 06:40:42 INFO - "basedir": "/builds/slave/test-pgo", 06:40:42 INFO - "buildnumber": 590, 06:40:42 INFO - "slavename": "talos-linux64-ix-001", 06:40:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:40:42 INFO - "platform": "ubuntu64_hw", 06:40:42 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:40:42 INFO - "branch": "mozilla-central", 06:40:42 INFO - "repo_path": "mozilla-central", 06:40:42 INFO - "revision": "a8acaa9868df4aa8d801725cfa9ef744640fc402", 06:40:42 INFO - "stage_platform": "linux64-pgo", 06:40:42 INFO - "builduid": "e86d24fbe59949d89d1e43310c37cc4b", 06:40:42 INFO - "slavebuilddir": "test" 06:40:42 INFO - } 06:40:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:40:42 INFO - Running post-action listener: _resource_record_post_action 06:40:42 INFO - ##### 06:40:42 INFO - ##### Running download-and-extract step. 06:40:42 INFO - ##### 06:40:42 INFO - Running pre-action listener: _resource_record_pre_action 06:40:42 INFO - Running main action method: download_and_extract 06:40:42 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:40: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')]} 06:40:42 INFO - https://queue.taskcluster.net/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/test_packages.json 06:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/test_packages.json 06:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:40:44 INFO - Downloaded 1302 bytes. 06:40:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:40:44 INFO - Using the following test package requirements: 06:40:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:40:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:40:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:44 INFO - u'jsshell-linux-x86_64.zip'], 06:40:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:40:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:40:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:40:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:40:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:40:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:40:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:40:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:44 INFO - https://queue.taskcluster.net/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:40:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:40:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:40:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/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 06:40:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/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 06:40:48 INFO - Downloaded 23175024 bytes. 06:40:48 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 06:40:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:40:48 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 06:40:49 INFO - Return code: 0 06:40:49 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 06:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:49 INFO - https://queue.taskcluster.net/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:40:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:40:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:40:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/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 06:40:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/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 06:41:00 INFO - Downloaded 23175024 bytes. 06:41:00 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 06:41:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:41:00 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 06:41:02 INFO - Return code: 0 06:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:02 INFO - https://queue.taskcluster.net/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:41:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:41:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:41:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/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 06:41:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/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 06:41:03 INFO - Downloaded 11132277 bytes. 06:41:03 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 06:41:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:41:03 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 06:41:03 INFO - Return code: 0 06:41:03 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')]} 06:41:03 INFO - https://queue.taskcluster.net/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:41:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:41:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:41:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/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 06:41:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oXgrGoEOTvOJbK-bPuf6ww/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 06:41:05 INFO - Downloaded 54949163 bytes. 06:41:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:41:05 INFO - mkdir: /builds/slave/test-pgo/properties 06:41:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:41:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:41:05 INFO - Contents: 06:41:05 INFO - build_url:https://queue.taskcluster.net/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:41:05 INFO - Running post-action listener: _resource_record_post_action 06:41:05 INFO - Running post-action listener: set_extra_try_arguments 06:41:05 INFO - ##### 06:41:05 INFO - ##### Running populate-webroot step. 06:41:05 INFO - ##### 06:41:05 INFO - Running pre-action listener: _resource_record_pre_action 06:41:05 INFO - Running main action method: populate_webroot 06:41:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:41:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:41:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:41:05 INFO - '--tppagecycles', 06:41:05 INFO - '7'], 06:41:05 INFO - 'tests': ['tsvgm']}}, 06:41:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:41:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:41:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:41:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:41:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:41:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:41:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:41:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:05 INFO - 'talos_options': ['--e10s'], 06:41:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:41:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:05 INFO - 'tests': ['damp', 'tps']}, 06:41:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:05 INFO - 'talos_options': ['--e10s'], 06:41:05 INFO - 'tests': ['damp', 'tps']}, 06:41:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:41:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:41:05 INFO - 'other': {'tests': ['a11yr', 06:41:05 INFO - 'ts_paint', 06:41:05 INFO - 'tpaint', 06:41:05 INFO - 'sessionrestore', 06:41:05 INFO - 'sessionrestore_no_auto_restore']}, 06:41:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:41:05 INFO - 'tests': ['a11yr', 06:41:05 INFO - 'ts_paint', 06:41:05 INFO - 'tpaint', 06:41:05 INFO - 'sessionrestore', 06:41:05 INFO - 'sessionrestore_no_auto_restore']}, 06:41:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:41:05 INFO - 'tests': ['a11yr', 06:41:05 INFO - 'ts_paint', 06:41:05 INFO - 'tpaint', 06:41:05 INFO - 'sessionrestore', 06:41:05 INFO - 'sessionrestore_no_auto_restore']}, 06:41:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:41:05 INFO - 'tests': ['a11yr', 06:41:05 INFO - 'ts_paint', 06:41:05 INFO - 'tpaint', 06:41:05 INFO - 'sessionrestore', 06:41:05 INFO - 'sessionrestore_no_auto_restore']}, 06:41:05 INFO - 'other_l64': {'tests': ['a11yr', 06:41:05 INFO - 'ts_paint', 06:41:05 INFO - 'tpaint', 06:41:05 INFO - 'sessionrestore', 06:41:05 INFO - 'sessionrestore_no_auto_restore']}, 06:41:05 INFO - 'other_nol64': {'tests': ['a11yr', 06:41:05 INFO - 'ts_paint', 06:41:05 INFO - 'tpaint', 06:41:05 INFO - 'sessionrestore', 06:41:05 INFO - 'sessionrestore_no_auto_restore']}, 06:41:05 INFO - 'svgr': {'tests': ['tsvgx', 06:41:05 INFO - 'tsvgr_opacity', 06:41:05 INFO - 'tart', 06:41:05 INFO - 'tscrollx', 06:41:05 INFO - 'cart']}, 06:41:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:41:05 INFO - 'tests': ['tsvgx', 06:41:05 INFO - 'tsvgr_opacity', 06:41:05 INFO - 'tart', 06:41:05 INFO - 'tscrollx', 06:41:05 INFO - 'cart']}, 06:41:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:05 INFO - 'tests': ['tp5o']}, 06:41:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:05 INFO - 'talos_options': ['--e10s'], 06:41:05 INFO - 'tests': ['tp5o']}, 06:41:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:05 INFO - 'talos_options': ['--xperf_path', 06:41:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:05 INFO - 'tests': ['tp5n']}, 06:41:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:05 INFO - 'talos_options': ['--e10s', 06:41:05 INFO - '--xperf_path', 06:41:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:05 INFO - 'tests': ['tp5n']}}, 06:41:05 INFO - 'talos.zip': {'path': '', 06:41:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:41:05 INFO - Running post-action listener: _resource_record_post_action 06:41:05 INFO - ##### 06:41:05 INFO - ##### Running create-virtualenv step. 06:41:05 INFO - ##### 06:41:05 INFO - Running pre-action listener: _resource_record_pre_action 06:41:05 INFO - Running main action method: create_virtualenv 06:41:05 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:41:05 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 06:41:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:41:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:41:05 INFO - Using real prefix '/usr' 06:41:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:41:06 INFO - Installing distribute.............................................................................................................................................................................................done. 06:41:08 INFO - Installing pip.................done. 06:41:08 INFO - Return code: 0 06:41:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:41:08 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')]} 06:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:08 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')]} 06:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:08 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 0x7fd594519f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe98840>, '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 0xe056b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe05b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', '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 06:41:08 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 06:41:08 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 06:41:08 INFO - Using env: {'DISPLAY': ':0', 06:41:08 INFO - 'HOME': '/home/cltbld', 06:41:08 INFO - 'LANG': 'en_US.UTF-8', 06:41:08 INFO - 'LANGUAGE': 'en_US:en', 06:41:08 INFO - 'LOGNAME': 'cltbld', 06:41:08 INFO - 'MAIL': '/var/mail/cltbld', 06:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:08 INFO - 'MOZ_NO_REMOTE': '1', 06:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:08 INFO - 'NO_EM_RESTART': '1', 06:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:41:08 INFO - 'PWD': '/builds/slave/test-pgo', 06:41:08 INFO - 'SHELL': '/bin/bash', 06:41:08 INFO - 'SHLVL': '1', 06:41:08 INFO - 'TERM': 'linux', 06:41:08 INFO - 'TMOUT': '86400', 06:41:08 INFO - 'USER': 'cltbld', 06:41:08 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', 06:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:08 INFO - '_': '/tools/buildbot/bin/python'} 06:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:08 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 06:41:08 INFO - Cleaning up... 06:41:08 INFO - Return code: 0 06:41:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:41:08 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')]} 06:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:08 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')]} 06:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:08 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 0x7fd594519f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe98840>, '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 0xe056b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe05b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', '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 06:41:08 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 06:41:08 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 06:41:08 INFO - Using env: {'DISPLAY': ':0', 06:41:08 INFO - 'HOME': '/home/cltbld', 06:41:08 INFO - 'LANG': 'en_US.UTF-8', 06:41:08 INFO - 'LANGUAGE': 'en_US:en', 06:41:08 INFO - 'LOGNAME': 'cltbld', 06:41:08 INFO - 'MAIL': '/var/mail/cltbld', 06:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:08 INFO - 'MOZ_NO_REMOTE': '1', 06:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:08 INFO - 'NO_EM_RESTART': '1', 06:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:41:08 INFO - 'PWD': '/builds/slave/test-pgo', 06:41:08 INFO - 'SHELL': '/bin/bash', 06:41:08 INFO - 'SHLVL': '1', 06:41:08 INFO - 'TERM': 'linux', 06:41:08 INFO - 'TMOUT': '86400', 06:41:08 INFO - 'USER': 'cltbld', 06:41:08 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', 06:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:08 INFO - '_': '/tools/buildbot/bin/python'} 06:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:08 INFO - Downloading/unpacking psutil>=0.7.1 06:41:08 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 06:41:08 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 06:41:08 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 06:41:08 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 06:41:08 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 06:41:08 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 06:41:10 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:41:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:41:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:41:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:41:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:41:10 INFO - Installing collected packages: psutil 06:41:10 INFO - Running setup.py install for psutil 06:41:10 INFO - building 'psutil._psutil_linux' extension 06:41:10 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 06:41:10 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 06:41:10 INFO - building 'psutil._psutil_posix' extension 06:41:10 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 06:41:10 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 06:41:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:41:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:41:11 INFO - Successfully installed psutil 06:41:11 INFO - Cleaning up... 06:41:11 INFO - Return code: 0 06:41:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:11 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 0x7fd594519f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe98840>, '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 0xe056b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe05b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', '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 06:41:11 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 06:41:11 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 06:41:11 INFO - Using env: {'DISPLAY': ':0', 06:41:11 INFO - 'HOME': '/home/cltbld', 06:41:11 INFO - 'LANG': 'en_US.UTF-8', 06:41:11 INFO - 'LANGUAGE': 'en_US:en', 06:41:11 INFO - 'LOGNAME': 'cltbld', 06:41:11 INFO - 'MAIL': '/var/mail/cltbld', 06:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:11 INFO - 'MOZ_NO_REMOTE': '1', 06:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:11 INFO - 'NO_EM_RESTART': '1', 06:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:41:11 INFO - 'PWD': '/builds/slave/test-pgo', 06:41:11 INFO - 'SHELL': '/bin/bash', 06:41:11 INFO - 'SHLVL': '1', 06:41:11 INFO - 'TERM': 'linux', 06:41:11 INFO - 'TMOUT': '86400', 06:41:11 INFO - 'USER': 'cltbld', 06:41:11 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', 06:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:11 INFO - '_': '/tools/buildbot/bin/python'} 06:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:41:11 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 06:41:11 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 06:41:11 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 06:41:11 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 06:41:11 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 06:41:11 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 06:41:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:41:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:41:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:41:12 INFO - Installing collected packages: mozsystemmonitor 06:41:12 INFO - Running setup.py install for mozsystemmonitor 06:41:13 INFO - Successfully installed mozsystemmonitor 06:41:13 INFO - Cleaning up... 06:41:13 INFO - Return code: 0 06:41:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:13 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 0x7fd594519f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe98840>, '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 0xe056b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe05b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', '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 06:41:13 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 06:41:13 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 06:41:13 INFO - Using env: {'DISPLAY': ':0', 06:41:13 INFO - 'HOME': '/home/cltbld', 06:41:13 INFO - 'LANG': 'en_US.UTF-8', 06:41:13 INFO - 'LANGUAGE': 'en_US:en', 06:41:13 INFO - 'LOGNAME': 'cltbld', 06:41:13 INFO - 'MAIL': '/var/mail/cltbld', 06:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:13 INFO - 'MOZ_NO_REMOTE': '1', 06:41:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:13 INFO - 'NO_EM_RESTART': '1', 06:41:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:41:13 INFO - 'PWD': '/builds/slave/test-pgo', 06:41:13 INFO - 'SHELL': '/bin/bash', 06:41:13 INFO - 'SHLVL': '1', 06:41:13 INFO - 'TERM': 'linux', 06:41:13 INFO - 'TMOUT': '86400', 06:41:13 INFO - 'USER': 'cltbld', 06:41:13 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', 06:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:13 INFO - '_': '/tools/buildbot/bin/python'} 06:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:13 INFO - Downloading/unpacking blobuploader==1.2.4 06:41:13 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 06:41:13 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 06:41:13 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 06:41:13 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 06:41:13 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 06:41:13 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 06:41:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:41:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:41:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:41:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:41:15 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 06:41:15 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 06:41:15 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 06:41:15 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 06:41:15 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 06:41:15 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 06:41:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:41:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:41:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:41:15 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 06:41:15 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 06:41:15 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 06:41:15 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 06:41:15 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 06:41:15 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 06:41:15 INFO - Downloading docopt-0.6.1.tar.gz 06:41:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:41:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:41:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:41:16 INFO - Running setup.py install for blobuploader 06:41:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:41:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:41:16 INFO - Running setup.py install for requests 06:41:16 INFO - Running setup.py install for docopt 06:41:16 INFO - Successfully installed blobuploader requests docopt 06:41:16 INFO - Cleaning up... 06:41:16 INFO - Return code: 0 06:41:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:41:16 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')]} 06:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:16 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')]} 06:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:16 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 0x7fd594519f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe98840>, '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 0xe056b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe05b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', '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 06:41:16 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 06:41:16 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 06:41:16 INFO - Using env: {'DISPLAY': ':0', 06:41:16 INFO - 'HOME': '/home/cltbld', 06:41:16 INFO - 'LANG': 'en_US.UTF-8', 06:41:16 INFO - 'LANGUAGE': 'en_US:en', 06:41:16 INFO - 'LOGNAME': 'cltbld', 06:41:16 INFO - 'MAIL': '/var/mail/cltbld', 06:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:16 INFO - 'MOZ_NO_REMOTE': '1', 06:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:16 INFO - 'NO_EM_RESTART': '1', 06:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:41:16 INFO - 'PWD': '/builds/slave/test-pgo', 06:41:16 INFO - 'SHELL': '/bin/bash', 06:41:16 INFO - 'SHLVL': '1', 06:41:16 INFO - 'TERM': 'linux', 06:41:16 INFO - 'TMOUT': '86400', 06:41:16 INFO - 'USER': 'cltbld', 06:41:16 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', 06:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:16 INFO - '_': '/tools/buildbot/bin/python'} 06:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:41:16 INFO - Running setup.py (path:/tmp/pip-us2PkP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:41:16 INFO - Running setup.py (path:/tmp/pip-lQFA2a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:41:16 INFO - Running setup.py (path:/tmp/pip-v3W7Oz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:41:17 INFO - Running setup.py (path:/tmp/pip-i048kD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:41:17 INFO - Running setup.py (path:/tmp/pip-2PvKi9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:41:17 INFO - Running setup.py (path:/tmp/pip-m9gTUR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:41:17 INFO - Running setup.py (path:/tmp/pip-o7D8Nn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:41:17 INFO - Running setup.py (path:/tmp/pip-XMDKxU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:41:17 INFO - Running setup.py (path:/tmp/pip-Jx5yBk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:41:17 INFO - Running setup.py (path:/tmp/pip-9okMfv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:41:17 INFO - Running setup.py (path:/tmp/pip-VQEUPT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:41:17 INFO - Running setup.py (path:/tmp/pip-DBISOt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:41:17 INFO - Running setup.py (path:/tmp/pip-6E9ILT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:41:17 INFO - Running setup.py (path:/tmp/pip-JSCT2F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:41:17 INFO - Running setup.py (path:/tmp/pip-Foy0uu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:41:17 INFO - Running setup.py (path:/tmp/pip-UF0UJr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:41:17 INFO - Running setup.py (path:/tmp/pip-w8TmXx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:41:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:41:18 INFO - Running setup.py install for manifestparser 06:41:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:41:18 INFO - Running setup.py install for mozcrash 06:41:18 INFO - Running setup.py install for mozdebug 06:41:18 INFO - Running setup.py install for mozdevice 06:41:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:41:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:41:18 INFO - Running setup.py install for mozfile 06:41:18 INFO - Running setup.py install for mozhttpd 06:41:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:41:18 INFO - Running setup.py install for mozinfo 06:41:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:41:18 INFO - Running setup.py install for mozInstall 06:41:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:41:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:41:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:41:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:41:18 INFO - Running setup.py install for mozleak 06:41:18 INFO - Running setup.py install for mozlog 06:41:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:41:19 INFO - Running setup.py install for moznetwork 06:41:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:41:19 INFO - Running setup.py install for mozprocess 06:41:19 INFO - Running setup.py install for mozprofile 06:41:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:41:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:41:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:41:19 INFO - Running setup.py install for mozrunner 06:41:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:41:19 INFO - Running setup.py install for mozscreenshot 06:41:19 INFO - Running setup.py install for moztest 06:41:19 INFO - Running setup.py install for mozversion 06:41:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:41:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:41:19 INFO - Cleaning up... 06:41:19 INFO - Return code: 0 06:41:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:41: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')]} 06:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41: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')]} 06:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:19 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 0x7fd594519f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe98840>, '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 0xe056b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe05b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', '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 06:41:19 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 06:41:19 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 06:41:19 INFO - Using env: {'DISPLAY': ':0', 06:41:19 INFO - 'HOME': '/home/cltbld', 06:41:19 INFO - 'LANG': 'en_US.UTF-8', 06:41:19 INFO - 'LANGUAGE': 'en_US:en', 06:41:19 INFO - 'LOGNAME': 'cltbld', 06:41:19 INFO - 'MAIL': '/var/mail/cltbld', 06:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:19 INFO - 'MOZ_NO_REMOTE': '1', 06:41:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:19 INFO - 'NO_EM_RESTART': '1', 06:41:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:41:19 INFO - 'PWD': '/builds/slave/test-pgo', 06:41:19 INFO - 'SHELL': '/bin/bash', 06:41:19 INFO - 'SHLVL': '1', 06:41:19 INFO - 'TERM': 'linux', 06:41:19 INFO - 'TMOUT': '86400', 06:41:19 INFO - 'USER': 'cltbld', 06:41:19 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', 06:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:19 INFO - '_': '/tools/buildbot/bin/python'} 06:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:41:20 INFO - Running setup.py (path:/tmp/pip-Syq73x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:41:20 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)) 06:41:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:41:20 INFO - Running setup.py (path:/tmp/pip-P7IfL1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:41:20 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)) 06:41:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:41:20 INFO - Running setup.py (path:/tmp/pip-evb053-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:41:20 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)) 06:41:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:41:20 INFO - Running setup.py (path:/tmp/pip-8wWhnW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:41:20 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)) 06:41:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:41:20 INFO - Running setup.py (path:/tmp/pip-hAdmF0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:41:20 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)) 06:41:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:41:20 INFO - Running setup.py (path:/tmp/pip-C32qBG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:41:20 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)) 06:41:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:41:20 INFO - Running setup.py (path:/tmp/pip-solnug-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:41:20 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)) 06:41:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:41:20 INFO - Running setup.py (path:/tmp/pip-KpQQ_i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:41:20 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)) 06:41:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:41:20 INFO - Running setup.py (path:/tmp/pip-IH_6Tq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:41:20 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)) 06:41:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:41:20 INFO - Running setup.py (path:/tmp/pip-A7SsaD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:41:20 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)) 06:41:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:41:20 INFO - Running setup.py (path:/tmp/pip-MSM_HX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:41:20 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)) 06:41:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:41:20 INFO - Running setup.py (path:/tmp/pip-9sVb4U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:41:20 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)) 06:41:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:41:20 INFO - Running setup.py (path:/tmp/pip-y2MmVs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:41:20 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)) 06:41:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:41:20 INFO - Running setup.py (path:/tmp/pip-X4rotm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:41:21 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)) 06:41:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:41:21 INFO - Running setup.py (path:/tmp/pip-PkWlTu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:41:21 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)) 06:41:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:41:21 INFO - Running setup.py (path:/tmp/pip-DuTWBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:41:21 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)) 06:41:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:41:21 INFO - Running setup.py (path:/tmp/pip-dUpnnq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:41:21 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)) 06:41:21 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)) 06:41:21 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)) 06:41:21 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)) 06:41:21 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)) 06:41:21 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)) 06:41:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:41:21 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 06:41:21 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 06:41:21 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 06:41:21 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 06:41:21 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 06:41:21 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 06:41:22 INFO - Downloading blessings-1.5.1.tar.gz 06:41:22 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 06:41:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:41:22 INFO - Installing collected packages: blessings 06:41:22 INFO - Running setup.py install for blessings 06:41:23 INFO - Successfully installed blessings 06:41:23 INFO - Cleaning up... 06:41:23 INFO - Return code: 0 06:41:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:41:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:41:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:41:23 INFO - Reading from file tmpfile_stdout 06:41:23 INFO - Current package versions: 06:41:23 INFO - argparse == 1.2.1 06:41:23 INFO - blessings == 1.5.1 06:41:23 INFO - blobuploader == 1.2.4 06:41:23 INFO - docopt == 0.6.1 06:41:23 INFO - manifestparser == 1.1 06:41:23 INFO - mozInstall == 1.12 06:41:23 INFO - mozcrash == 0.16 06:41:23 INFO - mozdebug == 0.1 06:41:23 INFO - mozdevice == 0.47 06:41:23 INFO - mozfile == 1.2 06:41:23 INFO - mozhttpd == 0.7 06:41:23 INFO - mozinfo == 0.9 06:41:23 INFO - mozleak == 0.1 06:41:23 INFO - mozlog == 3.1 06:41:23 INFO - moznetwork == 0.27 06:41:23 INFO - mozprocess == 0.22 06:41:23 INFO - mozprofile == 0.28 06:41:23 INFO - mozrunner == 6.11 06:41:23 INFO - mozscreenshot == 0.1 06:41:23 INFO - mozsystemmonitor == 0.0 06:41:23 INFO - moztest == 0.7 06:41:23 INFO - mozversion == 1.4 06:41:23 INFO - psutil == 3.1.1 06:41:23 INFO - requests == 1.2.3 06:41:23 INFO - wsgiref == 0.1.2 06:41:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:23 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 0x7fd594519f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe98840>, '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 0xe056b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe05b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', '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 06:41:23 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 06:41:23 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 06:41:23 INFO - Using env: {'DISPLAY': ':0', 06:41:23 INFO - 'HOME': '/home/cltbld', 06:41:23 INFO - 'LANG': 'en_US.UTF-8', 06:41:23 INFO - 'LANGUAGE': 'en_US:en', 06:41:23 INFO - 'LOGNAME': 'cltbld', 06:41:23 INFO - 'MAIL': '/var/mail/cltbld', 06:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:23 INFO - 'MOZ_NO_REMOTE': '1', 06:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:23 INFO - 'NO_EM_RESTART': '1', 06:41:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:41:23 INFO - 'PWD': '/builds/slave/test-pgo', 06:41:23 INFO - 'SHELL': '/bin/bash', 06:41:23 INFO - 'SHLVL': '1', 06:41:23 INFO - 'TERM': 'linux', 06:41:23 INFO - 'TMOUT': '86400', 06:41:23 INFO - 'USER': 'cltbld', 06:41:23 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', 06:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:23 INFO - '_': '/tools/buildbot/bin/python'} 06:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:23 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)) 06:41:23 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)) 06:41:23 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)) 06:41:23 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)) 06:41:23 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)) 06:41:23 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)) 06:41:23 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)) 06:41:23 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)) 06:41:23 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)) 06:41:23 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)) 06:41:23 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)) 06:41:23 INFO - Cleaning up... 06:41:23 INFO - Return code: 0 06:41:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:23 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 0x7fd594519f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe98840>, '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 0xe056b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe05b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', '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 06:41:23 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 06:41:23 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 06:41:23 INFO - Using env: {'DISPLAY': ':0', 06:41:23 INFO - 'HOME': '/home/cltbld', 06:41:23 INFO - 'LANG': 'en_US.UTF-8', 06:41:23 INFO - 'LANGUAGE': 'en_US:en', 06:41:23 INFO - 'LOGNAME': 'cltbld', 06:41:23 INFO - 'MAIL': '/var/mail/cltbld', 06:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:23 INFO - 'MOZ_NO_REMOTE': '1', 06:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:23 INFO - 'NO_EM_RESTART': '1', 06:41:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:41:23 INFO - 'PWD': '/builds/slave/test-pgo', 06:41:23 INFO - 'SHELL': '/bin/bash', 06:41:23 INFO - 'SHLVL': '1', 06:41:23 INFO - 'TERM': 'linux', 06:41:23 INFO - 'TMOUT': '86400', 06:41:23 INFO - 'USER': 'cltbld', 06:41:23 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', 06:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:23 INFO - '_': '/tools/buildbot/bin/python'} 06:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:23 INFO - Downloading/unpacking jsonschema 06:41:23 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 06:41:23 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 06:41:23 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 06:41:23 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 06:41:23 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 06:41:23 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 06:41:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:41:25 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 06:41:25 INFO - Downloading/unpacking functools32 (from jsonschema) 06:41:25 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 06:41:25 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 06:41:25 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 06:41:25 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 06:41:25 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 06:41:25 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 06:41:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:41:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:41:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:41:25 INFO - warning: no files found matching '*.txt' 06:41:25 INFO - no previously-included directories found matching 'build' 06:41:25 INFO - no previously-included directories found matching 'dist' 06:41:25 INFO - no previously-included directories found matching '.git*' 06:41:25 INFO - Installing collected packages: jsonschema, functools32 06:41:25 INFO - Running setup.py install for functools32 06:41:25 INFO - warning: no files found matching '*.txt' 06:41:25 INFO - no previously-included directories found matching 'build' 06:41:25 INFO - no previously-included directories found matching 'dist' 06:41:25 INFO - no previously-included directories found matching '.git*' 06:41:25 INFO - Successfully installed jsonschema functools32 06:41:25 INFO - Cleaning up... 06:41:25 INFO - Return code: 0 06:41:25 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:41:25 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')]} 06:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:25 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')]} 06:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:25 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 0x7fd594519f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe98840>, '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 0xe056b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe05b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', '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 06:41:25 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 06:41:25 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 06:41:25 INFO - Using env: {'DISPLAY': ':0', 06:41:25 INFO - 'HOME': '/home/cltbld', 06:41:25 INFO - 'LANG': 'en_US.UTF-8', 06:41:25 INFO - 'LANGUAGE': 'en_US:en', 06:41:25 INFO - 'LOGNAME': 'cltbld', 06:41:25 INFO - 'MAIL': '/var/mail/cltbld', 06:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:25 INFO - 'MOZ_NO_REMOTE': '1', 06:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:25 INFO - 'NO_EM_RESTART': '1', 06:41:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:41:25 INFO - 'PWD': '/builds/slave/test-pgo', 06:41:25 INFO - 'SHELL': '/bin/bash', 06:41:25 INFO - 'SHLVL': '1', 06:41:25 INFO - 'TERM': 'linux', 06:41:25 INFO - 'TMOUT': '86400', 06:41:25 INFO - 'USER': 'cltbld', 06:41:25 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', 06:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:25 INFO - '_': '/tools/buildbot/bin/python'} 06:41:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:26 INFO - Downloading/unpacking flake8 06:41:26 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 06:41:26 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 06:41:26 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 06:41:26 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 06:41:26 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 06:41:26 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 06:41:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:41:27 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 06:41:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:41:27 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 06:41:27 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 06:41:27 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 06:41:27 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 06:41:27 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 06:41:27 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 06:41:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:41:28 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 06:41:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:41:28 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 06:41:28 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 06:41:28 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 06:41:28 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 06:41:28 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 06:41:28 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 06:41:28 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 06:41:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:41:28 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 06:41:28 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 06:41:28 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 06:41:28 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 06:41:28 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 06:41:28 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 06:41:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:41:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:41:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:41:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:41:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:41:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:41:28 INFO - no previously-included directories found matching 'docs/_build' 06:41:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:41:28 INFO - Running setup.py install for pep8 06:41:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:41:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:41:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:41:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:41:28 INFO - no previously-included directories found matching 'docs/_build' 06:41:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:41:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:41:28 INFO - Cleaning up... 06:41:28 INFO - Return code: 0 06:41:28 INFO - Running post-action listener: _resource_record_post_action 06:41:28 INFO - Running post-action listener: _start_resource_monitoring 06:41:28 INFO - Starting resource monitoring. 06:41:28 INFO - ##### 06:41:28 INFO - ##### Running install step. 06:41:28 INFO - ##### 06:41:28 INFO - Running pre-action listener: _resource_record_pre_action 06:41:28 INFO - Running main action method: install 06:41:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:41:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:41:28 INFO - Reading from file tmpfile_stdout 06:41:28 INFO - Detecting whether we're running mozinstall >=1.0... 06:41:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:41:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:41:29 INFO - Reading from file tmpfile_stdout 06:41:29 INFO - Output received: 06:41:29 INFO - Usage: mozinstall [options] installer 06:41:29 INFO - Options: 06:41:29 INFO - -h, --help show this help message and exit 06:41:29 INFO - -d DEST, --destination=DEST 06:41:29 INFO - Directory to install application into. [default: 06:41:29 INFO - "/builds/slave/test-pgo"] 06:41:29 INFO - --app=APP Application being installed. [default: firefox] 06:41:29 INFO - mkdir: /builds/slave/test-pgo/build/application 06:41:29 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'] 06:41:29 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 06:41:44 INFO - Reading from file tmpfile_stdout 06:41:44 INFO - Output received: 06:41:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:41:44 INFO - Running post-action listener: _resource_record_post_action 06:41:44 INFO - ##### 06:41:44 INFO - ##### Running run-tests step. 06:41:44 INFO - ##### 06:41:44 INFO - Running pre-action listener: _resource_record_pre_action 06:41:44 INFO - Running main action method: run_tests 06:41:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:41:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:41:44 INFO - Python 2.7.3 06:41:44 INFO - Return code: 0 06:41:44 INFO - grabbing minidump binary from tooltool 06:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:44 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 0xe98840>, '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 0xe056b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe05b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:41:44 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 06:41:44 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 06:41:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:41:44 INFO - Return code: 0 06:41:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:41:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:41:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:41:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:41:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:41:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:41:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:41:45 INFO - Return code: 0 06:41:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 06:41:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:41:45 INFO - Using env: {'DISPLAY': ':0', 06:41:45 INFO - 'HOME': '/home/cltbld', 06:41:45 INFO - 'LANG': 'en_US.UTF-8', 06:41:45 INFO - 'LANGUAGE': 'en_US:en', 06:41:45 INFO - 'LOGNAME': 'cltbld', 06:41:45 INFO - 'MAIL': '/var/mail/cltbld', 06:41:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:41:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:45 INFO - 'MOZ_NO_REMOTE': '1', 06:41:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:41:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:45 INFO - 'NO_EM_RESTART': '1', 06:41:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:41:45 INFO - 'PWD': '/builds/slave/test-pgo', 06:41:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:41:45 INFO - 'SHELL': '/bin/bash', 06:41:45 INFO - 'SHLVL': '1', 06:41:45 INFO - 'TERM': 'linux', 06:41:45 INFO - 'TMOUT': '86400', 06:41:45 INFO - 'USER': 'cltbld', 06:41:45 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245', 06:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:45 INFO - '_': '/tools/buildbot/bin/python'} 06:41:45 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:41:46 INFO - mozversion application_buildid: 20151221043014 06:41:46 INFO - mozversion application_changeset: a8acaa9868df4aa8d801725cfa9ef744640fc402 06:41:46 INFO - mozversion application_display_name: Nightly 06:41:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:41:46 INFO - mozversion application_name: Firefox 06:41:46 INFO - mozversion application_remotingname: firefox 06:41:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:41:46 INFO - mozversion application_vendor: Mozilla 06:41:46 INFO - mozversion application_version: 46.0a1 06:41:46 INFO - mozversion platform_buildid: 20151221043014 06:41:46 INFO - mozversion platform_changeset: a8acaa9868df4aa8d801725cfa9ef744640fc402 06:41:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:41:46 INFO - mozversion platform_version: 46.0a1 06:41:46 INFO - using testdate: 1450708906 06:41:46 INFO - actual date: 1450708906 06:41:46 INFO - starting webserver on 'localhost:52463' 06:41:46 INFO - SUITE-START | Running 3 tests 06:41:46 INFO - TEST-START | dromaeo_css 06:41:46 INFO - operating with platform_type : linux_ 06:41:46 INFO - Initialising browser for dromaeo_css test... 06:41:46 INFO - TEST-INFO | started process 5472 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8XvF2g/profile http://localhost:52463/getInfo.html) 06:41:50 INFO - PROCESS | 5472 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 06:41:50 INFO - PROCESS | 5472 | __metrics Screen width/height:1600/1200 06:41:50 INFO - PROCESS | 5472 | colorDepth:24 06:41:50 INFO - PROCESS | 5472 | Browser inner width/height: 1024/697 06:41:50 INFO - PROCESS | 5472 | __metrics 06:41:51 INFO - PROCESS | 5472 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:41:52 INFO - TEST-INFO | 5472: exit 0 06:41:52 INFO - Browser initialized. 06:41:52 INFO - Running cycle 1/1 for dromaeo_css test... 06:41:52 INFO - TEST-INFO | started process 5603 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8XvF2g/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:04 INFO - PROCESS | 5603 | RSS: Main: 150990848 06:42:04 INFO - PROCESS | 5603 | 06:42:53 INFO - PROCESS | 5603 | 1450708973948 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] 06:45:02 INFO - PROCESS | 5603 | Cycle 1(1): loaded http://localhost:52463/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52463/tests/dromaeo/cssquery-ext.html) 06:45:04 INFO - PROCESS | 5603 | RSS: Main: 156270592 06:45:04 INFO - PROCESS | 5603 | 06:48:06 INFO - PROCESS | 5603 | Cycle 1(1): loaded http://localhost:52463/tests/dromaeo/cssquery-ext.html (next: http://localhost:52463/tests/dromaeo/cssquery-jquery.html) 06:48:06 INFO - PROCESS | 5603 | RSS: Main: 152920064 06:48:06 INFO - PROCESS | 5603 | 06:51:08 INFO - PROCESS | 5603 | Cycle 1(1): loaded http://localhost:52463/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52463/tests/dromaeo/cssquery-mootools.html) 06:51:09 INFO - PROCESS | 5603 | RSS: Main: 153681920 06:51:09 INFO - PROCESS | 5603 | 06:54:10 INFO - PROCESS | 5603 | Cycle 1(1): loaded http://localhost:52463/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52463/tests/dromaeo/cssquery-prototype.html) 06:54:11 INFO - PROCESS | 5603 | RSS: Main: 152231936 06:54:11 INFO - PROCESS | 5603 | 06:57:13 INFO - PROCESS | 5603 | Cycle 1(1): loaded http://localhost:52463/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52463/tests/dromaeo/cssquery-yui.html) 06:57:14 INFO - PROCESS | 5603 | RSS: Main: 152289280 06:57:14 INFO - PROCESS | 5603 | 07:00:16 INFO - PROCESS | 5603 | Cycle 1(1): loaded http://localhost:52463/tests/dromaeo/cssquery-yui.html (next: http://localhost:52463/tests/dromaeo/cssquery-dojo.html) 07:00:17 INFO - PROCESS | 5603 | RSS: Main: 155844608 07:00:17 INFO - PROCESS | 5603 | 07:00:17 INFO - PROCESS | 5603 | __start_tp_report 07:00:17 INFO - PROCESS | 5603 | _x_x_mozilla_page_load 07:00:17 INFO - PROCESS | 5603 | _x_x_mozilla_page_load_details 07:00:17 INFO - PROCESS | 5603 | |i|pagename|runs| 07:00:17 INFO - PROCESS | 5603 | |0;dojo.html;3220.0661808075656;3230.9822405942114;3248.220427097497;3288.9342213155737;3305.834708264586;5285.286486324345;5433.782648694052;5458.890822183554;5480.835574932748;5489.39616642169;5391.595630327732;5460.453954604538;5466.207399927008;5485.780568777244;5489.094299440598;4890.339804126433;4948.950510494885;5008.774605142759;5041.294218809369;5041.8487445376695;5019.121653710605;5099.209622508517;5105.591552675795;5122.897542049157;5147.330846989886;4879.341288926021;4925.21196608541;4973.204287314013;5008.173651347523;5084.898302033957;5039.09296326661;5047.394312682465;5051.090803655341;5054.812119151997;5059.16523773577;5016.724080175589;5030.119729047402;5049.949500504985;5055.266986286968;5069.569086627641;5073.746312684351;5174.922376164361;5192.428832828386;5277.577793776489;5365.651232669903;5859.501942334907;5867.3839246879315;5885.882282354329;5900.468957793776;5910.438508341744;5945.464908158287;5946.316173640043;5969.522438204933;5982.760689572412;5997.460228579405;5407.513323800877;5486.862828429281;5499.862503437406;5588.608797384225;5591.301087364039;6053.061775424728;6071.757129714851;6081.8479538011015;6114.966544785233;6134.018557030854;5853.619514731528;5855.414458554111;5857.736401861926;5864.853378665567;5868.471837534557;5764.394738552475;5832.416758324219;5894.6757928314355;5944;6020.759169633253;5834.15404766315;5847.239858818411;5851.502622277154;5855.092460668603;5858.619189752652;5843.211166492554;5844.766209351578;5850.297964244318;5862.472377486047;5869.383714709894;4418;4481.574250446268;4502.954970450319;4516.683832131785;4561.452625684939;4036.737612055207;4049.838006479708;4058.817353219053;4094.447249621263;4103.753774773523;5414.377346605112;5504.91742623861;5568.7215639217875;5598.4961353477565;5598.692071936001;5767.192593036978;5809.24479817621;5809.7095145242565;5892.175095486636;5902.852428689317;5558.277423934863;5576.275084239023;5579.609427340129;5582.413846546055;5610.775568977195;4955.752212389366;4976.651634385631;4982.227754698028;4997.825076122391;5046.747662616928;5777.88444231113;5811.622244554091;5966.671833049224;6090.969545152246;6091.5735898487565;5915.201447804491;5943.138244954371;5969.582129250911;5971.373005834324;5983.581149319506;6008.339082700812;6056.545759068;6058.636481811105;6069.666168360783;6071.028635418312;5643.7742490299925;5756.107803290497;5835.037218859011;5839.036558967723;5994.310654274815;5941.7623295067715;5943.702814859326;5978.97010514962;5983.37174596661;5997.70011499432;5792.768289268382;5814.069748840166;5823.7379317929945;5836.824895253149;5854.853628659147;5591.916121258266;5672.546196304368;5708.885822283614;5781.68200748946;5786.016377215799;5634.718264086861;5668.348139963792;5693.430656934273;5703.828885133453;5707.600467967369;5814.215080964185;5837.883242335214;5866.6480011199465;5875.089361149029;5879.588428809942;5513.200585914939;5601.6358936668985;5614.6631202128;5616.859578510406;5729.4843464088435 07:00:17 INFO - PROCESS | 5603 | |1;ext.html;571.9360915097748;609.1106983803646;612.8559788449713;614.7940439952619;616.0574321288427;32394.352112957728;32407.837960810222;32450.350992980126;32599.51100733485;32674.836625816868;39803.40294895579;40067.79966100173;40109.39835902456;40353;40371.39442908351;8652.394332396734;8735.912640873605;8811.471311721285;8823.77940551485;8872.37893347466;8466.44968077076;8619.267362274215;8620.224179823814;8622.827543449128;8630.697925572606;8606.827863442728;8632.784180395509;8740.650373985032;8752.081031491698;8753.693620723276;8641.52471614064;8647.308215342757;8685.261752751023;8688.131186881325;8710.085441028696;8621.267192288664;8689.26141277992;8710.433821801562;8718.651253949834;8728.083551227093;37343.25313493715;37688.81155594232;37989.81005094985;38049.42925856114;38088;2920.6057182280333;2976.0922918509846;3008;3222.452183128874;3228.951565726516;28276;28449.857750711322;28463.57304640432;28502.3287357009;28728.569071463946;3754.2303827715255;3830.942535861964;3869.9226015479535;3881.8253178606747;3905.7461265017682;252176;255692;256046;256501;257153;40875;53298;53656.73171634117;53672.46327536675;53709.1943620846;40175.19649606991;40176.39735403971;40200.79899600542;40283.59716402857;40487.392689109685;13257.66855828612;13417.127886687334;13473.056886017885;13485.797713034312;13492.460301587827;9837.360571562825;9865.75335616601;9868.901310986941;9987.850182247272;9992.150667193224;11972.940135299268;12013.939930300467;12240.693982650506;12247.510099595916;12301.69245768845;5724.8282551523525;5858.707064646751;5891.116332550152;5893.410658934158;5941.376155503696;875.4353442029856;883.2271762208068;1012.6759436980243;1127.701159192798;1141.7374003978964;25287.36781580475;25356.366090847507;25502.362440939123;25535.61696574553;25607.87196064045;981.5681100315838;1007.9546420410952;1060.5121644043827;1079.3200283821143;1111.8499002634703;14589.124652520883;15227.695446091016;15935.123568203628;16594.75107873383;16622.75065874013;356530;361233;361697;362106;364195;51383.74308128435;51520.74239628778;51534.74232628888;51865;51889;1328.9667758305927;1331.8668133186604;1334.312828893121;1347.9730405392033;1352.0873410448105;27743.44513109767;28596;28838.711612884443;29048.709512905447;29087.7091229085;43490.782546087066;44018.89952751207;44225.33661995137;44226.55773442225;44436.11127777362;290516;290554;292027;292336;292884;30770.230744230677;31539.52690709595;43197.568024320615;43828.34257486204;43852;40764.79617601893;40946.79526602348;41682;41982.16035679208;42021;34997.300053999286;35282;35516.28967420585;35907;36130.8193459031;34845.78039768596;35169.64830351664;35238.29523409569;35506.644933550335;35536;35332;35371.64628353684;35578.28843423169;37116.81441592775;37651.623483764815;25715.871420642776;27660.170194894185;28534.42931141407;36106.27787444289;37239.6276037247;24169.395765106012;24346.147884823946;24510.75489245156;24600.384990375383;24779.50440991206 07:00:17 INFO - PROCESS | 5603 | |2;jquery.html;353.69582159342974;355.04138825172026;355.8771925464603;360.96751292383686;363.34960420846676;16647.084410357427;16691.165441727924;17414.477565673034;17803.554911127198;18192.181351839165;10819.188560857947;11809.409529523511;16126.113063781488;16137.515874523782;16206;4844.467108618058;5422.915416916613;5448.210009548613;5448.945510544903;5467.589930755209;5431.23962645228;5431.429699881495;5452.182172674091;5452.291202143716;5470.124780035195;4960.97519512402;4964.702117872939;5026.748662566875;5092.9745351273195;5203.895922081556;5145.742712864342;5160.896782064376;5179.119549676545;5206.140986737203;5227.555657769094;4987.700737955698;5257.5005374489365;5284.841454756325;5290.867728306785;5294.205869119624;11758.588969323735;12033.338166400845;12890.742185156245;18126.728099078526;18127.909360453246;1893.6496748101645;1996.910139043732;2024.3522072936519;2027.858049936505;2314.0396735354807;9464.810703785955;9529.857052144223;9561.856572151424;11396.772064558663;13360.93319533396;1769.8938063716218;1812.4109664359005;1823.7811462624438;1853.4717605482372;1897.0514742628686;60517;61512.38487615111;64002;64571.35428645747;64784.67607661932;10455.790884182274;10488.68533943983;10503.422311772925;10506.159507239403;10592.947035264775;13525.32373381327;13533.323333833268;13591.592252232449;13612;13678;6459;6525.934740652628;6555.3772391622715;6582.76960306387;6655.933440665532;5902.055671092605;5975.850603734942;5985.25184351956;5993.520518358521;6032.969835150796;4519.0961807638605;4524.683272170916;4548.977255113769;4594.47163576193;4608.792604332813;1814.97277540837;1851.3705340184401;1873.6159087387052;1879.6804543227684;1886.566089799354;764.6482617995673;862.9870551941726;881.5856547422701;958.7746879483316;959.1271942532262;15713.68572628541;15769.605759855865;16526.66946661084;16848.74726879098;16922.32310707558;904.6064961741663;906.1120102299651;907.2288554728428;942.189716843514;962.8603852441357;9220.5850736717;9562.95218523903;9626.133647971716;9805;10248.692539223835;472260;490459;491359;494938;512446;84414.12959597769;84474.15525844786;84516;85791.5710421444;86811;1140.4753813245834;1141.4635121492886;1169.1465230381698;1197.0902114393125;1208.546794951893;14716.55850324492;15375.385584513466;15723.842761572696;16428.17859107064;16451.177441128137;32266.83866580652;32855;33208;33221.17283549428;33283.167920802174;43255.351169733105;43722.34416483692;43731;45115.54884451113;46473.76763116163;9672.75818104553;9680.080392362714;9689.12797848197;9706.369086009387;9732.562034708597;11340.376279304717;11406.48670809799;17423.738643920096;18251.908740456212;18495.352662656744;14202.218877961397;14662.63343416423;14784;15087.924560377129;15183.544493665207;14175;14205.28973551339;14485.203313817841;14555.854441455449;14631.780523291945;14028.87768978459;14311.141331519726;14607.707845843237;14728.852711472748;14822.62943426423;8872.290216782512;8961.417507861968;9133.908660913306;9360.765980850534;9392.95303523478;9912.454814985245;10031.29780915329;13573.864261357656;13852.307384630929;14242.430302788187 07:00:17 INFO - PROCESS | 5603 | |3;mootools.html;1447.8045463862381;1458.161557104665;1588.1900230882247;1672.0803558043076;1758.6306875556133;6738.764143254987;6813.591184528919;7531.284527969848;7948.284654381105;8103.91896081039;7290.854182916351;7420.369268612175;7477.43919206059;7484.588347640877;7541;2217.833662475317;2263.0608297556496;2264.52444986553;2266.5013696986634;2268.2174649745893;2276.3398614401804;2284.2804516577226;2315.4327189838514;2348.365941195876;2348.9060437582475;2290.713660792401;2298.161171172518;2321.3500219938446;2323.4075310795724;2360.291912426274;2228.342638921522;2233.687283780272;2285.48576570272;2286.7713228677167;2287.325239054483;2310.7111611048617;2344.7069116360453;2348.835581509295;2350.494643651623;2354.482013956944;7705.961470192613;7733.381329493684;7748.535087894745;7765.068191816961;7811.296983271533;4661.813527458898;4697.3893393858925;4733.668643194977;4735.881602959919;4754.1917873961165;3043.3761078978755;3086.166734981565;3161.826099564546;3184.3472088222093;3211.8394080295893;951.1629765806047;953.427943234061;1785.3037315446986;1843.8340549350623;1847.6027654054442;10290.7427314317;10347.63783267582;10359.482025898675;10417.791644167075;10433.373997560095;4103.97948010258;4180.456540649696;4210.200061988213;4224.852130175429;4230.725002874803;8498.150184981576;8518.233358997595;8518.957405212934;8540.914590854136;8543.871841922377;4700.153972285021;4708.788104535304;4722.598579120813;4729.929051064237;4735.479097299294;4180.602842729936;4306.870793876189;4326.113146804961;4359.716618419792;4390;3510.736694747904;3517.683408493248;3539.5221645077586;3549.0594992327055;3554;1025.5436330832856;1030.2891005206384;1031.1132426113536;1076.5101878645198;1080.6595922284612;1050.7740835720356;1052.4211683574003;1207.1911819081236;1268.5623459906317;1271.2499625220978;7259.927400726031;7326.3406293433845;7346.191918888918;7361.705531778776;7406.518576292524;468.33262600793734;471.8725943995102;493.1050143988649;496.85839535732146;500.31207090250905;5505.532029777513;5554.888902221933;5584.52531534816;5584.86037849057;5594.832155035356;9267.72196834096;9417.811643767087;9624.615015399446;9706.223502119814;9735.026497350209;9413.811723765486;9469.621215151454;9471.431714097176;9502.382345147544;9535.427874327563;7140.07179066718;7238.855222895512;7279.490435669452;7291.161516425679;7316.975623412726;6569.408753212234;6615.900761488678;6618.305077966937;6622.271550129578;6642.90035649456;8354.958479718833;8395.118512556339;8474.406791524534;8561.315094792526;8671.913280867111;8604.96740391157;8683.435576687496;8777.736667899973;8861.158189971942;8908.955455222682;6496.610203387811;6737.25890152073;6747.224069231905;7050.612216328152;7059.82350441243;7432.405407567489;7448.143463501767;7459.776206713807;7467.738629147953;7472.551646901204;6969.163700355787;7165.498415110892;7171.103612048494;7217.7112915484895;7321.194668586558;7015.158181018311;7046.788596342118;7094.574325540484;7181.820454488679;7206.774848275911;6617.305182955721;6835.555688880406;6895.241523432318;6911.930880691129;6915.308469153246;6048.455638992512;6107.541934354852;6137.355577664281;6171.537134714825;6183.81448556544;5968.045112781934;5999.460048595647;6004.639721616717;6022.8795424090395;6169.907451388322 07:00:17 INFO - PROCESS | 5603 | |4;prototype.html;309.6887627933926;310.22134442549196;324.1943769732215;326.7957526545909;332.1049770867512;6212.037134244188;6288.622682639039;6327.841803954898;6356.300806911236;6377.585456945295;6143.354947730491;6306;6312.779052733155;6317.684115794214;6324.2727086385075;4764.047190561884;4765.189917713997;4766.3088852116425;4772.713637181763;4782.067496838118;4754.690945088558;4756.215224487955;4773.880652983686;4777.283407488887;4780.139574876521;4635.188841952661;4739.336492890998;4741.9525804742025;4744.122337367581;4758.857234282977;4712.410948631421;4716.419999300221;4737.076270127326;4746.335513028179;4763.523647635244;4149.190907772985;4155.792210389468;4155.958440415618;4164.604362585549;4166.416701661769;5889.617174883619;5905.793297234576;5929.555283353722;5930.258717660293;5939.346671866091;5372.597055220874;5467.726613669301;5492.450754924515;5510.256115424407;5510.311211098613;6605.306442823482;6621.304762999912;6623.635700036496;6626.304238055031;6633.678212625542;4543.25036369002;4554.612857907082;4560.201964656205;4560.771961401917;4562.794674239667;6815;6926.480513961473;6966.79099627007;6966.79099627012;6982.755603553851;4702.952970470252;4707.764611769398;4709.152352576569;4710.88222794426;4722.763861806896;4764.523547645277;4768.523147685204;4772.284157376422;4774.546418090275;4775;5494;5501.807436739695;5502.202180683858;5511.145772405283;5520.861978450571;6555.770548030891;6687.264400915896;6700.329967003358;6721.8655626887185;6726.1256036715895;1594.6810637872472;1624.9025058496527;1652.132630369066;1657.0471978612345;1657.1382880902104;1074.3607553505808;1078.4823284823328;1079.9730006749894;1097.6542389147394;1102.2725001498973;6326.240851097898;6355.841103972345;6379.138816259746;6385.616862988236;6395.2645445773405;6801.18385793708;6801.659917004229;6855.828604284933;6862.897056544156;6863.965680171567;6151.292601350902;6341.746330146835;6342.651154186472;6345.49236061114;6346.397092276226;3697.3159965406485;3728.366177749789;3739.0652336915773;3743.288775132716;3746.587875333711;6983.406410455066;7005.92994070063;7021.262767409451;7025.473089518307;7029.613371264527;6885.449164066863;6966.616836073963;7035.964820175969;7040.577565345993;7042.964785176144;7084.645767711697;7107.857842843217;7146.071010768671;7153.213146553875;7172.354488096096;6928.826779330557;6940.444764418733;6967.233604303624;6991.300869912968;6993.0908981832035;6675.465962723068;6836.658167091526;6841.315868413119;6878.415334696407;6879.621620810904;7096.254893236136;7145.249748776304;7179.425645948207;7184.640767961686;7197.424206063607;4640.048789997974;4675.205215113507;4681.063787242633;4681.6722829401615;4694.43666759991;6844.657767111724;6983.127109111361;7019.333163349474;7022.2275549688475;7037.648117593997;6790.524663273721;6804.591724496348;6812.318768123148;6833.487488438486;6835.248122706399;6746.190457145174;6769.221539522821;6786;6792.981052842113;6817.93182068173;6462.935370646233;6568.21181458209;6589.967050164719;6604.768833090819;6609.339066093352;6739.292374300824;6809.659517024228;6812.829679258059;6815.216250131299;6826.283240259701;6533.660599577171;6617.07360969455;6627.867442651216;6652.966735166293;6656.434203092597 07:00:17 INFO - PROCESS | 5603 | |5;yui.html;785.3403141361257;798.7563793043123;816.1838161838161;821.9958900205498;829.3903980574273;13751.312434378278;13958.092723972935;14120.57638270851;14125.505607303747;14151.15093094415;12879.613611591643;12914.806277905838;13031.609051728463;13039;13041.869581304185;790.1505881177743;801.8556659801234;802.4984384759525;821.5686764448683;834.4242472693852;607.3531688751488;610.3926593039931;611.7583554495972;612.20107759374;612.9387061293858;855.0295414704293;857.2756021162139;862.180928118287;863.3309185381316;867.4101610904582;848.1603212819296;851.8466675998318;852.1691350932853;853.9658413663446;857.7298151082421;626.8088233088906;629.5687454093915;631.737828801047;632.8955722305814;633.5881676910045;13895.722085558233;13951.162930224118;14015.789763153562;14054;14065;11747.47136378865;11936.104792140537;12091.758164836741;12594.496220151183;13099.607011789662;9331.242634280787;9811.215102791759;9829.901700983042;10079.848802267972;10446.26876118672;3480.4083305837817;3586.497890295361;3602.1174812170925;3617.113807117273;3637.563492380905;46158;46287.07425851498;46419.767901160616;46423.30365044527;46444.07111857744;8368.121347258571;8516.531590762568;8644.135586441305;8711.520866352412;8827.205551500396;16432.096234707205;16595.336186552402;16708.49874503767;16710.58223544421;16738.497845064667;7276.854462910712;7373.963130184315;7395.852082958419;7521.5111017783665;7554.320111190019;3963.2271707016853;3980.6218409251073;4007.6793856491413;4025.9396109057802;4087.080406908481;2937.662168850567;2958.8520573971214;2979.1956171833485;2985.0746268656785;2986.8357240351556;528.0890463949656;550.9338879334506;559.194759546252;559.7928766356474;562.7777028073888;450.4279564952492;519.4338171393124;565.2284631478003;591.4233622218303;621.6767281013847;8194.303484203909;8220.58897055145;8269.917300827035;8341.165883411732;8573.356998225157;490.4335492506161;547.917812328154;606.4996377988177;618.9292523933531;626.2891618013497;3698;3909.843606255718;3917.941230881539;3948.8420463181724;4038.3134867072667;60276.39723602708;60623.393766061774;60912.39087609156;61068.69465652643;61146.38853611407;50812.23781643278;52113.73943130336;52196;52506;53259.20111198335;47191;47397.52602474;47729.28406073912;48226.27660585094;48571.271430928566;7943.44395892282;8162.6734930602115;8200.507969521848;8204.138565450541;8469.153084691729;36396;36457.63542364648;37314.44028339631;37536.436953445176;37801.81099094487;45943;46182.7690861557;46266.76866615645;46687.29969050399;47551;9945.502724863873;10539.947300263757;10853.620123295646;10891.618793342195;10930.180236482454;11070.944645276722;11353.545858165911;11538.769224615293;11571.074314055024;11646.650600481998;10412.895871041193;10678;10739.570417183537;10739.624113156002;10754.13966882632;10032.64885728996;10546.209034322303;10884.292520986111;10984.560617575207;11014.39420831862;9251.398659087137;9849.704508864745;10054.396736195851;10419.94790026045;10528.263021588415;8778.166074222938;8930.285577153682;8957.193852553302;9162.954185229031;9225.815483690154;7683.899879768174;7711.575863327346;8089.514629122272;8162.347012239125;8249.917500825155 07:00:17 INFO - PROCESS | 5603 | __end_tp_report 07:00:17 INFO - PROCESS | 5603 | __start_cc_report 07:00:17 INFO - PROCESS | 5603 | _x_x_mozilla_cycle_collect,314 07:00:17 INFO - PROCESS | 5603 | __end_cc_report 07:00:17 INFO - PROCESS | 5603 | __startTimestamp1450710017184__endTimestamp 07:00:17 INFO - PROCESS | 5603 | 07:00:17 INFO - PROCESS | 5603 | ------- Summary: start ------- 07:00:17 INFO - PROCESS | 5603 | Number of tests: 6 07:00:17 INFO - PROCESS | 5603 | 07:00:17 INFO - PROCESS | 5603 | [#0] dojo.html Cycles:165 Average:5465.66 Median:5668.35 stddev:612.80 (10.8%) stddev-sans-first:588.82 07:00:17 INFO - PROCESS | 5603 | Values: 3220.1 3231.0 3248.2 3288.9 3305.8 5285.3 5433.8 5458.9 5480.8 5489.4 5391.6 5460.5 5466.2 5485.8 5489.1 4890.3 4949.0 5008.8 5041.3 5041.8 5019.1 5099.2 5105.6 5122.9 5147.3 4879.3 4925.2 4973.2 5008.2 5084.9 5039.1 5047.4 5051.1 5054.8 5059.2 5016.7 5030.1 5049.9 5055.3 5069.6 5073.7 5174.9 5192.4 5277.6 5365.7 5859.5 5867.4 5885.9 5900.5 5910.4 5945.5 5946.3 5969.5 5982.8 5997.5 5407.5 5486.9 5499.9 5588.6 5591.3 6053.1 6071.8 6081.8 6115.0 6134.0 5853.6 5855.4 5857.7 5864.9 5868.5 5764.4 5832.4 5894.7 5944.0 6020.8 5834.2 5847.2 5851.5 5855.1 5858.6 5843.2 5844.8 5850.3 5862.5 5869.4 4418.0 4481.6 4503.0 4516.7 4561.5 4036.7 4049.8 4058.8 4094.4 4103.8 5414.4 5504.9 5568.7 5598.5 5598.7 5767.2 5809.2 5809.7 5892.2 5902.9 5558.3 5576.3 5579.6 5582.4 5610.8 4955.8 4976.7 4982.2 4997.8 5046.7 5777.9 5811.6 5966.7 6091.0 6091.6 5915.2 5943.1 5969.6 5971.4 5983.6 6008.3 6056.5 6058.6 6069.7 6071.0 5643.8 5756.1 5835.0 5839.0 5994.3 5941.8 5943.7 5979.0 5983.4 5997.7 5792.8 5814.1 5823.7 5836.8 5854.9 5591.9 5672.5 5708.9 5781.7 5786.0 5634.7 5668.3 5693.4 5703.8 5707.6 5814.2 5837.9 5866.6 5875.1 5879.6 5513.2 5601.6 5614.7 5616.9 5729.5 07:00:17 INFO - PROCESS | 5603 | 07:00:17 INFO - PROCESS | 5603 | [#1] ext.html Cycles:180 Average:45628.50 Median:200655.91 stddev:80303.54 (40.0%) stddev-sans-first:80457.55 07:00:17 INFO - PROCESS | 5603 | Values: 571.9 609.1 612.9 614.8 616.1 32394.4 32407.8 32450.4 32599.5 32674.8 39803.4 40067.8 40109.4 40353.0 40371.4 8652.4 8735.9 8811.5 8823.8 8872.4 8466.4 8619.3 8620.2 8622.8 8630.7 8606.8 8632.8 8740.7 8752.1 8753.7 8641.5 8647.3 8685.3 8688.1 8710.1 8621.3 8689.3 8710.4 8718.7 8728.1 37343.3 37688.8 37989.8 38049.4 38088.0 2920.6 2976.1 3008.0 3222.5 3229.0 28276.0 28449.9 28463.6 28502.3 28728.6 3754.2 3830.9 3869.9 3881.8 3905.7 252176.0 255692.0 256046.0 256501.0 257153.0 40875.0 53298.0 53656.7 53672.5 53709.2 40175.2 40176.4 40200.8 40283.6 40487.4 13257.7 13417.1 13473.1 13485.8 13492.5 9837.4 9865.8 9868.9 9987.9 9992.2 11972.9 12013.9 12240.7 12247.5 12301.7 5724.8 5858.7 5891.1 5893.4 5941.4 875.4 883.2 1012.7 1127.7 1141.7 25287.4 25356.4 25502.4 25535.6 25607.9 981.6 1008.0 1060.5 1079.3 1111.8 14589.1 15227.7 15935.1 16594.8 16622.8 356530.0 361233.0 361697.0 362106.0 364195.0 51383.7 51520.7 51534.7 51865.0 51889.0 1329.0 1331.9 1334.3 1348.0 1352.1 27743.4 28596.0 28838.7 29048.7 29087.7 43490.8 44018.9 44225.3 44226.6 44436.1 290516.0 290554.0 292027.0 292336.0 292884.0 30770.2 31539.5 43197.6 43828.3 43852.0 40764.8 40946.8 41682.0 41982.2 42021.0 34997.3 35282.0 35516.3 35907.0 36130.8 34845.8 35169.6 35238.3 35506.6 35536.0 35332.0 35371.6 35578.3 37116.8 37651.6 25715.9 27660.2 28534.4 36106.3 37239.6 24169.4 24346.1 24510.8 24600.4 24779.5 07:00:17 INFO - PROCESS | 5603 | 07:00:17 INFO - PROCESS | 5603 | [#2] jquery.html Cycles:180 Average:27315.29 Median:362.16 stddev:80706.15 (22284.8%) stddev-sans-first:80907.16 07:00:17 INFO - PROCESS | 5603 | Values: 353.7 355.0 355.9 361.0 363.3 16647.1 16691.2 17414.5 17803.6 18192.2 10819.2 11809.4 16126.1 16137.5 16206.0 4844.5 5422.9 5448.2 5448.9 5467.6 5431.2 5431.4 5452.2 5452.3 5470.1 4961.0 4964.7 5026.7 5093.0 5203.9 5145.7 5160.9 5179.1 5206.1 5227.6 4987.7 5257.5 5284.8 5290.9 5294.2 11758.6 12033.3 12890.7 18126.7 18127.9 1893.6 1996.9 2024.4 2027.9 2314.0 9464.8 9529.9 9561.9 11396.8 13360.9 1769.9 1812.4 1823.8 1853.5 1897.1 60517.0 61512.4 64002.0 64571.4 64784.7 10455.8 10488.7 10503.4 10506.2 10592.9 13525.3 13533.3 13591.6 13612.0 13678.0 6459.0 6525.9 6555.4 6582.8 6655.9 5902.1 5975.9 5985.3 5993.5 6033.0 4519.1 4524.7 4549.0 4594.5 4608.8 1815.0 1851.4 1873.6 1879.7 1886.6 764.6 863.0 881.6 958.8 959.1 15713.7 15769.6 16526.7 16848.7 16922.3 904.6 906.1 907.2 942.2 962.9 9220.6 9563.0 9626.1 9805.0 10248.7 472260.0 490459.0 491359.0 494938.0 512446.0 84414.1 84474.2 84516.0 85791.6 86811.0 1140.5 1141.5 1169.1 1197.1 1208.5 14716.6 15375.4 15723.8 16428.2 16451.2 32266.8 32855.0 33208.0 33221.2 33283.2 43255.4 43722.3 43731.0 45115.5 46473.8 9672.8 9680.1 9689.1 9706.4 9732.6 11340.4 11406.5 17423.7 18251.9 18495.4 14202.2 14662.6 14784.0 15087.9 15183.5 14175.0 14205.3 14485.2 14555.9 14631.8 14028.9 14311.1 14607.7 14728.9 14822.6 8872.3 8961.4 9133.9 9360.8 9393.0 9912.5 10031.3 13573.9 13852.3 14242.4 07:00:17 INFO - PROCESS | 5603 | 07:00:17 INFO - PROCESS | 5603 | [#3] mootools.html Cycles:180 Average:5388.86 Median:6013.76 stddev:2791.13 (46.4%) stddev-sans-first:2783.24 07:00:17 INFO - PROCESS | 5603 | Values: 1447.8 1458.2 1588.2 1672.1 1758.6 6738.8 6813.6 7531.3 7948.3 8103.9 7290.9 7420.4 7477.4 7484.6 7541.0 2217.8 2263.1 2264.5 2266.5 2268.2 2276.3 2284.3 2315.4 2348.4 2348.9 2290.7 2298.2 2321.4 2323.4 2360.3 2228.3 2233.7 2285.5 2286.8 2287.3 2310.7 2344.7 2348.8 2350.5 2354.5 7706.0 7733.4 7748.5 7765.1 7811.3 4661.8 4697.4 4733.7 4735.9 4754.2 3043.4 3086.2 3161.8 3184.3 3211.8 951.2 953.4 1785.3 1843.8 1847.6 10290.7 10347.6 10359.5 10417.8 10433.4 4104.0 4180.5 4210.2 4224.9 4230.7 8498.2 8518.2 8519.0 8540.9 8543.9 4700.2 4708.8 4722.6 4729.9 4735.5 4180.6 4306.9 4326.1 4359.7 4390.0 3510.7 3517.7 3539.5 3549.1 3554.0 1025.5 1030.3 1031.1 1076.5 1080.7 1050.8 1052.4 1207.2 1268.6 1271.2 7259.9 7326.3 7346.2 7361.7 7406.5 468.3 471.9 493.1 496.9 500.3 5505.5 5554.9 5584.5 5584.9 5594.8 9267.7 9417.8 9624.6 9706.2 9735.0 9413.8 9469.6 9471.4 9502.4 9535.4 7140.1 7238.9 7279.5 7291.2 7317.0 6569.4 6615.9 6618.3 6622.3 6642.9 8355.0 8395.1 8474.4 8561.3 8671.9 8605.0 8683.4 8777.7 8861.2 8909.0 6496.6 6737.3 6747.2 7050.6 7059.8 7432.4 7448.1 7459.8 7467.7 7472.6 6969.2 7165.5 7171.1 7217.7 7321.2 7015.2 7046.8 7094.6 7181.8 7206.8 6617.3 6835.6 6895.2 6911.9 6915.3 6048.5 6107.5 6137.4 6171.5 6183.8 5968.0 5999.5 6004.6 6022.9 6169.9 07:00:17 INFO - PROCESS | 5603 | 07:00:17 INFO - PROCESS | 5603 | [#4] prototype.html Cycles:180 Average:5570.20 Median:6342.20 stddev:1703.07 (26.9%) stddev-sans-first:1661.45 07:00:17 INFO - PROCESS | 5603 | Values: 309.7 310.2 324.2 326.8 332.1 6212.0 6288.6 6327.8 6356.3 6377.6 6143.4 6306.0 6312.8 6317.7 6324.3 4764.0 4765.2 4766.3 4772.7 4782.1 4754.7 4756.2 4773.9 4777.3 4780.1 4635.2 4739.3 4742.0 4744.1 4758.9 4712.4 4716.4 4737.1 4746.3 4763.5 4149.2 4155.8 4156.0 4164.6 4166.4 5889.6 5905.8 5929.6 5930.3 5939.3 5372.6 5467.7 5492.5 5510.3 5510.3 6605.3 6621.3 6623.6 6626.3 6633.7 4543.3 4554.6 4560.2 4560.8 4562.8 6815.0 6926.5 6966.8 6966.8 6982.8 4703.0 4707.8 4709.2 4710.9 4722.8 4764.5 4768.5 4772.3 4774.5 4775.0 5494.0 5501.8 5502.2 5511.1 5520.9 6555.8 6687.3 6700.3 6721.9 6726.1 1594.7 1624.9 1652.1 1657.0 1657.1 1074.4 1078.5 1080.0 1097.7 1102.3 6326.2 6355.8 6379.1 6385.6 6395.3 6801.2 6801.7 6855.8 6862.9 6864.0 6151.3 6341.7 6342.7 6345.5 6346.4 3697.3 3728.4 3739.1 3743.3 3746.6 6983.4 7005.9 7021.3 7025.5 7029.6 6885.4 6966.6 7036.0 7040.6 7043.0 7084.6 7107.9 7146.1 7153.2 7172.4 6928.8 6940.4 6967.2 6991.3 6993.1 6675.5 6836.7 6841.3 6878.4 6879.6 7096.3 7145.2 7179.4 7184.6 7197.4 4640.0 4675.2 4681.1 4681.7 4694.4 6844.7 6983.1 7019.3 7022.2 7037.6 6790.5 6804.6 6812.3 6833.5 6835.2 6746.2 6769.2 6786.0 6793.0 6817.9 6462.9 6568.2 6590.0 6604.8 6609.3 6739.3 6809.7 6812.8 6815.2 6826.3 6533.7 6617.1 6627.9 6653.0 6656.4 07:00:17 INFO - PROCESS | 5603 | 07:00:17 INFO - PROCESS | 5603 | [#5] yui.html Cycles:180 Average:13731.27 Median:25651.34 stddev:16493.12 (64.3%) stddev-sans-first:16510.74 07:00:17 INFO - PROCESS | 5603 | Values: 785.3 798.8 816.2 822.0 829.4 13751.3 13958.1 14120.6 14125.5 14151.2 12879.6 12914.8 13031.6 13039.0 13041.9 790.2 801.9 802.5 821.6 834.4 607.4 610.4 611.8 612.2 612.9 855.0 857.3 862.2 863.3 867.4 848.2 851.8 852.2 854.0 857.7 626.8 629.6 631.7 632.9 633.6 13895.7 13951.2 14015.8 14054.0 14065.0 11747.5 11936.1 12091.8 12594.5 13099.6 9331.2 9811.2 9829.9 10079.8 10446.3 3480.4 3586.5 3602.1 3617.1 3637.6 46158.0 46287.1 46419.8 46423.3 46444.1 8368.1 8516.5 8644.1 8711.5 8827.2 16432.1 16595.3 16708.5 16710.6 16738.5 7276.9 7374.0 7395.9 7521.5 7554.3 3963.2 3980.6 4007.7 4025.9 4087.1 2937.7 2958.9 2979.2 2985.1 2986.8 528.1 550.9 559.2 559.8 562.8 450.4 519.4 565.2 591.4 621.7 8194.3 8220.6 8269.9 8341.2 8573.4 490.4 547.9 606.5 618.9 626.3 3698.0 3909.8 3917.9 3948.8 4038.3 60276.4 60623.4 60912.4 61068.7 61146.4 50812.2 52113.7 52196.0 52506.0 53259.2 47191.0 47397.5 47729.3 48226.3 48571.3 7943.4 8162.7 8200.5 8204.1 8469.2 36396.0 36457.6 37314.4 37536.4 37801.8 45943.0 46182.8 46266.8 46687.3 47551.0 9945.5 10539.9 10853.6 10891.6 10930.2 11070.9 11353.5 11538.8 11571.1 11646.7 10412.9 10678.0 10739.6 10739.6 10754.1 10032.6 10546.2 10884.3 10984.6 11014.4 9251.4 9849.7 10054.4 10419.9 10528.3 8778.2 8930.3 8957.2 9163.0 9225.8 7683.9 7711.6 8089.5 8162.3 8249.9 07:00:17 INFO - PROCESS | 5603 | -------- Summary: end -------- 07:00:17 INFO - PROCESS | 5603 | 07:00:17 INFO - TEST-INFO | 5603: exit 0 07:00:17 INFO - TEST-OK | dromaeo_css | took 1111845ms 07:00:17 INFO - TEST-START | kraken 07:00:17 INFO - operating with platform_type : linux_ 07:00:17 INFO - Initialising browser for kraken test... 07:00:17 INFO - TEST-INFO | started process 5846 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb23skf/profile http://localhost:52463/getInfo.html) 07:00:21 INFO - PROCESS | 5846 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 07:00:22 INFO - PROCESS | 5846 | __metrics Screen width/height:1600/1200 07:00:22 INFO - PROCESS | 5846 | colorDepth:24 07:00:22 INFO - PROCESS | 5846 | Browser inner width/height: 1024/697 07:00:22 INFO - PROCESS | 5846 | __metrics 07:00:22 INFO - PROCESS | 5846 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:00:23 INFO - TEST-INFO | 5846: exit 0 07:00:23 INFO - Browser initialized. 07:00:23 INFO - Running cycle 1/1 for kraken test... 07:00:23 INFO - TEST-INFO | started process 5966 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb23skf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:35 INFO - PROCESS | 5966 | RSS: Main: 151146496 07:00:35 INFO - PROCESS | 5966 | 07:00:37 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52463/tests/kraken/driver.html?testName=audio-beat-detection) 07:00:38 INFO - PROCESS | 5966 | RSS: Main: 151687168 07:00:38 INFO - PROCESS | 5966 | 07:00:41 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52463/tests/kraken/driver.html?testName=audio-dft) 07:00:41 INFO - PROCESS | 5966 | RSS: Main: 152580096 07:00:41 INFO - PROCESS | 5966 | 07:00:44 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52463/tests/kraken/driver.html?testName=audio-fft) 07:00:45 INFO - PROCESS | 5966 | RSS: Main: 145899520 07:00:45 INFO - PROCESS | 5966 | 07:00:47 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52463/tests/kraken/driver.html?testName=audio-oscillator) 07:00:48 INFO - PROCESS | 5966 | RSS: Main: 146788352 07:00:48 INFO - PROCESS | 5966 | 07:00:50 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52463/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:00:51 INFO - PROCESS | 5966 | RSS: Main: 146898944 07:00:51 INFO - PROCESS | 5966 | 07:00:54 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52463/tests/kraken/driver.html?testName=imaging-darkroom) 07:00:54 INFO - PROCESS | 5966 | RSS: Main: 147587072 07:00:54 INFO - PROCESS | 5966 | 07:00:57 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52463/tests/kraken/driver.html?testName=imaging-desaturate) 07:00:58 INFO - PROCESS | 5966 | RSS: Main: 148938752 07:00:58 INFO - PROCESS | 5966 | 07:01:01 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52463/tests/kraken/driver.html?testName=json-parse-financial) 07:01:01 INFO - PROCESS | 5966 | RSS: Main: 149123072 07:01:01 INFO - PROCESS | 5966 | 07:01:03 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52463/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:01:04 INFO - PROCESS | 5966 | RSS: Main: 148316160 07:01:04 INFO - PROCESS | 5966 | 07:01:05 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52463/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:01:06 INFO - PROCESS | 5966 | RSS: Main: 148885504 07:01:06 INFO - PROCESS | 5966 | 07:01:08 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52463/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:01:09 INFO - PROCESS | 5966 | RSS: Main: 148787200 07:01:09 INFO - PROCESS | 5966 | 07:01:11 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52463/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:01:12 INFO - PROCESS | 5966 | RSS: Main: 148750336 07:01:12 INFO - PROCESS | 5966 | 07:01:14 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52463/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:01:15 INFO - PROCESS | 5966 | RSS: Main: 148807680 07:01:15 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:52463/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52463/tests/kraken/driver.html?testName=ai-astar) 07:01:17 INFO - PROCESS | 5966 | RSS: Main: 148439040 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | __start_tp_report 07:01:17 INFO - PROCESS | 5966 | _x_x_mozilla_page_load 07:01:17 INFO - PROCESS | 5966 | _x_x_mozilla_page_load_details 07:01:17 INFO - PROCESS | 5966 | |i|pagename|runs| 07:01:17 INFO - PROCESS | 5966 | |0;ai-astar;112;107;110;111;110;124;112;112;110;109 07:01:17 INFO - PROCESS | 5966 | |1;audio-beat-detection;159;134;150;163;131;155;150;129;171;136 07:01:17 INFO - PROCESS | 5966 | |2;audio-dft;163;165;168;164;164;167;164;173;167;162 07:01:17 INFO - PROCESS | 5966 | |3;audio-fft;73;83;73;73;72;135;72;78;73;73 07:01:17 INFO - PROCESS | 5966 | |4;audio-oscillator;94;93;146;93;93;96;146;94;94;137 07:01:17 INFO - PROCESS | 5966 | |5;imaging-gaussian-blur;110;110;110;110;110;109;110;111;111;110 07:01:17 INFO - PROCESS | 5966 | |6;imaging-darkroom;146;146;148;145;148;147;147;146;148;147 07:01:17 INFO - PROCESS | 5966 | |7;imaging-desaturate;96;96;96;97;96;97;96;96;96;96 07:01:17 INFO - PROCESS | 5966 | |8;json-parse-financial;63;61;60;62;67;61;60;60;64;58 07:01:17 INFO - PROCESS | 5966 | |9;json-stringify-tinderbox;65;70;65;66;67;66;67;66;66;67 07:01:17 INFO - PROCESS | 5966 | |10;stanford-crypto-aes;91;83;92;87;85;84;84;85;84;85 07:01:17 INFO - PROCESS | 5966 | |11;stanford-crypto-ccm;129;122;123;125;119;123;122;119;120;120 07:01:17 INFO - PROCESS | 5966 | |12;stanford-crypto-pbkdf2;153;153;159;155;157;141;155;155;152;152 07:01:17 INFO - PROCESS | 5966 | |13;stanford-crypto-sha256-iterative;70;67;74;68;68;70;68;69;68;68 07:01:17 INFO - PROCESS | 5966 | __end_tp_report 07:01:17 INFO - PROCESS | 5966 | __start_cc_report 07:01:17 INFO - PROCESS | 5966 | _x_x_mozilla_cycle_collect,721 07:01:17 INFO - PROCESS | 5966 | __end_cc_report 07:01:17 INFO - PROCESS | 5966 | __startTimestamp1450710077412__endTimestamp 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | ------- Summary: start ------- 07:01:17 INFO - PROCESS | 5966 | Number of tests: 14 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:4.60 (4.1%) stddev-sans-first:4.87 07:01:17 INFO - PROCESS | 5966 | Values: 112.0 107.0 110.0 111.0 110.0 124.0 112.0 112.0 110.0 109.0 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:152.50 stddev:14.61 (9.6%) stddev-sans-first:14.93 07:01:17 INFO - PROCESS | 5966 | Values: 159.0 134.0 150.0 163.0 131.0 155.0 150.0 129.0 171.0 136.0 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#2] audio-dft Cycles:10 Average:165.70 Median:166.00 stddev:3.20 (1.9%) stddev-sans-first:3.24 07:01:17 INFO - PROCESS | 5966 | Values: 163.0 165.0 168.0 164.0 164.0 167.0 164.0 173.0 167.0 162.0 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#3] audio-fft Cycles:10 Average:80.50 Median:73.00 stddev:19.46 (26.7%) stddev-sans-first:20.45 07:01:17 INFO - PROCESS | 5966 | Values: 73.0 83.0 73.0 73.0 72.0 135.0 72.0 78.0 73.0 73.0 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.50 stddev:23.88 (25.5%) stddev-sans-first:24.74 07:01:17 INFO - PROCESS | 5966 | Values: 94.0 93.0 146.0 93.0 93.0 96.0 146.0 94.0 94.0 137.0 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:01:17 INFO - PROCESS | 5966 | Values: 110.0 110.0 110.0 110.0 110.0 109.0 110.0 111.0 111.0 110.0 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 07:01:17 INFO - PROCESS | 5966 | Values: 146.0 146.0 148.0 145.0 148.0 147.0 147.0 146.0 148.0 147.0 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:01:17 INFO - PROCESS | 5966 | Values: 96.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:61.50 stddev:2.55 (4.1%) stddev-sans-first:2.65 07:01:17 INFO - PROCESS | 5966 | Values: 63.0 61.0 60.0 62.0 67.0 61.0 60.0 60.0 64.0 58.0 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.50 stddev:1.43 (2.2%) stddev-sans-first:1.41 07:01:17 INFO - PROCESS | 5966 | Values: 65.0 70.0 65.0 66.0 67.0 66.0 67.0 66.0 66.0 67.0 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.00 stddev:3.09 (3.6%) stddev-sans-first:2.70 07:01:17 INFO - PROCESS | 5966 | Values: 91.0 83.0 92.0 87.0 85.0 84.0 84.0 85.0 84.0 85.0 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#11] stanford-crypto-ccm Cycles:10 Average:122.20 Median:122.50 stddev:3.08 (2.5%) stddev-sans-first:2.07 07:01:17 INFO - PROCESS | 5966 | Values: 129.0 122.0 123.0 125.0 119.0 123.0 122.0 119.0 120.0 120.0 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.20 Median:155.00 stddev:4.83 (3.1%) stddev-sans-first:5.12 07:01:17 INFO - PROCESS | 5966 | Values: 153.0 153.0 159.0 155.0 157.0 141.0 155.0 155.0 152.0 152.0 07:01:17 INFO - PROCESS | 5966 | 07:01:17 INFO - PROCESS | 5966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:2.00 (2.9%) stddev-sans-first:2.09 07:01:17 INFO - PROCESS | 5966 | Values: 70.0 67.0 74.0 68.0 68.0 70.0 68.0 69.0 68.0 68.0 07:01:17 INFO - PROCESS | 5966 | -------- Summary: end -------- 07:01:17 INFO - PROCESS | 5966 | 07:01:18 INFO - TEST-INFO | 5966: exit 0 07:01:18 INFO - TEST-OK | kraken | took 60344ms 07:01:18 INFO - TEST-START | v8_7 07:01:18 INFO - operating with platform_type : linux_ 07:01:18 INFO - Initialising browser for v8_7 test... 07:01:18 INFO - TEST-INFO | started process 6254 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpryuhiA/profile http://localhost:52463/getInfo.html) 07:01:22 INFO - PROCESS | 6254 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 07:01:22 INFO - PROCESS | 6254 | __metrics Screen width/height:1600/1200 07:01:22 INFO - PROCESS | 6254 | colorDepth:24 07:01:22 INFO - PROCESS | 6254 | Browser inner width/height: 1024/697 07:01:22 INFO - PROCESS | 6254 | __metrics 07:01:23 INFO - PROCESS | 6254 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:01:24 INFO - TEST-INFO | 6254: exit 0 07:01:24 INFO - Browser initialized. 07:01:24 INFO - Running cycle 1/1 for v8_7 test... 07:01:24 INFO - TEST-INFO | started process 6378 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpryuhiA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:35 INFO - PROCESS | 6378 | RSS: Main: 151023616 07:01:35 INFO - PROCESS | 6378 | 07:01:57 INFO - PROCESS | 6378 | Cycle 1(1): loaded http://localhost:52463/tests/v8_7/run.html (next: http://localhost:52463/tests/v8_7/run.html) 07:01:57 INFO - PROCESS | 6378 | RSS: Main: 147247104 07:01:57 INFO - PROCESS | 6378 | 07:01:57 INFO - PROCESS | 6378 | __start_tp_report 07:01:57 INFO - PROCESS | 6378 | _x_x_mozilla_page_load 07:01:57 INFO - PROCESS | 6378 | _x_x_mozilla_page_load_details 07:01:57 INFO - PROCESS | 6378 | |i|pagename|runs| 07:01:57 INFO - PROCESS | 6378 | |0;Richards;166.03021749958492 07:01:57 INFO - PROCESS | 6378 | |1;DeltaBlue;195.8096729978461 07:01:57 INFO - PROCESS | 6378 | |2;Encrypt;284.8191398461977 07:01:57 INFO - PROCESS | 6378 | |3;Decrypt;5213.541666666667 07:01:57 INFO - PROCESS | 6378 | |4;RayTrace;1063.8297872340424 07:01:57 INFO - PROCESS | 6378 | |5;Earley;721.5007215007215 07:01:57 INFO - PROCESS | 6378 | |6;Boyer;12120.481927710844 07:01:57 INFO - PROCESS | 6378 | |7;RegExp;25375 07:01:57 INFO - PROCESS | 6378 | |8;Splay;617.6652254478073 07:01:57 INFO - PROCESS | 6378 | |9;NavierStokes;4840.579710144928 07:01:57 INFO - PROCESS | 6378 | __end_tp_report 07:01:57 INFO - PROCESS | 6378 | __startTimestamp1450710117540__endTimestamp 07:01:57 INFO - PROCESS | 6378 | 07:01:57 INFO - PROCESS | 6378 | ------- Summary: start ------- 07:01:57 INFO - PROCESS | 6378 | Number of tests: 10 07:01:57 INFO - PROCESS | 6378 | 07:01:57 INFO - PROCESS | 6378 | [#0] Richards Cycles:1 Average:166.03 Median:166.03 stddev:0.00 (0.0%) 07:01:57 INFO - PROCESS | 6378 | Values: 166.0 07:01:57 INFO - PROCESS | 6378 | 07:01:57 INFO - PROCESS | 6378 | [#1] DeltaBlue Cycles:1 Average:195.81 Median:195.81 stddev:0.00 (0.0%) 07:01:57 INFO - PROCESS | 6378 | Values: 195.8 07:01:57 INFO - PROCESS | 6378 | 07:01:57 INFO - PROCESS | 6378 | [#2] Encrypt Cycles:1 Average:284.82 Median:284.82 stddev:0.00 (0.0%) 07:01:57 INFO - PROCESS | 6378 | Values: 284.8 07:01:57 INFO - PROCESS | 6378 | 07:01:57 INFO - PROCESS | 6378 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 07:01:57 INFO - PROCESS | 6378 | Values: 5213.5 07:01:57 INFO - PROCESS | 6378 | 07:01:57 INFO - PROCESS | 6378 | [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 07:01:57 INFO - PROCESS | 6378 | Values: 1063.8 07:01:57 INFO - PROCESS | 6378 | 07:01:57 INFO - PROCESS | 6378 | [#5] Earley Cycles:1 Average:721.50 Median:721.50 stddev:0.00 (0.0%) 07:01:57 INFO - PROCESS | 6378 | Values: 721.5 07:01:57 INFO - PROCESS | 6378 | 07:01:57 INFO - PROCESS | 6378 | [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 07:01:57 INFO - PROCESS | 6378 | Values: 12120.5 07:01:57 INFO - PROCESS | 6378 | 07:01:57 INFO - PROCESS | 6378 | [#7] RegExp Cycles:1 Average:25375.00 Median:25375.00 stddev:0.00 (0.0%) 07:01:57 INFO - PROCESS | 6378 | Values: 25375.0 07:01:57 INFO - PROCESS | 6378 | 07:01:57 INFO - PROCESS | 6378 | [#8] Splay Cycles:1 Average:617.67 Median:617.67 stddev:0.00 (0.0%) 07:01:57 INFO - PROCESS | 6378 | Values: 617.7 07:01:57 INFO - PROCESS | 6378 | 07:01:57 INFO - PROCESS | 6378 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 07:01:57 INFO - PROCESS | 6378 | Values: 4840.6 07:01:57 INFO - PROCESS | 6378 | -------- Summary: end -------- 07:01:57 INFO - PROCESS | 6378 | 07:01:58 INFO - TEST-INFO | 6378: exit 0 07:01:58 INFO - TEST-OK | v8_7 | took 40202ms 07:01:58 INFO - SUITE-END | took 1212s 07:01:58 INFO - Completed test suite (00:20:12) 07:01:58 INFO - Working with test: dromaeo_css 07:01:58 INFO - Generating results file: dromaeo_css 07:01:58 INFO - Working with test: kraken 07:01:58 INFO - Generating results file: kraken 07:01:58 INFO - javascript benchmark 07:01:58 INFO - Working with test: v8_7 07:01:58 INFO - Generating results file: v8_7 07:01:58 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:01:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:01:58 INFO - process_Request line: dromaeo_css 6908.22 graph.html#tests=[[72,1,43]] 07:01:58 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:01:58 INFO - process_Request line: kraken 1525.90 graph.html#tests=[[232,1,43]] 07:01:58 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:01:58 INFO - process_Request line: v8_7 21194.40 graph.html#tests=[[230,1,43]] 07:01:58 INFO - RETURN: dromaeo_css: 6908.22 07:01:58 INFO - RETURN: kraken: 1525.90 07:01:58 INFO - RETURN: v8_7: 21194.40 07:01:58 INFO - javascript benchmark 07:01:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3220.0661808075656, 3230.9822405942114, 3248.220427097497, 3288.9342213155737, 3305.834708264586, 5285.286486324345, 5433.782648694052, 5458.890822183554, 5480.835574932748, 5489.39616642169, 5391.595630327732, 5460.453954604538, 5466.207399927008, 5485.780568777244, 5489.094299440598, 4890.339804126433, 4948.950510494885, 5008.774605142759, 5041.294218809369, 5041.8487445376695, 5019.121653710605, 5099.209622508517, 5105.591552675795, 5122.897542049157, 5147.330846989886, 4879.341288926021, 4925.21196608541, 4973.204287314013, 5008.173651347523, 5084.898302033957, 5039.09296326661, 5047.394312682465, 5051.090803655341, 5054.812119151997, 5059.16523773577, 5016.724080175589, 5030.119729047402, 5049.949500504985, 5055.266986286968, 5069.569086627641, 5073.746312684351, 5174.922376164361, 5192.428832828386, 5277.577793776489, 5365.651232669903, 5859.501942334907, 5867.3839246879315, 5885.882282354329, 5900.468957793776, 5910.438508341744, 5945.464908158287, 5946.316173640043, 5969.522438204933, 5982.760689572412, 5997.460228579405, 5407.513323800877, 5486.862828429281, 5499.862503437406, 5588.608797384225, 5591.301087364039, 6053.061775424728, 6071.757129714851, 6081.8479538011015, 6114.966544785233, 6134.018557030854, 5853.619514731528, 5855.414458554111, 5857.736401861926, 5864.853378665567, 5868.471837534557, 5764.394738552475, 5832.416758324219, 5894.6757928314355, 5944.0, 6020.759169633253, 5834.15404766315, 5847.239858818411, 5851.502622277154, 5855.092460668603, 5858.619189752652, 5843.211166492554, 5844.766209351578, 5850.297964244318, 5862.472377486047, 5869.383714709894, 4418.0, 4481.574250446268, 4502.954970450319, 4516.683832131785, 4561.452625684939, 4036.737612055207, 4049.838006479708, 4058.817353219053, 4094.447249621263, 4103.753774773523, 5414.377346605112, 5504.91742623861, 5568.7215639217875, 5598.4961353477565, 5598.692071936001, 5767.192593036978, 5809.24479817621, 5809.7095145242565, 5892.175095486636, 5902.852428689317, 5558.277423934863, 5576.275084239023, 5579.609427340129, 5582.413846546055, 5610.775568977195, 4955.752212389366, 4976.651634385631, 4982.227754698028, 4997.825076122391, 5046.747662616928, 5777.88444231113, 5811.622244554091, 5966.671833049224, 6090.969545152246, 6091.5735898487565, 5915.201447804491, 5943.138244954371, 5969.582129250911, 5971.373005834324, 5983.581149319506, 6008.339082700812, 6056.545759068, 6058.636481811105, 6069.666168360783, 6071.028635418312, 5643.7742490299925, 5756.107803290497, 5835.037218859011, 5839.036558967723, 5994.310654274815, 5941.7623295067715, 5943.702814859326, 5978.97010514962, 5983.37174596661, 5997.70011499432, 5792.768289268382, 5814.069748840166, 5823.7379317929945, 5836.824895253149, 5854.853628659147, 5591.916121258266, 5672.546196304368, 5708.885822283614, 5781.68200748946, 5786.016377215799, 5634.718264086861, 5668.348139963792, 5693.430656934273, 5703.828885133453, 5707.600467967369, 5814.215080964185, 5837.883242335214, 5866.6480011199465, 5875.089361149029, 5879.588428809942, 5513.200585914939, 5601.6358936668985, 5614.6631202128, 5616.859578510406, 5729.4843464088435], "unit": "score", "name": "dojo.html", "value": 5425.449962777333}, {"lowerIsBetter": false, "replicates": [571.9360915097748, 609.1106983803646, 612.8559788449713, 614.7940439952619, 616.0574321288427, 32394.352112957728, 32407.837960810222, 32450.350992980126, 32599.51100733485, 32674.836625816868, 39803.40294895579, 40067.79966100173, 40109.39835902456, 40353.0, 40371.39442908351, 8652.394332396734, 8735.912640873605, 8811.471311721285, 8823.77940551485, 8872.37893347466, 8466.44968077076, 8619.267362274215, 8620.224179823814, 8622.827543449128, 8630.697925572606, 8606.827863442728, 8632.784180395509, 8740.650373985032, 8752.081031491698, 8753.693620723276, 8641.52471614064, 8647.308215342757, 8685.261752751023, 8688.131186881325, 8710.085441028696, 8621.267192288664, 8689.26141277992, 8710.433821801562, 8718.651253949834, 8728.083551227093, 37343.25313493715, 37688.81155594232, 37989.81005094985, 38049.42925856114, 38088.0, 2920.6057182280333, 2976.0922918509846, 3008.0, 3222.452183128874, 3228.951565726516, 28276.0, 28449.857750711322, 28463.57304640432, 28502.3287357009, 28728.569071463946, 3754.2303827715255, 3830.942535861964, 3869.9226015479535, 3881.8253178606747, 3905.7461265017682, 252176.0, 255692.0, 256046.0, 256501.0, 257153.0, 40875.0, 53298.0, 53656.73171634117, 53672.46327536675, 53709.1943620846, 40175.19649606991, 40176.39735403971, 40200.79899600542, 40283.59716402857, 40487.392689109685, 13257.66855828612, 13417.127886687334, 13473.056886017885, 13485.797713034312, 13492.460301587827, 9837.360571562825, 9865.75335616601, 9868.901310986941, 9987.850182247272, 9992.150667193224, 11972.940135299268, 12013.939930300467, 12240.693982650506, 12247.510099595916, 12301.69245768845, 5724.8282551523525, 5858.707064646751, 5891.116332550152, 5893.410658934158, 5941.376155503696, 875.4353442029856, 883.2271762208068, 1012.6759436980243, 1127.701159192798, 1141.7374003978964, 25287.36781580475, 25356.366090847507, 25502.362440939123, 25535.61696574553, 25607.87196064045, 981.5681100315838, 1007.9546420410952, 1060.5121644043827, 1079.3200283821143, 1111.8499002634703, 14589.124652520883, 15227.695446091016, 15935.123568203628, 16594.75107873383, 16622.75065874013, 356530.0, 361233.0, 361697.0, 362106.0, 364195.0, 51383.74308128435, 51520.74239628778, 51534.74232628888, 51865.0, 51889.0, 1328.9667758305927, 1331.8668133186604, 1334.312828893121, 1347.9730405392033, 1352.0873410448105, 27743.44513109767, 28596.0, 28838.711612884443, 29048.709512905447, 29087.7091229085, 43490.782546087066, 44018.89952751207, 44225.33661995137, 44226.55773442225, 44436.11127777362, 290516.0, 290554.0, 292027.0, 292336.0, 292884.0, 30770.230744230677, 31539.52690709595, 43197.568024320615, 43828.34257486204, 43852.0, 40764.79617601893, 40946.79526602348, 41682.0, 41982.16035679208, 42021.0, 34997.300053999286, 35282.0, 35516.28967420585, 35907.0, 36130.8193459031, 34845.78039768596, 35169.64830351664, 35238.29523409569, 35506.644933550335, 35536.0, 35332.0, 35371.64628353684, 35578.28843423169, 37116.81441592775, 37651.623483764815, 25715.871420642776, 27660.170194894185, 28534.42931141407, 36106.27787444289, 37239.6276037247, 24169.395765106012, 24346.147884823946, 24510.75489245156, 24600.384990375383, 24779.50440991206], "unit": "score", "name": "ext.html", "value": 17479.228721470823}, {"lowerIsBetter": false, "replicates": [353.69582159342974, 355.04138825172026, 355.8771925464603, 360.96751292383686, 363.34960420846676, 16647.084410357427, 16691.165441727924, 17414.477565673034, 17803.554911127198, 18192.181351839165, 10819.188560857947, 11809.409529523511, 16126.113063781488, 16137.515874523782, 16206.0, 4844.467108618058, 5422.915416916613, 5448.210009548613, 5448.945510544903, 5467.589930755209, 5431.23962645228, 5431.429699881495, 5452.182172674091, 5452.291202143716, 5470.124780035195, 4960.97519512402, 4964.702117872939, 5026.748662566875, 5092.9745351273195, 5203.895922081556, 5145.742712864342, 5160.896782064376, 5179.119549676545, 5206.140986737203, 5227.555657769094, 4987.700737955698, 5257.5005374489365, 5284.841454756325, 5290.867728306785, 5294.205869119624, 11758.588969323735, 12033.338166400845, 12890.742185156245, 18126.728099078526, 18127.909360453246, 1893.6496748101645, 1996.910139043732, 2024.3522072936519, 2027.858049936505, 2314.0396735354807, 9464.810703785955, 9529.857052144223, 9561.856572151424, 11396.772064558663, 13360.93319533396, 1769.8938063716218, 1812.4109664359005, 1823.7811462624438, 1853.4717605482372, 1897.0514742628686, 60517.0, 61512.38487615111, 64002.0, 64571.35428645747, 64784.67607661932, 10455.790884182274, 10488.68533943983, 10503.422311772925, 10506.159507239403, 10592.947035264775, 13525.32373381327, 13533.323333833268, 13591.592252232449, 13612.0, 13678.0, 6459.0, 6525.934740652628, 6555.3772391622715, 6582.76960306387, 6655.933440665532, 5902.055671092605, 5975.850603734942, 5985.25184351956, 5993.520518358521, 6032.969835150796, 4519.0961807638605, 4524.683272170916, 4548.977255113769, 4594.47163576193, 4608.792604332813, 1814.97277540837, 1851.3705340184401, 1873.6159087387052, 1879.6804543227684, 1886.566089799354, 764.6482617995673, 862.9870551941726, 881.5856547422701, 958.7746879483316, 959.1271942532262, 15713.68572628541, 15769.605759855865, 16526.66946661084, 16848.74726879098, 16922.32310707558, 904.6064961741663, 906.1120102299651, 907.2288554728428, 942.189716843514, 962.8603852441357, 9220.5850736717, 9562.95218523903, 9626.133647971716, 9805.0, 10248.692539223835, 472260.0, 490459.0, 491359.0, 494938.0, 512446.0, 84414.12959597769, 84474.15525844786, 84516.0, 85791.5710421444, 86811.0, 1140.4753813245834, 1141.4635121492886, 1169.1465230381698, 1197.0902114393125, 1208.546794951893, 14716.55850324492, 15375.385584513466, 15723.842761572696, 16428.17859107064, 16451.177441128137, 32266.83866580652, 32855.0, 33208.0, 33221.17283549428, 33283.167920802174, 43255.351169733105, 43722.34416483692, 43731.0, 45115.54884451113, 46473.76763116163, 9672.75818104553, 9680.080392362714, 9689.12797848197, 9706.369086009387, 9732.562034708597, 11340.376279304717, 11406.48670809799, 17423.738643920096, 18251.908740456212, 18495.352662656744, 14202.218877961397, 14662.63343416423, 14784.0, 15087.924560377129, 15183.544493665207, 14175.0, 14205.28973551339, 14485.203313817841, 14555.854441455449, 14631.780523291945, 14028.87768978459, 14311.141331519726, 14607.707845843237, 14728.852711472748, 14822.62943426423, 8872.290216782512, 8961.417507861968, 9133.908660913306, 9360.765980850534, 9392.95303523478, 9912.454814985245, 10031.29780915329, 13573.864261357656, 13852.307384630929, 14242.430302788187], "unit": "score", "name": "jquery.html", "value": 8617.108997498743}, {"lowerIsBetter": false, "replicates": [1447.8045463862381, 1458.161557104665, 1588.1900230882247, 1672.0803558043076, 1758.6306875556133, 6738.764143254987, 6813.591184528919, 7531.284527969848, 7948.284654381105, 8103.91896081039, 7290.854182916351, 7420.369268612175, 7477.43919206059, 7484.588347640877, 7541.0, 2217.833662475317, 2263.0608297556496, 2264.52444986553, 2266.5013696986634, 2268.2174649745893, 2276.3398614401804, 2284.2804516577226, 2315.4327189838514, 2348.365941195876, 2348.9060437582475, 2290.713660792401, 2298.161171172518, 2321.3500219938446, 2323.4075310795724, 2360.291912426274, 2228.342638921522, 2233.687283780272, 2285.48576570272, 2286.7713228677167, 2287.325239054483, 2310.7111611048617, 2344.7069116360453, 2348.835581509295, 2350.494643651623, 2354.482013956944, 7705.961470192613, 7733.381329493684, 7748.535087894745, 7765.068191816961, 7811.296983271533, 4661.813527458898, 4697.3893393858925, 4733.668643194977, 4735.881602959919, 4754.1917873961165, 3043.3761078978755, 3086.166734981565, 3161.826099564546, 3184.3472088222093, 3211.8394080295893, 951.1629765806047, 953.427943234061, 1785.3037315446986, 1843.8340549350623, 1847.6027654054442, 10290.7427314317, 10347.63783267582, 10359.482025898675, 10417.791644167075, 10433.373997560095, 4103.97948010258, 4180.456540649696, 4210.200061988213, 4224.852130175429, 4230.725002874803, 8498.150184981576, 8518.233358997595, 8518.957405212934, 8540.914590854136, 8543.871841922377, 4700.153972285021, 4708.788104535304, 4722.598579120813, 4729.929051064237, 4735.479097299294, 4180.602842729936, 4306.870793876189, 4326.113146804961, 4359.716618419792, 4390.0, 3510.736694747904, 3517.683408493248, 3539.5221645077586, 3549.0594992327055, 3554.0, 1025.5436330832856, 1030.2891005206384, 1031.1132426113536, 1076.5101878645198, 1080.6595922284612, 1050.7740835720356, 1052.4211683574003, 1207.1911819081236, 1268.5623459906317, 1271.2499625220978, 7259.927400726031, 7326.3406293433845, 7346.191918888918, 7361.705531778776, 7406.518576292524, 468.33262600793734, 471.8725943995102, 493.1050143988649, 496.85839535732146, 500.31207090250905, 5505.532029777513, 5554.888902221933, 5584.52531534816, 5584.86037849057, 5594.832155035356, 9267.72196834096, 9417.811643767087, 9624.615015399446, 9706.223502119814, 9735.026497350209, 9413.811723765486, 9469.621215151454, 9471.431714097176, 9502.382345147544, 9535.427874327563, 7140.07179066718, 7238.855222895512, 7279.490435669452, 7291.161516425679, 7316.975623412726, 6569.408753212234, 6615.900761488678, 6618.305077966937, 6622.271550129578, 6642.90035649456, 8354.958479718833, 8395.118512556339, 8474.406791524534, 8561.315094792526, 8671.913280867111, 8604.96740391157, 8683.435576687496, 8777.736667899973, 8861.158189971942, 8908.955455222682, 6496.610203387811, 6737.25890152073, 6747.224069231905, 7050.612216328152, 7059.82350441243, 7432.405407567489, 7448.143463501767, 7459.776206713807, 7467.738629147953, 7472.551646901204, 6969.163700355787, 7165.498415110892, 7171.103612048494, 7217.7112915484895, 7321.194668586558, 7015.158181018311, 7046.788596342118, 7094.574325540484, 7181.820454488679, 7206.774848275911, 6617.305182955721, 6835.555688880406, 6895.241523432318, 6911.930880691129, 6915.308469153246, 6048.455638992512, 6107.541934354852, 6137.355577664281, 6171.537134714825, 6183.81448556544, 5968.045112781934, 5999.460048595647, 6004.639721616717, 6022.8795424090395, 6169.907451388322], "unit": "score", "name": "mootools.html", "value": 4387.14964540357}, {"lowerIsBetter": false, "replicates": [309.6887627933926, 310.22134442549196, 324.1943769732215, 326.7957526545909, 332.1049770867512, 6212.037134244188, 6288.622682639039, 6327.841803954898, 6356.300806911236, 6377.585456945295, 6143.354947730491, 6306.0, 6312.779052733155, 6317.684115794214, 6324.2727086385075, 4764.047190561884, 4765.189917713997, 4766.3088852116425, 4772.713637181763, 4782.067496838118, 4754.690945088558, 4756.215224487955, 4773.880652983686, 4777.283407488887, 4780.139574876521, 4635.188841952661, 4739.336492890998, 4741.9525804742025, 4744.122337367581, 4758.857234282977, 4712.410948631421, 4716.419999300221, 4737.076270127326, 4746.335513028179, 4763.523647635244, 4149.190907772985, 4155.792210389468, 4155.958440415618, 4164.604362585549, 4166.416701661769, 5889.617174883619, 5905.793297234576, 5929.555283353722, 5930.258717660293, 5939.346671866091, 5372.597055220874, 5467.726613669301, 5492.450754924515, 5510.256115424407, 5510.311211098613, 6605.306442823482, 6621.304762999912, 6623.635700036496, 6626.304238055031, 6633.678212625542, 4543.25036369002, 4554.612857907082, 4560.201964656205, 4560.771961401917, 4562.794674239667, 6815.0, 6926.480513961473, 6966.79099627007, 6966.79099627012, 6982.755603553851, 4702.952970470252, 4707.764611769398, 4709.152352576569, 4710.88222794426, 4722.763861806896, 4764.523547645277, 4768.523147685204, 4772.284157376422, 4774.546418090275, 4775.0, 5494.0, 5501.807436739695, 5502.202180683858, 5511.145772405283, 5520.861978450571, 6555.770548030891, 6687.264400915896, 6700.329967003358, 6721.8655626887185, 6726.1256036715895, 1594.6810637872472, 1624.9025058496527, 1652.132630369066, 1657.0471978612345, 1657.1382880902104, 1074.3607553505808, 1078.4823284823328, 1079.9730006749894, 1097.6542389147394, 1102.2725001498973, 6326.240851097898, 6355.841103972345, 6379.138816259746, 6385.616862988236, 6395.2645445773405, 6801.18385793708, 6801.659917004229, 6855.828604284933, 6862.897056544156, 6863.965680171567, 6151.292601350902, 6341.746330146835, 6342.651154186472, 6345.49236061114, 6346.397092276226, 3697.3159965406485, 3728.366177749789, 3739.0652336915773, 3743.288775132716, 3746.587875333711, 6983.406410455066, 7005.92994070063, 7021.262767409451, 7025.473089518307, 7029.613371264527, 6885.449164066863, 6966.616836073963, 7035.964820175969, 7040.577565345993, 7042.964785176144, 7084.645767711697, 7107.857842843217, 7146.071010768671, 7153.213146553875, 7172.354488096096, 6928.826779330557, 6940.444764418733, 6967.233604303624, 6991.300869912968, 6993.0908981832035, 6675.465962723068, 6836.658167091526, 6841.315868413119, 6878.415334696407, 6879.621620810904, 7096.254893236136, 7145.249748776304, 7179.425645948207, 7184.640767961686, 7197.424206063607, 4640.048789997974, 4675.205215113507, 4681.063787242633, 4681.6722829401615, 4694.43666759991, 6844.657767111724, 6983.127109111361, 7019.333163349474, 7022.2275549688475, 7037.648117593997, 6790.524663273721, 6804.591724496348, 6812.318768123148, 6833.487488438486, 6835.248122706399, 6746.190457145174, 6769.221539522821, 6786.0, 6792.981052842113, 6817.93182068173, 6462.935370646233, 6568.21181458209, 6589.967050164719, 6604.768833090819, 6609.339066093352, 6739.292374300824, 6809.659517024228, 6812.829679258059, 6815.216250131299, 6826.283240259701, 6533.660599577171, 6617.07360969455, 6627.867442651216, 6652.966735166293, 6656.434203092597], "unit": "score", "name": "prototype.html", "value": 5000.456211991374}, {"lowerIsBetter": false, "replicates": [785.3403141361257, 798.7563793043123, 816.1838161838161, 821.9958900205498, 829.3903980574273, 13751.312434378278, 13958.092723972935, 14120.57638270851, 14125.505607303747, 14151.15093094415, 12879.613611591643, 12914.806277905838, 13031.609051728463, 13039.0, 13041.869581304185, 790.1505881177743, 801.8556659801234, 802.4984384759525, 821.5686764448683, 834.4242472693852, 607.3531688751488, 610.3926593039931, 611.7583554495972, 612.20107759374, 612.9387061293858, 855.0295414704293, 857.2756021162139, 862.180928118287, 863.3309185381316, 867.4101610904582, 848.1603212819296, 851.8466675998318, 852.1691350932853, 853.9658413663446, 857.7298151082421, 626.8088233088906, 629.5687454093915, 631.737828801047, 632.8955722305814, 633.5881676910045, 13895.722085558233, 13951.162930224118, 14015.789763153562, 14054.0, 14065.0, 11747.47136378865, 11936.104792140537, 12091.758164836741, 12594.496220151183, 13099.607011789662, 9331.242634280787, 9811.215102791759, 9829.901700983042, 10079.848802267972, 10446.26876118672, 3480.4083305837817, 3586.497890295361, 3602.1174812170925, 3617.113807117273, 3637.563492380905, 46158.0, 46287.07425851498, 46419.767901160616, 46423.30365044527, 46444.07111857744, 8368.121347258571, 8516.531590762568, 8644.135586441305, 8711.520866352412, 8827.205551500396, 16432.096234707205, 16595.336186552402, 16708.49874503767, 16710.58223544421, 16738.497845064667, 7276.854462910712, 7373.963130184315, 7395.852082958419, 7521.5111017783665, 7554.320111190019, 3963.2271707016853, 3980.6218409251073, 4007.6793856491413, 4025.9396109057802, 4087.080406908481, 2937.662168850567, 2958.8520573971214, 2979.1956171833485, 2985.0746268656785, 2986.8357240351556, 528.0890463949656, 550.9338879334506, 559.194759546252, 559.7928766356474, 562.7777028073888, 450.4279564952492, 519.4338171393124, 565.2284631478003, 591.4233622218303, 621.6767281013847, 8194.303484203909, 8220.58897055145, 8269.917300827035, 8341.165883411732, 8573.356998225157, 490.4335492506161, 547.917812328154, 606.4996377988177, 618.9292523933531, 626.2891618013497, 3698.0, 3909.843606255718, 3917.941230881539, 3948.8420463181724, 4038.3134867072667, 60276.39723602708, 60623.393766061774, 60912.39087609156, 61068.69465652643, 61146.38853611407, 50812.23781643278, 52113.73943130336, 52196.0, 52506.0, 53259.20111198335, 47191.0, 47397.52602474, 47729.28406073912, 48226.27660585094, 48571.271430928566, 7943.44395892282, 8162.6734930602115, 8200.507969521848, 8204.138565450541, 8469.153084691729, 36396.0, 36457.63542364648, 37314.44028339631, 37536.436953445176, 37801.81099094487, 45943.0, 46182.7690861557, 46266.76866615645, 46687.29969050399, 47551.0, 9945.502724863873, 10539.947300263757, 10853.620123295646, 10891.618793342195, 10930.180236482454, 11070.944645276722, 11353.545858165911, 11538.769224615293, 11571.074314055024, 11646.650600481998, 10412.895871041193, 10678.0, 10739.570417183537, 10739.624113156002, 10754.13966882632, 10032.64885728996, 10546.209034322303, 10884.292520986111, 10984.560617575207, 11014.39420831862, 9251.398659087137, 9849.704508864745, 10054.396736195851, 10419.94790026045, 10528.263021588415, 8778.166074222938, 8930.285577153682, 8957.193852553302, 9162.954185229031, 9225.815483690154, 7683.899879768174, 7711.575863327346, 8089.514629122272, 8162.347012239125, 8249.917500825155], "unit": "score", "name": "yui.html", "value": 6062.463549217112}], "name": "dromaeo_css", "value": 6908.218511819709}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 110.0, 111.0, 110.0, 124.0, 112.0, 112.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [159.0, 134.0, 150.0, 163.0, 131.0, 155.0, 150.0, 129.0, 171.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 168.0, 164.0, 164.0, 167.0, 164.0, 173.0, 167.0, 162.0], "unit": "score", "name": "audio-dft", "value": 165.7}, {"lowerIsBetter": true, "replicates": [73.0, 83.0, 73.0, 73.0, 72.0, 135.0, 72.0, 78.0, 73.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 146.0, 93.0, 93.0, 96.0, 146.0, 94.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 111.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 148.0, 145.0, 148.0, 147.0, 147.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [63.0, 61.0, 60.0, 62.0, 67.0, 61.0, 60.0, 60.0, 64.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 61.6}, {"lowerIsBetter": true, "replicates": [65.0, 70.0, 65.0, 66.0, 67.0, 66.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [91.0, 83.0, 92.0, 87.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [129.0, 122.0, 123.0, 125.0, 119.0, 123.0, 122.0, 119.0, 120.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.2}, {"lowerIsBetter": true, "replicates": [153.0, 153.0, 159.0, 155.0, 157.0, 141.0, 155.0, 155.0, 152.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.2}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 74.0, 68.0, 68.0, 70.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1525.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.03021749958492], "unit": "score", "name": "Richards", "value": 212.62394600000007}, {"lowerIsBetter": false, "replicates": [195.8096729978461], "unit": "score", "name": "DeltaBlue", "value": 337.6646259999999}, {"lowerIsBetter": false, "replicates": [284.8191398461977], "unit": "score", "name": "Encrypt", "value": 934.5614910000002}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [721.5007215007215], "unit": "score", "name": "Earley", "value": 923.7177179999996}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [25375.0], "unit": "score", "name": "RegExp", "value": 35.90088669950742}, {"lowerIsBetter": false, "replicates": [617.6652254478073], "unit": "score", "name": "Splay", "value": 131.93392900000003}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21194.396822294435}]} 07:01:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21194.40"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1525.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6908.22"}}} 07:01:58 INFO - Return code: 0 07:01:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:01:58 INFO - # TBPL SUCCESS # 07:01:58 INFO - Running post-action listener: _resource_record_post_action 07:01:58 INFO - Running post-run listener: _resource_record_post_run 07:01:59 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556183552; Read time: 8; Write time: 438464 07:01:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234962944; Read time: 0; Write time: 244784 07:01:59 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320946176; Read time: 8; Write time: 193656 07:01:59 INFO - Running post-run listener: _upload_blobber_files 07:01:59 INFO - Blob upload gear active. 07:01:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:01:59 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 07:01:59 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:01:59 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:02:00 INFO - (blobuploader) - INFO - Open directory for files ... 07:02:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:02:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:02:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:01 INFO - (blobuploader) - INFO - Done attempting. 07:02:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:02:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:02:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:02 INFO - (blobuploader) - INFO - Done attempting. 07:02:02 INFO - (blobuploader) - INFO - Iteration through files over. 07:02:02 INFO - Return code: 0 07:02:02 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:02:02 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:02:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6198e7f9d8119d3d55d0cf34083374f517d5dc883b3cc5444df7dea63a4832a13982b36db7773179e96e59984f82ea95f8d2535b33200abe8e59aa4d4fbd3ec1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b18d1f1ae9165ce7449c43a2870b504f2eed8b2e176c0efcb4e76d9b0fefb3ceb53e4b80502cc4ce48d3ebd1f80e61a90563dcbb8b4e257d2038c330f696b411"} 07:02:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:02:02 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:02:02 INFO - Contents: 07:02:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6198e7f9d8119d3d55d0cf34083374f517d5dc883b3cc5444df7dea63a4832a13982b36db7773179e96e59984f82ea95f8d2535b33200abe8e59aa4d4fbd3ec1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b18d1f1ae9165ce7449c43a2870b504f2eed8b2e176c0efcb4e76d9b0fefb3ceb53e4b80502cc4ce48d3ebd1f80e61a90563dcbb8b4e257d2038c330f696b411"} 07:02:02 INFO - Copying logs to upload dir... 07:02:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1281.279714 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-12-21 07:02:02.748214) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 07:02:02.751405) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6198e7f9d8119d3d55d0cf34083374f517d5dc883b3cc5444df7dea63a4832a13982b36db7773179e96e59984f82ea95f8d2535b33200abe8e59aa4d4fbd3ec1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b18d1f1ae9165ce7449c43a2870b504f2eed8b2e176c0efcb4e76d9b0fefb3ceb53e4b80502cc4ce48d3ebd1f80e61a90563dcbb8b4e257d2038c330f696b411"} build_url:https://queue.taskcluster.net/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011210 build_url: 'https://queue.taskcluster.net/v1/task/oXgrGoEOTvOJbK-bPuf6ww/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6198e7f9d8119d3d55d0cf34083374f517d5dc883b3cc5444df7dea63a4832a13982b36db7773179e96e59984f82ea95f8d2535b33200abe8e59aa4d4fbd3ec1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b18d1f1ae9165ce7449c43a2870b504f2eed8b2e176c0efcb4e76d9b0fefb3ceb53e4b80502cc4ce48d3ebd1f80e61a90563dcbb8b4e257d2038c330f696b411"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 07:02:02.776892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 07:02:02.777224) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450707123.536358-242967245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003186 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 07:02:02.856780) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 07:02:02.857109) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 07:02:02.857390) ========= ========= Total master_lag: 0.25 =========