builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1452956175.53 results: success (0) buildid: 20160116043010 builduid: 90ddbab9edb94db7b5c75dcac01c970c revision: 5f99e2208a3b5ef44fc80681caef563f6ec80b77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.529789) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.530284) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.530575) ========= 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=1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006363 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.574693) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.575538) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.655483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.655776) ========= 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=1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.710702) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.710978) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.711323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.711606) ========= 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=1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-16 06:56:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-01-16 06:56:16 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185754 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.911008) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.911310) ========= 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=1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017519 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.962424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:15.962784) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5f99e2208a3b5ef44fc80681caef563f6ec80b77 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5f99e2208a3b5ef44fc80681caef563f6ec80b77 --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=1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-16 06:56:16,282 truncating revision to first 12 chars 2016-01-16 06:56:16,282 Setting DEBUG logging. 2016-01-16 06:56:16,282 attempt 1/10 2016-01-16 06:56:16,282 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5f99e2208a3b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-16 06:56:16,664 unpacking tar archive at: mozilla-inbound-5f99e2208a3b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678298 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:16.659085) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:16.659422) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004707 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:16.713612) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:16.713972) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:16.725042) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:16.725321) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-16 06:56:16.726005) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-16 06:56:16.726309) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:56:17 INFO - MultiFileLogger online at 20160116 06:56:17 in /builds/slave/test-pgo 06:56:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 06:56:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:56:17 INFO - {'append_to_log': False, 06:56:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:56:17 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:56:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:56:17 INFO - 'branch': 'Mozilla-Inbound', 06:56:17 INFO - 'buildbot_json_path': 'buildprops.json', 06:56:17 INFO - 'config_files': ('talos/linux_config.py',), 06:56:17 INFO - 'default_actions': ('clobber', 06:56:17 INFO - 'read-buildbot-config', 06:56:17 INFO - 'download-and-extract', 06:56:17 INFO - 'populate-webroot', 06:56:17 INFO - 'create-virtualenv', 06:56:17 INFO - 'install', 06:56:17 INFO - 'run-tests'), 06:56:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:56:17 INFO - 'download_minidump_stackwalk': True, 06:56:17 INFO - 'download_symbols': 'ondemand', 06:56:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:56:17 INFO - 'tooltool.py': '/tools/tooltool.py', 06:56:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:56:17 INFO - '/tools/misc-python/virtualenv.py')}, 06:56:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:56:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:56:17 INFO - 'installer_path': 'installer.exe', 06:56:17 INFO - 'log_level': 'info', 06:56:17 INFO - 'log_name': 'talos', 06:56:17 INFO - 'log_to_console': True, 06:56:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:56:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:56:17 INFO - 'opt_config_files': (), 06:56:17 INFO - 'pip_index': False, 06:56:17 INFO - 'sps_profile': False, 06:56:17 INFO - 'sps_profile_interval': 0, 06:56:17 INFO - 'suite': 'dromaeojs', 06:56:17 INFO - 'system_bits': '32', 06:56:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:56:17 INFO - 'title': 'talos-linux64-ix-027', 06:56:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:56:17 INFO - 'use_talos_json': True, 06:56:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:56:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:56:17 INFO - 'work_dir': 'build'} 06:56:17 INFO - ##### 06:56:17 INFO - ##### Running clobber step. 06:56:17 INFO - ##### 06:56:17 INFO - Running pre-action listener: _resource_record_pre_action 06:56:17 INFO - Running main action method: clobber 06:56:17 INFO - rmtree: /builds/slave/test-pgo/build 06:56:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:56:17 INFO - Running post-action listener: _resource_record_post_action 06:56:17 INFO - ##### 06:56:17 INFO - ##### Running read-buildbot-config step. 06:56:17 INFO - ##### 06:56:17 INFO - Running pre-action listener: _resource_record_pre_action 06:56:17 INFO - Running main action method: read_buildbot_config 06:56:17 INFO - Using buildbot properties: 06:56:17 INFO - { 06:56:17 INFO - "project": "", 06:56:17 INFO - "product": "firefox", 06:56:17 INFO - "script_repo_revision": "production", 06:56:17 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 06:56:17 INFO - "repository": "", 06:56:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 06:56:17 INFO - "buildid": "20160116043010", 06:56:17 INFO - "pgo_build": "True", 06:56:17 INFO - "basedir": "/builds/slave/test-pgo", 06:56:17 INFO - "buildnumber": 613, 06:56:17 INFO - "slavename": "talos-linux64-ix-027", 06:56:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:56:17 INFO - "platform": "ubuntu64_hw", 06:56:17 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 06:56:17 INFO - "branch": "mozilla-inbound", 06:56:17 INFO - "repo_path": "integration/mozilla-inbound", 06:56:17 INFO - "revision": "5f99e2208a3b5ef44fc80681caef563f6ec80b77", 06:56:17 INFO - "stage_platform": "linux64-pgo", 06:56:17 INFO - "builduid": "90ddbab9edb94db7b5c75dcac01c970c", 06:56:17 INFO - "slavebuilddir": "test" 06:56:17 INFO - } 06:56:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:56:17 INFO - Running post-action listener: _resource_record_post_action 06:56:17 INFO - ##### 06:56:17 INFO - ##### Running download-and-extract step. 06:56:17 INFO - ##### 06:56:17 INFO - Running pre-action listener: _resource_record_pre_action 06:56:17 INFO - Running main action method: download_and_extract 06:56:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:17 INFO - https://queue.taskcluster.net/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:56:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/test_packages.json 06:56:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/test_packages.json 06:56:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:56:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:56:22 INFO - Downloaded 1448 bytes. 06:56:22 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:56:22 INFO - Using the following test package requirements: 06:56:22 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:56:22 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:56:22 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:56:22 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:22 INFO - u'jsshell-linux-x86_64.zip'], 06:56:22 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:56:22 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:56:22 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:56:22 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:56:22 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:56:22 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:56:22 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:56:22 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:56:22 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:56:22 INFO - https://queue.taskcluster.net/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:56:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:56:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:56:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/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:56:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/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:56:25 INFO - Downloaded 22484179 bytes. 06:56:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:56:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:56:26 INFO - Return code: 0 06:56:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:26 INFO - https://queue.taskcluster.net/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:56:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:56:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:56:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/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:56:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/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:56:30 INFO - Downloaded 22484179 bytes. 06:56:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:56:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:56:32 INFO - Return code: 0 06:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:32 INFO - https://queue.taskcluster.net/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/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:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/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:56:34 INFO - Downloaded 11132144 bytes. 06:56:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:56:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 06:56:34 INFO - Return code: 0 06:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:34 INFO - https://queue.taskcluster.net/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:56:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:56:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:56:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/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:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZdVPk13TZ-FQM9Uahx8cg/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:56:37 INFO - Downloaded 55927611 bytes. 06:56:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:56:37 INFO - mkdir: /builds/slave/test-pgo/properties 06:56:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:56:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:56:37 INFO - Contents: 06:56:37 INFO - build_url:https://queue.taskcluster.net/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:56:37 INFO - Running post-action listener: _resource_record_post_action 06:56:37 INFO - Running post-action listener: set_extra_try_arguments 06:56:37 INFO - ##### 06:56:37 INFO - ##### Running populate-webroot step. 06:56:37 INFO - ##### 06:56:37 INFO - Running pre-action listener: _resource_record_pre_action 06:56:37 INFO - Running main action method: populate_webroot 06:56:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:56:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:56:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:56:37 INFO - '--tppagecycles', 06:56:37 INFO - '7'], 06:56:37 INFO - 'tests': ['tsvgm']}}, 06:56:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:56:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:56:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:56:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:56:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:56:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:56:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:56:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:37 INFO - 'talos_options': ['--e10s'], 06:56:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:56:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:37 INFO - 'tests': ['damp', 'tps']}, 06:56:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:37 INFO - 'talos_options': ['--e10s'], 06:56:37 INFO - 'tests': ['damp', 'tps']}, 06:56:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:56:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:56:37 INFO - 'other': {'tests': ['a11yr', 06:56:37 INFO - 'ts_paint', 06:56:37 INFO - 'tpaint', 06:56:37 INFO - 'sessionrestore', 06:56:37 INFO - 'sessionrestore_no_auto_restore']}, 06:56:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:56:37 INFO - 'tests': ['a11yr', 06:56:37 INFO - 'ts_paint', 06:56:37 INFO - 'tpaint', 06:56:37 INFO - 'sessionrestore', 06:56:37 INFO - 'sessionrestore_no_auto_restore']}, 06:56:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:56:37 INFO - 'tests': ['a11yr', 06:56:37 INFO - 'ts_paint', 06:56:37 INFO - 'tpaint', 06:56:37 INFO - 'sessionrestore', 06:56:37 INFO - 'sessionrestore_no_auto_restore']}, 06:56:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:56:37 INFO - 'tests': ['a11yr', 06:56:37 INFO - 'ts_paint', 06:56:37 INFO - 'tpaint', 06:56:37 INFO - 'sessionrestore', 06:56:37 INFO - 'sessionrestore_no_auto_restore']}, 06:56:37 INFO - 'other_l64': {'tests': ['a11yr', 06:56:37 INFO - 'ts_paint', 06:56:37 INFO - 'tpaint', 06:56:37 INFO - 'sessionrestore', 06:56:37 INFO - 'sessionrestore_no_auto_restore']}, 06:56:37 INFO - 'other_nol64': {'tests': ['a11yr', 06:56:37 INFO - 'ts_paint', 06:56:37 INFO - 'tpaint', 06:56:37 INFO - 'sessionrestore', 06:56:37 INFO - 'sessionrestore_no_auto_restore']}, 06:56:37 INFO - 'svgr': {'tests': ['tsvgx', 06:56:37 INFO - 'tsvgr_opacity', 06:56:37 INFO - 'tart', 06:56:37 INFO - 'tscrollx', 06:56:37 INFO - 'cart']}, 06:56:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:56:37 INFO - 'tests': ['tsvgx', 06:56:37 INFO - 'tsvgr_opacity', 06:56:37 INFO - 'tart', 06:56:37 INFO - 'tscrollx', 06:56:37 INFO - 'cart']}, 06:56:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:37 INFO - 'tests': ['tp5o']}, 06:56:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:37 INFO - 'talos_options': ['--e10s'], 06:56:37 INFO - 'tests': ['tp5o']}, 06:56:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:37 INFO - 'talos_options': ['--xperf_path', 06:56:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:56:37 INFO - 'tests': ['tp5n']}, 06:56:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:37 INFO - 'talos_options': ['--e10s', 06:56:37 INFO - '--xperf_path', 06:56:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:56:37 INFO - 'tests': ['tp5n']}}, 06:56:37 INFO - 'talos.zip': {'path': '', 06:56:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:56:37 INFO - Running post-action listener: _resource_record_post_action 06:56:37 INFO - ##### 06:56:37 INFO - ##### Running create-virtualenv step. 06:56:37 INFO - ##### 06:56:37 INFO - Running pre-action listener: _resource_record_pre_action 06:56:37 INFO - Running main action method: create_virtualenv 06:56:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:56:37 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:56:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:56:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:56:37 INFO - Using real prefix '/usr' 06:56:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:56:37 INFO - Installing distribute.............................................................................................................................................................................................done. 06:56:39 INFO - Installing pip.................done. 06:56:39 INFO - Return code: 0 06:56:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8762ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b7f0>, '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 0x10e72d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7760>, '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': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', '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:56:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:56:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:56:39 INFO - Using env: {'DISPLAY': ':0', 06:56:39 INFO - 'HOME': '/home/cltbld', 06:56:39 INFO - 'LANG': 'en_US.UTF-8', 06:56:39 INFO - 'LANGUAGE': 'en_US:en', 06:56:39 INFO - 'LOGNAME': 'cltbld', 06:56:39 INFO - 'MAIL': '/var/mail/cltbld', 06:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:39 INFO - 'MOZ_NO_REMOTE': '1', 06:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:39 INFO - 'NO_EM_RESTART': '1', 06:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:39 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:39 INFO - 'SHELL': '/bin/bash', 06:56:39 INFO - 'SHLVL': '1', 06:56:39 INFO - 'TERM': 'linux', 06:56:39 INFO - 'TMOUT': '86400', 06:56:39 INFO - 'USER': 'cltbld', 06:56:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', 06:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:39 INFO - '_': '/tools/buildbot/bin/python'} 06:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:39 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:56:39 INFO - Cleaning up... 06:56:39 INFO - Return code: 0 06:56:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8762ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b7f0>, '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 0x10e72d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7760>, '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': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', '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:56:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:56:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:56:39 INFO - Using env: {'DISPLAY': ':0', 06:56:39 INFO - 'HOME': '/home/cltbld', 06:56:39 INFO - 'LANG': 'en_US.UTF-8', 06:56:39 INFO - 'LANGUAGE': 'en_US:en', 06:56:39 INFO - 'LOGNAME': 'cltbld', 06:56:39 INFO - 'MAIL': '/var/mail/cltbld', 06:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:39 INFO - 'MOZ_NO_REMOTE': '1', 06:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:39 INFO - 'NO_EM_RESTART': '1', 06:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:39 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:39 INFO - 'SHELL': '/bin/bash', 06:56:39 INFO - 'SHLVL': '1', 06:56:39 INFO - 'TERM': 'linux', 06:56:39 INFO - 'TMOUT': '86400', 06:56:39 INFO - 'USER': 'cltbld', 06:56:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', 06:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:39 INFO - '_': '/tools/buildbot/bin/python'} 06:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:40 INFO - Downloading/unpacking psutil>=0.7.1 06:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:41 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:56:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:56:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:56:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:56:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:56:41 INFO - Installing collected packages: psutil 06:56:41 INFO - Running setup.py install for psutil 06:56:41 INFO - building 'psutil._psutil_linux' extension 06:56:41 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:56:42 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:56:42 INFO - building 'psutil._psutil_posix' extension 06:56:42 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:56:42 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:56:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:56:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:56:42 INFO - Successfully installed psutil 06:56:42 INFO - Cleaning up... 06:56:42 INFO - Return code: 0 06:56:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8762ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b7f0>, '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 0x10e72d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7760>, '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': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', '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:56:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:56:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:56:42 INFO - Using env: {'DISPLAY': ':0', 06:56:42 INFO - 'HOME': '/home/cltbld', 06:56:42 INFO - 'LANG': 'en_US.UTF-8', 06:56:42 INFO - 'LANGUAGE': 'en_US:en', 06:56:42 INFO - 'LOGNAME': 'cltbld', 06:56:42 INFO - 'MAIL': '/var/mail/cltbld', 06:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:42 INFO - 'MOZ_NO_REMOTE': '1', 06:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:42 INFO - 'NO_EM_RESTART': '1', 06:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:42 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:42 INFO - 'SHELL': '/bin/bash', 06:56:42 INFO - 'SHLVL': '1', 06:56:42 INFO - 'TERM': 'linux', 06:56:42 INFO - 'TMOUT': '86400', 06:56:42 INFO - 'USER': 'cltbld', 06:56:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', 06:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:42 INFO - '_': '/tools/buildbot/bin/python'} 06:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:56:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:56:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:56:44 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:56:44 INFO - Installing collected packages: mozsystemmonitor 06:56:44 INFO - Running setup.py install for mozsystemmonitor 06:56:44 INFO - Successfully installed mozsystemmonitor 06:56:44 INFO - Cleaning up... 06:56:44 INFO - Return code: 0 06:56:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:56: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:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56: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:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8762ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b7f0>, '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 0x10e72d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7760>, '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': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', '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:56:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:56:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:56:44 INFO - Using env: {'DISPLAY': ':0', 06:56:44 INFO - 'HOME': '/home/cltbld', 06:56:44 INFO - 'LANG': 'en_US.UTF-8', 06:56:44 INFO - 'LANGUAGE': 'en_US:en', 06:56:44 INFO - 'LOGNAME': 'cltbld', 06:56:44 INFO - 'MAIL': '/var/mail/cltbld', 06:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:44 INFO - 'MOZ_NO_REMOTE': '1', 06:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:44 INFO - 'NO_EM_RESTART': '1', 06:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:44 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:44 INFO - 'SHELL': '/bin/bash', 06:56:44 INFO - 'SHLVL': '1', 06:56:44 INFO - 'TERM': 'linux', 06:56:44 INFO - 'TMOUT': '86400', 06:56:44 INFO - 'USER': 'cltbld', 06:56:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', 06:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:44 INFO - '_': '/tools/buildbot/bin/python'} 06:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:44 INFO - Downloading/unpacking blobuploader==1.2.4 06:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:46 INFO - Downloading blobuploader-1.2.4.tar.gz 06:56:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:56:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:56:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:56:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:56:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:47 INFO - Downloading docopt-0.6.1.tar.gz 06:56:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:56:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:56:47 INFO - Installing collected packages: blobuploader, requests, docopt 06:56:47 INFO - Running setup.py install for blobuploader 06:56:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:56:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:56:47 INFO - Running setup.py install for requests 06:56:48 INFO - Running setup.py install for docopt 06:56:48 INFO - Successfully installed blobuploader requests docopt 06:56:48 INFO - Cleaning up... 06:56:48 INFO - Return code: 0 06:56:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:56:48 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:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:48 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:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:48 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 0x7f8762ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b7f0>, '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 0x10e72d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7760>, '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': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', '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:56:48 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:56:48 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:56:48 INFO - Using env: {'DISPLAY': ':0', 06:56:48 INFO - 'HOME': '/home/cltbld', 06:56:48 INFO - 'LANG': 'en_US.UTF-8', 06:56:48 INFO - 'LANGUAGE': 'en_US:en', 06:56:48 INFO - 'LOGNAME': 'cltbld', 06:56:48 INFO - 'MAIL': '/var/mail/cltbld', 06:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:48 INFO - 'MOZ_NO_REMOTE': '1', 06:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:48 INFO - 'NO_EM_RESTART': '1', 06:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:48 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:48 INFO - 'SHELL': '/bin/bash', 06:56:48 INFO - 'SHLVL': '1', 06:56:48 INFO - 'TERM': 'linux', 06:56:48 INFO - 'TMOUT': '86400', 06:56:48 INFO - 'USER': 'cltbld', 06:56:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', 06:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:48 INFO - '_': '/tools/buildbot/bin/python'} 06:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:56:48 INFO - Running setup.py (path:/tmp/pip-c0cFxb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:56:48 INFO - Running setup.py (path:/tmp/pip-J8D9Ah-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:56:48 INFO - Running setup.py (path:/tmp/pip-PjNUO5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:56:48 INFO - Running setup.py (path:/tmp/pip-aXGO0f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:56:48 INFO - Running setup.py (path:/tmp/pip-Sk6_Sd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:56:49 INFO - Running setup.py (path:/tmp/pip-aqpX9C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:56:49 INFO - Running setup.py (path:/tmp/pip-oDzjs1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:56:49 INFO - Running setup.py (path:/tmp/pip-jKhHJr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:56:49 INFO - Running setup.py (path:/tmp/pip-DAW1tl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:56:49 INFO - Running setup.py (path:/tmp/pip-S57Zpf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:56:49 INFO - Running setup.py (path:/tmp/pip-U02O2x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:56:49 INFO - Running setup.py (path:/tmp/pip-d3D9eA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:56:49 INFO - Running setup.py (path:/tmp/pip-hE2Otz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:56:49 INFO - Running setup.py (path:/tmp/pip-SmaYK1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:56:49 INFO - Running setup.py (path:/tmp/pip-Ei7O4w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:56:49 INFO - Running setup.py (path:/tmp/pip-ywdEpd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:56:49 INFO - Running setup.py (path:/tmp/pip-LIy16e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:56:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:56:49 INFO - Running setup.py install for manifestparser 06:56:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:56:49 INFO - Running setup.py install for mozcrash 06:56:50 INFO - Running setup.py install for mozdebug 06:56:50 INFO - Running setup.py install for mozdevice 06:56:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:56:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:56:50 INFO - Running setup.py install for mozfile 06:56:50 INFO - Running setup.py install for mozhttpd 06:56:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:56:50 INFO - Running setup.py install for mozinfo 06:56:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:56:50 INFO - Running setup.py install for mozInstall 06:56:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:56:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:56:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:56:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:56:50 INFO - Running setup.py install for mozleak 06:56:50 INFO - Running setup.py install for mozlog 06:56:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:56:50 INFO - Running setup.py install for moznetwork 06:56:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:56:50 INFO - Running setup.py install for mozprocess 06:56:51 INFO - Running setup.py install for mozprofile 06:56:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:56:51 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:56:51 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:56:51 INFO - Running setup.py install for mozrunner 06:56:51 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:56:51 INFO - Running setup.py install for mozscreenshot 06:56:51 INFO - Running setup.py install for moztest 06:56:51 INFO - Running setup.py install for mozversion 06:56:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:56:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:56:51 INFO - Cleaning up... 06:56:51 INFO - Return code: 0 06:56:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:51 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 0x7f8762ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b7f0>, '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 0x10e72d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7760>, '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': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', '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:56:51 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:56:51 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:56:51 INFO - Using env: {'DISPLAY': ':0', 06:56:51 INFO - 'HOME': '/home/cltbld', 06:56:51 INFO - 'LANG': 'en_US.UTF-8', 06:56:51 INFO - 'LANGUAGE': 'en_US:en', 06:56:51 INFO - 'LOGNAME': 'cltbld', 06:56:51 INFO - 'MAIL': '/var/mail/cltbld', 06:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:51 INFO - 'MOZ_NO_REMOTE': '1', 06:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:51 INFO - 'NO_EM_RESTART': '1', 06:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:51 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:51 INFO - 'SHELL': '/bin/bash', 06:56:51 INFO - 'SHLVL': '1', 06:56:51 INFO - 'TERM': 'linux', 06:56:51 INFO - 'TMOUT': '86400', 06:56:51 INFO - 'USER': 'cltbld', 06:56:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', 06:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:51 INFO - '_': '/tools/buildbot/bin/python'} 06:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:56:51 INFO - Running setup.py (path:/tmp/pip-tcvBH7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:56:51 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:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:56:51 INFO - Running setup.py (path:/tmp/pip-TuBMfx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:56:52 INFO - Running setup.py (path:/tmp/pip-SaFLu0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:56:52 INFO - Running setup.py (path:/tmp/pip-I2Yy92-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:56:52 INFO - Running setup.py (path:/tmp/pip-WIlj8g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:56:52 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:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:56:52 INFO - Running setup.py (path:/tmp/pip-q6MH_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:56:52 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:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:56:52 INFO - Running setup.py (path:/tmp/pip-S8FS_4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:56:52 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:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:56:52 INFO - Running setup.py (path:/tmp/pip-I7cWb0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:56:52 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:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:56:52 INFO - Running setup.py (path:/tmp/pip-YkoIZ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:56:52 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:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:56:52 INFO - Running setup.py (path:/tmp/pip-dXklvN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:56:52 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:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:56:52 INFO - Running setup.py (path:/tmp/pip-3uj7Z7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:56:52 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:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:56:52 INFO - Running setup.py (path:/tmp/pip-mXKWXu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:56:52 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:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:56:52 INFO - Running setup.py (path:/tmp/pip-C06MGA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:56:52 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:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:56:52 INFO - Running setup.py (path:/tmp/pip-8IE7BG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:56:52 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:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:56:52 INFO - Running setup.py (path:/tmp/pip-6WLddT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:56:52 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:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:56:52 INFO - Running setup.py (path:/tmp/pip-Ft_2zb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 06:56:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:56:53 INFO - Running setup.py (path:/tmp/pip-leZtz6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 06:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:56:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:54 INFO - Downloading blessings-1.5.1.tar.gz 06:56:54 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:56:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:56:54 INFO - Installing collected packages: blessings 06:56:54 INFO - Running setup.py install for blessings 06:56:55 INFO - Successfully installed blessings 06:56:55 INFO - Cleaning up... 06:56:55 INFO - Return code: 0 06:56:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:56:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:56:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:56:55 INFO - Reading from file tmpfile_stdout 06:56:55 INFO - Current package versions: 06:56:55 INFO - argparse == 1.2.1 06:56:55 INFO - blessings == 1.5.1 06:56:55 INFO - blobuploader == 1.2.4 06:56:55 INFO - docopt == 0.6.1 06:56:55 INFO - manifestparser == 1.1 06:56:55 INFO - mozInstall == 1.12 06:56:55 INFO - mozcrash == 0.16 06:56:55 INFO - mozdebug == 0.1 06:56:55 INFO - mozdevice == 0.48 06:56:55 INFO - mozfile == 1.2 06:56:55 INFO - mozhttpd == 0.7 06:56:55 INFO - mozinfo == 0.9 06:56:55 INFO - mozleak == 0.1 06:56:55 INFO - mozlog == 3.1 06:56:55 INFO - moznetwork == 0.27 06:56:55 INFO - mozprocess == 0.22 06:56:55 INFO - mozprofile == 0.28 06:56:55 INFO - mozrunner == 6.11 06:56:55 INFO - mozscreenshot == 0.1 06:56:55 INFO - mozsystemmonitor == 0.0 06:56:55 INFO - moztest == 0.7 06:56:55 INFO - mozversion == 1.4 06:56:55 INFO - psutil == 3.1.1 06:56:55 INFO - requests == 1.2.3 06:56:55 INFO - wsgiref == 0.1.2 06:56:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:55 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 0x7f8762ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b7f0>, '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 0x10e72d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7760>, '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': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', '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:56:55 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:56:55 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:56:55 INFO - Using env: {'DISPLAY': ':0', 06:56:55 INFO - 'HOME': '/home/cltbld', 06:56:55 INFO - 'LANG': 'en_US.UTF-8', 06:56:55 INFO - 'LANGUAGE': 'en_US:en', 06:56:55 INFO - 'LOGNAME': 'cltbld', 06:56:55 INFO - 'MAIL': '/var/mail/cltbld', 06:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:55 INFO - 'MOZ_NO_REMOTE': '1', 06:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:55 INFO - 'NO_EM_RESTART': '1', 06:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:55 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:55 INFO - 'SHELL': '/bin/bash', 06:56:55 INFO - 'SHLVL': '1', 06:56:55 INFO - 'TERM': 'linux', 06:56:55 INFO - 'TMOUT': '86400', 06:56:55 INFO - 'USER': 'cltbld', 06:56:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', 06:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:55 INFO - '_': '/tools/buildbot/bin/python'} 06:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:55 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:56:55 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:56:55 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:56:55 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:56:55 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:56:55 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:56:55 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:56:55 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:56:55 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:56:55 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:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:56:55 INFO - Cleaning up... 06:56:55 INFO - Return code: 0 06:56:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:55 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 0x7f8762ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b7f0>, '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 0x10e72d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7760>, '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': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', '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:56:55 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:56:55 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:56:55 INFO - Using env: {'DISPLAY': ':0', 06:56:55 INFO - 'HOME': '/home/cltbld', 06:56:55 INFO - 'LANG': 'en_US.UTF-8', 06:56:55 INFO - 'LANGUAGE': 'en_US:en', 06:56:55 INFO - 'LOGNAME': 'cltbld', 06:56:55 INFO - 'MAIL': '/var/mail/cltbld', 06:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:55 INFO - 'MOZ_NO_REMOTE': '1', 06:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:55 INFO - 'NO_EM_RESTART': '1', 06:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:55 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:55 INFO - 'SHELL': '/bin/bash', 06:56:55 INFO - 'SHLVL': '1', 06:56:55 INFO - 'TERM': 'linux', 06:56:55 INFO - 'TMOUT': '86400', 06:56:55 INFO - 'USER': 'cltbld', 06:56:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', 06:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:55 INFO - '_': '/tools/buildbot/bin/python'} 06:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:55 INFO - Downloading/unpacking jsonschema 06:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:56:57 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:56:57 INFO - Downloading/unpacking functools32 (from jsonschema) 06:56:57 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:56:57 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:56:57 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:56:57 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:56:57 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:56:57 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:56:57 INFO - Downloading functools32-3.2.3-2.tar.gz 06:56:57 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:56:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:56:58 INFO - warning: no files found matching '*.txt' 06:56:58 INFO - no previously-included directories found matching 'build' 06:56:58 INFO - no previously-included directories found matching 'dist' 06:56:58 INFO - no previously-included directories found matching '.git*' 06:56:58 INFO - Installing collected packages: jsonschema, functools32 06:56:58 INFO - Running setup.py install for functools32 06:56:58 INFO - warning: no files found matching '*.txt' 06:56:58 INFO - no previously-included directories found matching 'build' 06:56:58 INFO - no previously-included directories found matching 'dist' 06:56:58 INFO - no previously-included directories found matching '.git*' 06:56:58 INFO - Successfully installed jsonschema functools32 06:56:58 INFO - Cleaning up... 06:56:58 INFO - Return code: 0 06:56:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8762ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b7f0>, '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 0x10e72d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7760>, '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': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', '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:56:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 06:56:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:56:58 INFO - Using env: {'DISPLAY': ':0', 06:56:58 INFO - 'HOME': '/home/cltbld', 06:56:58 INFO - 'LANG': 'en_US.UTF-8', 06:56:58 INFO - 'LANGUAGE': 'en_US:en', 06:56:58 INFO - 'LOGNAME': 'cltbld', 06:56:58 INFO - 'MAIL': '/var/mail/cltbld', 06:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:58 INFO - 'MOZ_NO_REMOTE': '1', 06:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:58 INFO - 'NO_EM_RESTART': '1', 06:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:58 INFO - 'SHELL': '/bin/bash', 06:56:58 INFO - 'SHLVL': '1', 06:56:58 INFO - 'TERM': 'linux', 06:56:58 INFO - 'TMOUT': '86400', 06:56:58 INFO - 'USER': 'cltbld', 06:56:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', 06:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:58 INFO - '_': '/tools/buildbot/bin/python'} 06:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:58 INFO - Downloading/unpacking flake8 06:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:57:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 06:57:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:57:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 06:57:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:00 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:57:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:57:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:57:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:57:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:57:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:57:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:57:00 INFO - no previously-included directories found matching 'docs/_build' 06:57:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:57:00 INFO - Running setup.py install for pep8 06:57:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:57:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:57:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:57:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:57:01 INFO - no previously-included directories found matching 'docs/_build' 06:57:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:57:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:57:01 INFO - Cleaning up... 06:57:01 INFO - Return code: 0 06:57:01 INFO - Running post-action listener: _resource_record_post_action 06:57:01 INFO - Running post-action listener: _start_resource_monitoring 06:57:01 INFO - Starting resource monitoring. 06:57:01 INFO - ##### 06:57:01 INFO - ##### Running install step. 06:57:01 INFO - ##### 06:57:01 INFO - Running pre-action listener: _resource_record_pre_action 06:57:01 INFO - Running main action method: install 06:57:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:57:01 INFO - Reading from file tmpfile_stdout 06:57:01 INFO - Detecting whether we're running mozinstall >=1.0... 06:57:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:57:01 INFO - Reading from file tmpfile_stdout 06:57:01 INFO - Output received: 06:57:01 INFO - Usage: mozinstall [options] installer 06:57:01 INFO - Options: 06:57:01 INFO - -h, --help show this help message and exit 06:57:01 INFO - -d DEST, --destination=DEST 06:57:01 INFO - Directory to install application into. [default: 06:57:01 INFO - "/builds/slave/test-pgo"] 06:57:01 INFO - --app=APP Application being installed. [default: firefox] 06:57:01 INFO - mkdir: /builds/slave/test-pgo/build/application 06:57:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:57:17 INFO - Reading from file tmpfile_stdout 06:57:17 INFO - Output received: 06:57:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:57:17 INFO - Running post-action listener: _resource_record_post_action 06:57:17 INFO - ##### 06:57:17 INFO - ##### Running run-tests step. 06:57:17 INFO - ##### 06:57:17 INFO - Running pre-action listener: _resource_record_pre_action 06:57:17 INFO - Running main action method: run_tests 06:57:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:57:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:57:17 INFO - Python 2.7.3 06:57:17 INFO - Return code: 0 06:57:17 INFO - grabbing minidump binary from tooltool 06:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b7f0>, '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 0x10e72d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:57:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 06:57:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:57:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:57:17 INFO - Return code: 0 06:57:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:57:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:57:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:57:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:57:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:57:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:57:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:57:18 INFO - Return code: 0 06:57:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 06:57:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 06:57:18 INFO - Using env: {'DISPLAY': ':0', 06:57:18 INFO - 'HOME': '/home/cltbld', 06:57:18 INFO - 'LANG': 'en_US.UTF-8', 06:57:18 INFO - 'LANGUAGE': 'en_US:en', 06:57:18 INFO - 'LOGNAME': 'cltbld', 06:57:18 INFO - 'MAIL': '/var/mail/cltbld', 06:57:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:57:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:18 INFO - 'MOZ_NO_REMOTE': '1', 06:57:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:57:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:18 INFO - 'NO_EM_RESTART': '1', 06:57:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:18 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:57:18 INFO - 'SHELL': '/bin/bash', 06:57:18 INFO - 'SHLVL': '1', 06:57:18 INFO - 'TERM': 'linux', 06:57:18 INFO - 'TMOUT': '86400', 06:57:18 INFO - 'USER': 'cltbld', 06:57:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898', 06:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:18 INFO - '_': '/tools/buildbot/bin/python'} 06:57:18 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:57:18 INFO - mozversion application_buildid: 20160116043010 06:57:18 INFO - mozversion application_changeset: 5f99e2208a3b5ef44fc80681caef563f6ec80b77 06:57:18 INFO - mozversion application_display_name: Nightly 06:57:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:57:18 INFO - mozversion application_name: Firefox 06:57:18 INFO - mozversion application_remotingname: firefox 06:57:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:57:18 INFO - mozversion application_vendor: Mozilla 06:57:18 INFO - mozversion application_version: 46.0a1 06:57:18 INFO - mozversion platform_buildid: 20160116043010 06:57:18 INFO - mozversion platform_changeset: 5f99e2208a3b5ef44fc80681caef563f6ec80b77 06:57:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:57:18 INFO - mozversion platform_version: 46.0a1 06:57:18 INFO - using testdate: 1452956238 06:57:18 INFO - actual date: 1452956238 06:57:18 INFO - starting webserver on 'localhost:39644' 06:57:18 INFO - SUITE-START | Running 3 tests 06:57:18 INFO - TEST-START | dromaeo_css 06:57:18 INFO - operating with platform_type : linux_ 06:57:18 INFO - Initialising browser for dromaeo_css test... 06:57:18 INFO - TEST-INFO | started process 5125 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMO1por/profile http://localhost:39644/getInfo.html) 06:57:23 INFO - PROCESS | 5125 | __metrics Screen width/height:1600/1200 06:57:23 INFO - PROCESS | 5125 | colorDepth:24 06:57:23 INFO - PROCESS | 5125 | Browser inner width/height: 1024/697 06:57:23 INFO - PROCESS | 5125 | __metrics 06:57:23 INFO - PROCESS | 5125 | 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:57:23 INFO - PROCESS | 5125 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:57:24 INFO - TEST-INFO | 5125: exit 0 06:57:24 INFO - Browser initialized. 06:57:24 INFO - Running cycle 1/1 for dromaeo_css test... 06:57:24 INFO - TEST-INFO | started process 5218 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMO1por/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:57:36 INFO - PROCESS | 5218 | RSS: Main: 149528576 06:57:36 INFO - PROCESS | 5218 | 06:58:27 INFO - PROCESS | 5218 | 1452956307684 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:00:35 INFO - PROCESS | 5218 | Cycle 1(1): loaded http://localhost:39644/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39644/tests/dromaeo/cssquery-ext.html) 07:00:36 INFO - PROCESS | 5218 | RSS: Main: 266457088 07:00:36 INFO - PROCESS | 5218 | 07:03:39 INFO - PROCESS | 5218 | Cycle 1(1): loaded http://localhost:39644/tests/dromaeo/cssquery-ext.html (next: http://localhost:39644/tests/dromaeo/cssquery-jquery.html) 07:03:39 INFO - PROCESS | 5218 | RSS: Main: 235126784 07:03:39 INFO - PROCESS | 5218 | 07:06:41 INFO - PROCESS | 5218 | Cycle 1(1): loaded http://localhost:39644/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39644/tests/dromaeo/cssquery-mootools.html) 07:06:42 INFO - PROCESS | 5218 | RSS: Main: 245481472 07:06:42 INFO - PROCESS | 5218 | 07:09:44 INFO - PROCESS | 5218 | Cycle 1(1): loaded http://localhost:39644/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39644/tests/dromaeo/cssquery-prototype.html) 07:09:44 INFO - PROCESS | 5218 | RSS: Main: 213700608 07:09:44 INFO - PROCESS | 5218 | 07:12:47 INFO - PROCESS | 5218 | Cycle 1(1): loaded http://localhost:39644/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39644/tests/dromaeo/cssquery-yui.html) 07:12:47 INFO - PROCESS | 5218 | RSS: Main: 217100288 07:12:47 INFO - PROCESS | 5218 | 07:15:50 INFO - PROCESS | 5218 | Cycle 1(1): loaded http://localhost:39644/tests/dromaeo/cssquery-yui.html (next: http://localhost:39644/tests/dromaeo/cssquery-dojo.html) 07:15:50 INFO - PROCESS | 5218 | RSS: Main: 273182720 07:15:50 INFO - PROCESS | 5218 | 07:15:50 INFO - PROCESS | 5218 | __start_tp_report 07:15:50 INFO - PROCESS | 5218 | _x_x_mozilla_page_load 07:15:50 INFO - PROCESS | 5218 | _x_x_mozilla_page_load_details 07:15:50 INFO - PROCESS | 5218 | |i|pagename|runs| 07:15:50 INFO - PROCESS | 5218 | |0;dojo.html;3059.1042401948603;3078.4458797416464;3113.3461972985674;3123.4065527549765;3133.5143052826807;4887.095887260854;4914.926276105862;4957.429895562007;4964.726940018298;4994.925076123861;4959.528844759742;5017.397912250535;5034.270030845525;5046.7224302663335;5116.565091967178;4579.221532339502;4630.74530900802;4646.86059418218;4701.647376446763;4702.670813043088;4603.838865639704;4688.437387513486;4710.458297295821;4710.952890471086;4734.668573199878;4544.727316361029;4625.7687115644085;4650.86047418578;4701.694389864648;4712.458067322267;4554.726716397026;4595.9310610340535;4609.078184363141;4619.399478067863;4625.976870115662;4569.973998080931;4573.245414506602;4577.404937358156;4620.838270660511;4628.629709623256;4739.6208303336;4843;4859.829905953275;4863.562279394871;4924.285978533128;5394.946050539523;5409.891802163935;5431.918521222185;5432.592555558349;5478.123500239983;5404.216388623628;5415.783368665248;5430.239766432703;5430.67415955044;5433.049216387117;5025.84922452327;5091.05815424144;5098.08234517783;5113.974430127825;5146.6911985281;5504.587155963239;5526.281583394133;5532.5573954083575;5539.196816461671;5566.35986861508;5336.092864213093;5339.225812257278;5343.385510666323;5347.0375332440535;5397.028534863763;5335.199720042025;5391.784328626811;5416.945830541723;5425.83722488326;5446.537044351275;5354.036273470735;5377.623566350318;5386.084365657847;5387.676739395649;5390.649607775482;5397.676139431646;5409.43200963901;5415.241866138744;5418.133098704188;5464.480874316933;4204.201201771653;4211.073563816017;4239.025024244441;4245.745255284693;4271.893202669896;3816.5420149581673;3817.3892177251505;3818.1790914953417;3838.1556057667267;3850.8459661613783;5012.147934851011;5025.522575355335;5025.623078269071;5028.522290382408;5038.899222015539;5300;5396.028714831289;5425.186222066722;5466.863328416742;5516.14499752539;4969.900601988013;4983.103041452501;4985.277134815431;5005.3242812220615;5023.472535383805;4597.241455159861;4632.884177895512;4640.559146881041;4682.719036857799;4725.692829966041;5571.66570005801;5599.104143337128;5636.887262254814;5656.773729050874;5712.428757124254;5400.243965844864;5425.891482170256;5426.0504411727;5429.077056900415;5430.728463576726;5498.560115190855;5583.637063590853;5611.270534830446;5624.465675760796;5679.971600141973;5350.197470379474;5410.59420543453;5412.377576578744;5414.485623865727;5429.511343979061;5393.002294575516;5433.375161856437;5435.537979271806;5435.701036443033;5481.917771233514;5235.869103272448;5280.551153152025;5320.14877619579;5331.653442526223;5333.306670132858;5293.047251494768;5311.840644780663;5314.681119132864;5315.495027972336;5342.759575819176;5176.094183517945;5225.764840582259;5232.005918875401;5240.4759524047295;5264.289320941624;5175.948240517547;5293.708846013506;5296.602754793483;5307.575393968396;5319.308489896289;5235.083860324352;5254.238135470412;5256.001359741636;5256.10646190141;5260.105782017143 07:15:50 INFO - PROCESS | 5218 | |1;ext.html;522.4383787428516;544.0750723769592;557.342336043469;565.0309718832202;579.4726798613262;30631.7836627154;31274.84362578184;31278.68721312786;31306.686933130663;31341.903033393864;32237.194070148256;32863;32887.99999999994;36876.446853297224;37639.05902352442;8569.91430085699;8771.649134034662;8772.517511536864;8773.298136149093;8773.385862989593;8517.105703901063;8636.740897773045;8646.870296945552;8650.913490865074;8650.913490865105;8629.352798540103;8687.044425113232;8694.434861733967;8696.21734043936;8699.913000869974;8556.358273129508;8615.784605384853;8629.784255393666;8630.395872288942;8649.65401383944;8487.40588158829;8591.5704214789;8608.913910860874;8624.870626940601;8630.697925572575;39648.80175599132;39859.40210896839;40195.39706904399;40260.59739402598;40301.39547906784;3064.8161110333226;3112.237501812048;3356.412627790127;3825.2731980923536;3847.4228865670093;29079.41841163186;29229.707702923122;29801.850990744908;30309.545356819664;30878.382432351453;3880.4373365861793;3952.426898099788;4026.617471340218;4049.696272779524;4095.8566450174103;259588;261197;261828;261995.9999999981;263640;53826.461735382145;54695.45304546983;59989;61142;61159;53559;54341.72829135829;54414.18378724322;54441.45558544364;54570;13660.521881734092;13785.51750688721;13991.720165596631;14010.789838152436;14104.717905642035;11060.612878549373;11254.21220514556;11312.604058858065;11318.717032074264;11337.922897324741;19492.809046055165;20397;20496.487587810425;20603.484912876997;20666.793332066485;7620;7706.7687969361;7772.727954521564;7793.64928578204;7823.491473054233;932.4079209701753;1015.6749840051112;1016.8627235323137;1028.290479569095;1084.1814430105221;28350.724217410265;28401.57397638996;28545.85727071393;28618.427631447255;29090.854545727136;1039.147898723055;1057.2282233969245;1141.6517962021662;1206.4209179593668;1218.7318789866215;14690.632734181518;14699.191544464944;14987.175705336093;15201.923990379977;15279.159646219343;335713;339992;340689;341074;341264;51857.48142518602;52206.21690674643;52247;52280.47719522832;52292;1293.1012946002438;1313.750387426405;1318.45284207053;1319.2546211390534;1342.328835582209;26941;27522.587161192198;27882.302942426602;27917.441651167268;28017.71982280151;46536.301955470015;47059.29411058906;47067;47075.52782485658;47095.293570595786;300626;301338;301836;302055;302321;28094;28481.715182847907;32086;32188.356232875678;32805.17987050343;37189.25621487609;37243.25513489769;37362.25275494529;38107.23785524219;38171.23657526779;31870.52194217042;32098.358032838747;32207.14676208973;32335.838320808245;32519.837400812845;28507.714922851337;31560.52659210068;33743.4938475928;34433;34494.65505345015;31656.525152122274;31982.840085799424;32356.676433235367;32386.514202286515;32399;27030.459390812466;29198.7080129196;29496;29773.70226297796;29788.55317170201;23494.412639684146;23989.640155398032;24013.159539416036;24067.27798166058;24127.396815079763 07:15:50 INFO - PROCESS | 5218 | |2;jquery.html;365.512041424698;367.366293144326;367.9742418030739;368.0798004987531;373.4659437005085;13084.411201495932;13123.606291811237;15746.527604171879;16132.274047667854;16842.831571684295;9972.601095956154;10327;16484;16875.240614172362;16908.915455422735;4439.356293337464;4997.125503036972;4997.550220480156;4999.425066117388;5001.324821149153;3716.907077323075;3878.224355128971;4932.038252540756;4972.353594032771;5152.92270615941;5307.787688492475;5319.494648008453;5338.252644629755;5365.195220716884;5371.113766228567;5146;5373.301470808769;5381.300430943952;5382;5385.623006389555;5030.647854650176;5146.3824341078935;5151.4333423323405;5152.149895267276;5288.180332048539;19115.23539058436;19726.13970974215;19853.9007304964;19878.403647890587;19904.20383184671;1954.687250040001;2058.5779915117514;2067.1524674883376;2073.409078412645;2192.243675931801;9582.472963986978;12133.696657583543;12233.204841685261;12457.563985260564;13028.739425211443;1793.2378739035858;1868.5141863115552;1883;1900.686386746199;1907.8473722102199;54036.72981635106;55321.44678553203;55603;55673.721631391985;56125.71937140329;9799.461029643438;9899.851502227473;10111.241656875764;10133.847992280122;10170.542325595366;13305.933470332586;13384.531541396005;13384.598462046155;13429;13436.932815336057;7051.435885129177;7130.572165670076;7266.309700578437;7269.563826170447;7336.193018767931;6927.099477067949;6935.133108361455;6972.1284839395075;7020.403265722369;7029.753958611424;4329.220740266719;4367.759773212504;4368.672349573794;4394.736315820997;4409.603135717736;1702.4126676296657;1718.5789481577094;1782.1712903499676;1818.9818101819078;1834.7981722010568;905.0813424374265;983.4885859353096;989.2827699917502;993.8062077894741;1063.0645032371617;13323.800142997863;14571.635709107146;16042.197890105448;16453.753193702105;16478.176091195393;931.8648795924553;933.6482029514077;960.7261930349956;978.5449765858909;987.0080569028224;8789.165029322205;9069.093090690878;9074.411977903841;9194.12655797698;9229.215516681157;500052;503796;514530;515109;515983;70089;70771.64614176999;72781;72860.63569682118;74273.6286318565;1037.7768779712399;1047.3035431438009;1063.0485715284776;1077.8329358949375;1080.1412876762993;14006.64983375383;14349.210793406046;14397.280135992949;14677;14690.192039437934;31995.200119997186;32709.836450817595;32853.01440956775;33228.66771332353;33243.16892077717;40012.59987400089;41199.382009269284;41712;42012;42228.98824611657;6788.796336109727;7042.401395881408;7463.626818659154;7511;7574.659140338808;8375.288100511525;10687.46562671879;11081.002709756161;11468.254563453349;11487.597934072268;8969.327300452362;9501.192398645917;9703.466309353053;9820.263480238867;9923.454210018519;9380.765480863032;9436.764080898032;9609.807803844024;9865.605375784888;9993.750156246151;9446.38598491096;9810.313278070467;10027.398356098658;10081.89918100839;10309.123724483203;7105.467089968376;7147.714091436493;7164.068671072727;7193.172785129568;7577.393808495197;7555.962220188864;9735.464549449565;9790.75523111928;9948.204143668634;10089.243306751876 07:15:50 INFO - PROCESS | 5218 | |3;mootools.html;1302.4204229118047;1486.4425840309884;1494.3574263066885;1643.3344495479328;1801.0184449475043;6707.396334329909;7371.373433258173;7543.547387156775;7565.205653406396;7567.3567746741455;7473.738419155331;7635.961820190905;7642.503237289572;7649.502782319146;7665.5783931883725;2023.5143565544238;2063.731714877064;2069.1309649946984;2307.665388518664;2329.988350058256;2296.7588403217674;2355.458244603742;2363.9290821275304;2366.4557151854997;2366.656834758959;2264.6376579747243;2280.703508543887;2309.90760369585;2320.211128216406;2323.488832456857;2299.609066458706;2304.942376440594;2314.0628045641456;2317.4901521665206;2353.5410594933996;2316.096722278313;2326.732425771041;2333.5449587330477;2335.5795956727784;2348.97651023491;7597.924020759832;7623.695052197905;7630.4658673892845;7636.69453221876;7639.541627502367;4685.1332503486965;4783.354247176656;4785;4787.210110331791;4791.065742180276;3003.2041509000132;3055.434744572261;3120;3124.562561241428;3133.357661679373;1000.8848982367048;1010.5553556435218;1013.8834034086101;1041.927065105443;1052.6841947415744;10388.740281492948;10475.58097676092;10528;10548.20888433363;10569.207309451745;4345.9348109778375;4430.490493593278;4507.166174257773;4529.433820772403;4533.84131555394;9216.124468175512;9221.90778092224;9230.53847307632;9236;9256.907430925605;4950.282209079735;4972.8508144755715;4978.5270399312;4992.500749924979;4994.001199760062;4404.493483249467;4412.139632771643;4454.643628509712;4456.888577785581;4463.464384273908;3516.542849429609;3594.2991116731987;3596.118950857057;3679.742418030712;3748.7938163401277;1261.779188641984;1266.7339858629607;1271.6439396968863;1272.8981681465461;1282.8139919711589;1305.556110922291;1308.7578797922415;1313.6453157647381;1329.4815022141372;1329.667583104224;7121.89317160243;7133.251008644018;7150.5352152109945;7159.463040272;7167.605781682058;1100.1528822806395;1104.089126470665;1129.9378534180535;1131.216082205023;1132.422464543089;5676.233708449389;5743.913841292384;5747;5750.4249575042995;5761;8910.064443233498;8913.331500137516;9004.684836030707;9007.774805629911;9121.224695900923;8877.600507977157;8880.955595221982;9001.819963600823;9051.185393314501;9080.273578113734;6929.099217101744;7054.329838665216;7073.71705131789;7082.39799617028;7136.607486588287;6854.794356169323;6875.5874647521305;6887.035814986006;6892.241853396223;6895.827604309932;7893.329067029367;7921.485103468256;7968.123506414406;7989.121196668478;8039.919600803917;8173.18268173178;8370.665173392996;8488.74533763988;8505.319574434154;8511.787205319917;6838.487113466411;6848.3494068063455;6862.279460656759;6911.205211400552;6919.273476285119;6226.40849119333;6320.873582528232;6887.381465355537;7064.894026589708;7355.374793142429;6741;6748.93251067483;6795;6857.828554286183;6924.4460443165435;6660.83347916306;6694.263631000488;6704.899426508704;6763.053172555748;6866.828329291608;6784.728610855511;7011;7011.894821577578;7014.473914456335;7023.086998690138;6268.216472940882;6291.119243306032;6341.319550319077;6362.904556431565;6394.808155755335;6368.395002474757;6381.680915954276;6429.7749578764515;6435.839104022437;6457.031445283057 07:15:50 INFO - PROCESS | 5218 | |4;prototype.html;337.7146311366895;344.5503617778799;348.3398958972745;348.808155514467;352.85674414895743;5772.538196944245;5773.989551828429;5797.072468405061;5833.941660583393;5852.561057920651;5537.197106419567;5571.359293681227;5677.914831277524;5694.060480020791;5737.684427356494;4458.554144585548;4468.75421851798;4469.50835408104;4482.932756008662;4493.191225579394;4319.568043195687;4485.416895803557;4496.055828276066;4497.505274419811;4503.0318481526465;4353.891152721176;4385.2106620808245;4427.800748966288;4462.553744625544;4481.095534397884;4419.160359531695;4428.512863584987;4437.800298986521;4439.7780110994645;4461.08547747711;3928.194720082376;3930.3711406174875;3934.173823497069;3938.212357528506;3943.4084887266854;5387.057264978652;5480.862978425571;5492.780288788444;5493.395726470085;5501.862453438656;5107.438181799999;5113.309703190059;5115.181570948667;5116.897662046738;5117.6161787865685;6044.637321760709;6053.606515576474;6055.2430946131735;6056.666883321415;6062.242219722535;4299.161663475624;4333.934990975138;4343.847965321199;4351;4356.803943822504;6252.249730032425;6361.809145725636;6370.8088757337355;6379.968100159516;6399.552031357854;4424.46906371231;4427.667924905581;4432.135733531994;4436.911261774746;4438.822447102079;4489.506154323022;4490.977545112319;4491.46102467706;4494.685372023927;4497.595216430537;5112.335396398519;5124.077666020077;5129.717865517432;5138;5147.897042059213;5997.160397544348;6150;6155.984262596711;6158.630482171084;6161.691915404302;1582.2800625715272;1608.5737279620676;1609.4286528282526;1609.7022050920616;1610.8791840612;1090.7545802194602;1097.05653138301;1098.3739268616812;1105.2926127278547;1115.9776804463866;5839.386864379264;5853.94146058534;5857.502112320501;5860.150278209636;5861.882762344814;6321.715522801485;6328.968355158287;6332.33510481402;6334.113224148531;6348.650824204713;5654.293213348332;5710.628809127394;5723.513501352349;5727.427257274323;5783.045797443375;3369.747268954838;3388.7289016879085;3397.2016576104597;3407.522946787452;3417.79493230407;6605.834854128685;6608.801735947929;6610.6694665267505;6611.140551728245;6621.106150669694;6366.172397588377;6515.348465153446;6519.7392104315295;6549.181352330958;6549.312322206195;6628.966855165693;6645.800625981228;6647.900281495781;6657.367550082734;6665.700043498055;6314.336994615683;6340.461060809698;6343.207099112611;6354.586951848115;6354.618722876642;6157.846053848511;6276.152719383008;6301.747930082745;6304.464120549805;6315.621062736251;6640.306721785913;6649.933500665125;6653.168353955755;6653.500987425866;6663.200415949923;4514.435695538058;4525.886852828706;4530.954690453185;4532.27483602622;4533.206688829376;6231.594946328474;6357.1735674362035;6381.8085457436355;6391.552591318563;6395.392437718409;6165.784197553064;6172.043333283348;6173.59871608344;6175.814725558241;6175.814725558241;6196.10156527292;6200.0699895016105;6205.968970155121;6208.789286089169;6211.503079753518;5992.250968628921;6048.90926636092;6099.054646529795;6114.388561144028;6116.449519543263;6195.070739389128;6196.380361963767;6205.751769929333;6250.281217660027;6274.058891166362;6105.84735381619;6110.69446527663;6114.205153330038;6115;6118.908216376669 07:15:50 INFO - PROCESS | 5218 | |5;yui.html;659.3604203922193;664.7706541243269;757.4319260554585;775.2751177648897;800.6117033238878;12746.17149885258;12894.161879477839;12966.286854223014;12973.156744811604;13010.479580816756;12082.456289466973;12093.213941093845;12151.635450936486;12163.087768417381;12173.573924912629;661.3650895140671;668.4418510543702;786.2137862137862;803.2890891560967;810.4893916832417;805.7985503624094;815.8613035783901;819.647551552832;819.7171975668415;823.7281697039992;848.6308455821737;853.9188777066169;854.581255184958;855.1576696953496;855.7133360324299;701.1200942816757;712.2628079937266;835.0688981785296;858.1418581418582;859.0636206534907;621.940915613016;625.859181684122;625.9155014073087;633.1705465839718;633.262249479356;12036;12066.9743071839;12094.697632559168;12121.878781212252;12136.635900922987;12059.216150950248;12068.456919438559;12131.939340303243;12430.067744919168;12533.874661253361;10380.896191038144;10408.219383546264;10534.894651053544;10583.15334773224;10655.893441065646;3610.097475631092;3611.783293002402;3637.8726744563814;3638.708903287757;3757.511523501927;44089.338659919806;44293;44458.11083778339;44475.110497789865;44558.10883782338;10281.845772313422;10289.485525723683;10330.896691033144;10377.117944974761;10524.736881577868;17697.203625836868;17812.55468613295;17891.552711182325;17901.641967160846;17903.910480447776;7710.653020613973;7802.336801371834;7850.882236766453;8040.4773689711155;8152.959235203786;4381.956180438218;4438.622717069021;4442.397864955452;4449.243628583149;4514.029483661028;3015.62304711911;3055.388922215566;3059.8623061962267;3069.938601227963;3072.8617212225504;581.1689284323373;581.316952580716;585.2771826793906;587.9235699359142;609.6159419565645;478.5406010230218;547.9397266300704;642.9327316654332;666.9333066693389;684.7021545627667;8678.956605216934;8697.869531957025;8720.171583699539;8797.12028797115;8957.820843583091;555.50837508805;586.9413058694097;635.9650219237893;665.2250128600126;744.5495475237403;3936.193080418507;4029.174019326031;4045.292073887058;4104.056067104523;4157.127003329335;54796.45203547993;57449.712751435974;58267;58298.12552811711;58448;46195;46417.53582464132;46643.30035049477;49115;50269.24596131061;46233.53766462292;46389.30416043762;47065;47261;47387.52612473831;9047.411918225294;9118.95440522793;9165.862512062191;9211.631534738535;9219.549961289731;31583.21041973969;32455.350892982482;32483.837580811945;36103;37097.814510927274;40071;40351.99120022023;40560.79719601383;42610;47585.76207118942;11361.943190283995;11770.705732356759;12078.637640870787;12086.395680215777;12112.818307725214;12246.877531224574;12323.630291091282;12633.684157896127;12638.810417843924;12736.554220602235;11703.531858725555;12069.517219311128;12128.636140915787;12241.938790305992;12661.493540258287;11862;11872.465739041936;12086.516539338329;12117.394130293625;12183;11591.6522504325;11614.825777613512;11762.82355764647;11836;11927.165098443025;9293.395929264576;9306.162445379949;9417.576209070472;9721.805563888542;9732.562034708313;8892.377533572846;9129.5891684873;10222.948885255824;10248.119702336207;10350.637727679496 07:15:50 INFO - PROCESS | 5218 | __end_tp_report 07:15:50 INFO - PROCESS | 5218 | __start_cc_report 07:15:50 INFO - PROCESS | 5218 | _x_x_mozilla_cycle_collect,986 07:15:50 INFO - PROCESS | 5218 | __end_cc_report 07:15:50 INFO - PROCESS | 5218 | __startTimestamp1452957350440__endTimestamp 07:15:50 INFO - PROCESS | 5218 | 07:15:50 INFO - PROCESS | 5218 | ------- Summary: start ------- 07:15:50 INFO - PROCESS | 5218 | Number of tests: 6 07:15:50 INFO - PROCESS | 5218 | 07:15:50 INFO - PROCESS | 5218 | [#0] dojo.html Cycles:165 Average:5035.69 Median:5254.24 stddev:538.13 (10.2%) stddev-sans-first:516.96 07:15:50 INFO - PROCESS | 5218 | Values: 3059.1 3078.4 3113.3 3123.4 3133.5 4887.1 4914.9 4957.4 4964.7 4994.9 4959.5 5017.4 5034.3 5046.7 5116.6 4579.2 4630.7 4646.9 4701.6 4702.7 4603.8 4688.4 4710.5 4711.0 4734.7 4544.7 4625.8 4650.9 4701.7 4712.5 4554.7 4595.9 4609.1 4619.4 4626.0 4570.0 4573.2 4577.4 4620.8 4628.6 4739.6 4843.0 4859.8 4863.6 4924.3 5394.9 5409.9 5431.9 5432.6 5478.1 5404.2 5415.8 5430.2 5430.7 5433.0 5025.8 5091.1 5098.1 5114.0 5146.7 5504.6 5526.3 5532.6 5539.2 5566.4 5336.1 5339.2 5343.4 5347.0 5397.0 5335.2 5391.8 5416.9 5425.8 5446.5 5354.0 5377.6 5386.1 5387.7 5390.6 5397.7 5409.4 5415.2 5418.1 5464.5 4204.2 4211.1 4239.0 4245.7 4271.9 3816.5 3817.4 3818.2 3838.2 3850.8 5012.1 5025.5 5025.6 5028.5 5038.9 5300.0 5396.0 5425.2 5466.9 5516.1 4969.9 4983.1 4985.3 5005.3 5023.5 4597.2 4632.9 4640.6 4682.7 4725.7 5571.7 5599.1 5636.9 5656.8 5712.4 5400.2 5425.9 5426.1 5429.1 5430.7 5498.6 5583.6 5611.3 5624.5 5680.0 5350.2 5410.6 5412.4 5414.5 5429.5 5393.0 5433.4 5435.5 5435.7 5481.9 5235.9 5280.6 5320.1 5331.7 5333.3 5293.0 5311.8 5314.7 5315.5 5342.8 5176.1 5225.8 5232.0 5240.5 5264.3 5175.9 5293.7 5296.6 5307.6 5319.3 5235.1 5254.2 5256.0 5256.1 5260.1 07:15:50 INFO - PROCESS | 5218 | 07:15:50 INFO - PROCESS | 5218 | [#1] ext.html Cycles:180 Average:45766.86 Median:32392.76 stddev:79335.18 (244.9%) stddev-sans-first:79485.00 07:15:50 INFO - PROCESS | 5218 | Values: 522.4 544.1 557.3 565.0 579.5 30631.8 31274.8 31278.7 31306.7 31341.9 32237.2 32863.0 32888.0 36876.4 37639.1 8569.9 8771.6 8772.5 8773.3 8773.4 8517.1 8636.7 8646.9 8650.9 8650.9 8629.4 8687.0 8694.4 8696.2 8699.9 8556.4 8615.8 8629.8 8630.4 8649.7 8487.4 8591.6 8608.9 8624.9 8630.7 39648.8 39859.4 40195.4 40260.6 40301.4 3064.8 3112.2 3356.4 3825.3 3847.4 29079.4 29229.7 29801.9 30309.5 30878.4 3880.4 3952.4 4026.6 4049.7 4095.9 259588.0 261197.0 261828.0 261996.0 263640.0 53826.5 54695.5 59989.0 61142.0 61159.0 53559.0 54341.7 54414.2 54441.5 54570.0 13660.5 13785.5 13991.7 14010.8 14104.7 11060.6 11254.2 11312.6 11318.7 11337.9 19492.8 20397.0 20496.5 20603.5 20666.8 7620.0 7706.8 7772.7 7793.6 7823.5 932.4 1015.7 1016.9 1028.3 1084.2 28350.7 28401.6 28545.9 28618.4 29090.9 1039.1 1057.2 1141.7 1206.4 1218.7 14690.6 14699.2 14987.2 15201.9 15279.2 335713.0 339992.0 340689.0 341074.0 341264.0 51857.5 52206.2 52247.0 52280.5 52292.0 1293.1 1313.8 1318.5 1319.3 1342.3 26941.0 27522.6 27882.3 27917.4 28017.7 46536.3 47059.3 47067.0 47075.5 47095.3 300626.0 301338.0 301836.0 302055.0 302321.0 28094.0 28481.7 32086.0 32188.4 32805.2 37189.3 37243.3 37362.3 38107.2 38171.2 31870.5 32098.4 32207.1 32335.8 32519.8 28507.7 31560.5 33743.5 34433.0 34494.7 31656.5 31982.8 32356.7 32386.5 32399.0 27030.5 29198.7 29496.0 29773.7 29788.6 23494.4 23989.6 24013.2 24067.3 24127.4 07:15:50 INFO - PROCESS | 5218 | 07:15:50 INFO - PROCESS | 5218 | [#2] jquery.html Cycles:180 Average:26423.04 Median:4997.34 stddev:83331.38 (1667.5%) stddev-sans-first:83542.17 07:15:50 INFO - PROCESS | 5218 | Values: 365.5 367.4 368.0 368.1 373.5 13084.4 13123.6 15746.5 16132.3 16842.8 9972.6 10327.0 16484.0 16875.2 16908.9 4439.4 4997.1 4997.6 4999.4 5001.3 3716.9 3878.2 4932.0 4972.4 5152.9 5307.8 5319.5 5338.3 5365.2 5371.1 5146.0 5373.3 5381.3 5382.0 5385.6 5030.6 5146.4 5151.4 5152.1 5288.2 19115.2 19726.1 19853.9 19878.4 19904.2 1954.7 2058.6 2067.2 2073.4 2192.2 9582.5 12133.7 12233.2 12457.6 13028.7 1793.2 1868.5 1883.0 1900.7 1907.8 54036.7 55321.4 55603.0 55673.7 56125.7 9799.5 9899.9 10111.2 10133.8 10170.5 13305.9 13384.5 13384.6 13429.0 13436.9 7051.4 7130.6 7266.3 7269.6 7336.2 6927.1 6935.1 6972.1 7020.4 7029.8 4329.2 4367.8 4368.7 4394.7 4409.6 1702.4 1718.6 1782.2 1819.0 1834.8 905.1 983.5 989.3 993.8 1063.1 13323.8 14571.6 16042.2 16453.8 16478.2 931.9 933.6 960.7 978.5 987.0 8789.2 9069.1 9074.4 9194.1 9229.2 500052.0 503796.0 514530.0 515109.0 515983.0 70089.0 70771.6 72781.0 72860.6 74273.6 1037.8 1047.3 1063.0 1077.8 1080.1 14006.6 14349.2 14397.3 14677.0 14690.2 31995.2 32709.8 32853.0 33228.7 33243.2 40012.6 41199.4 41712.0 42012.0 42229.0 6788.8 7042.4 7463.6 7511.0 7574.7 8375.3 10687.5 11081.0 11468.3 11487.6 8969.3 9501.2 9703.5 9820.3 9923.5 9380.8 9436.8 9609.8 9865.6 9993.8 9446.4 9810.3 10027.4 10081.9 10309.1 7105.5 7147.7 7164.1 7193.2 7577.4 7556.0 9735.5 9790.8 9948.2 10089.2 07:15:50 INFO - PROCESS | 5218 | 07:15:50 INFO - PROCESS | 5218 | [#3] mootools.html Cycles:180 Average:5375.03 Median:6247.31 stddev:2703.47 (43.3%) stddev-sans-first:2693.71 07:15:50 INFO - PROCESS | 5218 | Values: 1302.4 1486.4 1494.4 1643.3 1801.0 6707.4 7371.4 7543.5 7565.2 7567.4 7473.7 7636.0 7642.5 7649.5 7665.6 2023.5 2063.7 2069.1 2307.7 2330.0 2296.8 2355.5 2363.9 2366.5 2366.7 2264.6 2280.7 2309.9 2320.2 2323.5 2299.6 2304.9 2314.1 2317.5 2353.5 2316.1 2326.7 2333.5 2335.6 2349.0 7597.9 7623.7 7630.5 7636.7 7639.5 4685.1 4783.4 4785.0 4787.2 4791.1 3003.2 3055.4 3120.0 3124.6 3133.4 1000.9 1010.6 1013.9 1041.9 1052.7 10388.7 10475.6 10528.0 10548.2 10569.2 4345.9 4430.5 4507.2 4529.4 4533.8 9216.1 9221.9 9230.5 9236.0 9256.9 4950.3 4972.9 4978.5 4992.5 4994.0 4404.5 4412.1 4454.6 4456.9 4463.5 3516.5 3594.3 3596.1 3679.7 3748.8 1261.8 1266.7 1271.6 1272.9 1282.8 1305.6 1308.8 1313.6 1329.5 1329.7 7121.9 7133.3 7150.5 7159.5 7167.6 1100.2 1104.1 1129.9 1131.2 1132.4 5676.2 5743.9 5747.0 5750.4 5761.0 8910.1 8913.3 9004.7 9007.8 9121.2 8877.6 8881.0 9001.8 9051.2 9080.3 6929.1 7054.3 7073.7 7082.4 7136.6 6854.8 6875.6 6887.0 6892.2 6895.8 7893.3 7921.5 7968.1 7989.1 8039.9 8173.2 8370.7 8488.7 8505.3 8511.8 6838.5 6848.3 6862.3 6911.2 6919.3 6226.4 6320.9 6887.4 7064.9 7355.4 6741.0 6748.9 6795.0 6857.8 6924.4 6660.8 6694.3 6704.9 6763.1 6866.8 6784.7 7011.0 7011.9 7014.5 7023.1 6268.2 6291.1 6341.3 6362.9 6394.8 6368.4 6381.7 6429.8 6435.8 6457.0 07:15:50 INFO - PROCESS | 5218 | 07:15:50 INFO - PROCESS | 5218 | [#4] prototype.html Cycles:180 Average:5159.36 Median:5778.52 stddev:1536.19 (26.6%) stddev-sans-first:1497.27 07:15:50 INFO - PROCESS | 5218 | Values: 337.7 344.6 348.3 348.8 352.9 5772.5 5774.0 5797.1 5833.9 5852.6 5537.2 5571.4 5677.9 5694.1 5737.7 4458.6 4468.8 4469.5 4482.9 4493.2 4319.6 4485.4 4496.1 4497.5 4503.0 4353.9 4385.2 4427.8 4462.6 4481.1 4419.2 4428.5 4437.8 4439.8 4461.1 3928.2 3930.4 3934.2 3938.2 3943.4 5387.1 5480.9 5492.8 5493.4 5501.9 5107.4 5113.3 5115.2 5116.9 5117.6 6044.6 6053.6 6055.2 6056.7 6062.2 4299.2 4333.9 4343.8 4351.0 4356.8 6252.2 6361.8 6370.8 6380.0 6399.6 4424.5 4427.7 4432.1 4436.9 4438.8 4489.5 4491.0 4491.5 4494.7 4497.6 5112.3 5124.1 5129.7 5138.0 5147.9 5997.2 6150.0 6156.0 6158.6 6161.7 1582.3 1608.6 1609.4 1609.7 1610.9 1090.8 1097.1 1098.4 1105.3 1116.0 5839.4 5853.9 5857.5 5860.2 5861.9 6321.7 6329.0 6332.3 6334.1 6348.7 5654.3 5710.6 5723.5 5727.4 5783.0 3369.7 3388.7 3397.2 3407.5 3417.8 6605.8 6608.8 6610.7 6611.1 6621.1 6366.2 6515.3 6519.7 6549.2 6549.3 6629.0 6645.8 6647.9 6657.4 6665.7 6314.3 6340.5 6343.2 6354.6 6354.6 6157.8 6276.2 6301.7 6304.5 6315.6 6640.3 6649.9 6653.2 6653.5 6663.2 4514.4 4525.9 4531.0 4532.3 4533.2 6231.6 6357.2 6381.8 6391.6 6395.4 6165.8 6172.0 6173.6 6175.8 6175.8 6196.1 6200.1 6206.0 6208.8 6211.5 5992.3 6048.9 6099.1 6114.4 6116.4 6195.1 6196.4 6205.8 6250.3 6274.1 6105.8 6110.7 6114.2 6115.0 6118.9 07:15:50 INFO - PROCESS | 5218 | 07:15:50 INFO - PROCESS | 5218 | [#5] yui.html Cycles:180 Average:13548.25 Median:4440.51 stddev:15352.50 (345.7%) stddev-sans-first:15365.06 07:15:50 INFO - PROCESS | 5218 | Values: 659.4 664.8 757.4 775.3 800.6 12746.2 12894.2 12966.3 12973.2 13010.5 12082.5 12093.2 12151.6 12163.1 12173.6 661.4 668.4 786.2 803.3 810.5 805.8 815.9 819.6 819.7 823.7 848.6 853.9 854.6 855.2 855.7 701.1 712.3 835.1 858.1 859.1 621.9 625.9 625.9 633.2 633.3 12036.0 12067.0 12094.7 12121.9 12136.6 12059.2 12068.5 12131.9 12430.1 12533.9 10380.9 10408.2 10534.9 10583.2 10655.9 3610.1 3611.8 3637.9 3638.7 3757.5 44089.3 44293.0 44458.1 44475.1 44558.1 10281.8 10289.5 10330.9 10377.1 10524.7 17697.2 17812.6 17891.6 17901.6 17903.9 7710.7 7802.3 7850.9 8040.5 8153.0 4382.0 4438.6 4442.4 4449.2 4514.0 3015.6 3055.4 3059.9 3069.9 3072.9 581.2 581.3 585.3 587.9 609.6 478.5 547.9 642.9 666.9 684.7 8679.0 8697.9 8720.2 8797.1 8957.8 555.5 586.9 636.0 665.2 744.5 3936.2 4029.2 4045.3 4104.1 4157.1 54796.5 57449.7 58267.0 58298.1 58448.0 46195.0 46417.5 46643.3 49115.0 50269.2 46233.5 46389.3 47065.0 47261.0 47387.5 9047.4 9119.0 9165.9 9211.6 9219.5 31583.2 32455.4 32483.8 36103.0 37097.8 40071.0 40352.0 40560.8 42610.0 47585.8 11361.9 11770.7 12078.6 12086.4 12112.8 12246.9 12323.6 12633.7 12638.8 12736.6 11703.5 12069.5 12128.6 12241.9 12661.5 11862.0 11872.5 12086.5 12117.4 12183.0 11591.7 11614.8 11762.8 11836.0 11927.2 9293.4 9306.2 9417.6 9721.8 9732.6 8892.4 9129.6 10222.9 10248.1 10350.6 07:15:50 INFO - PROCESS | 5218 | -------- Summary: end -------- 07:15:50 INFO - PROCESS | 5218 | 07:15:51 INFO - TEST-INFO | 5218: exit 0 07:15:51 INFO - TEST-OK | dromaeo_css | took 1112332ms 07:15:51 INFO - TEST-START | kraken 07:15:51 INFO - operating with platform_type : linux_ 07:15:51 INFO - Initialising browser for kraken test... 07:15:51 INFO - TEST-INFO | started process 5415 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO5vg6r/profile http://localhost:39644/getInfo.html) 07:15:54 INFO - PROCESS | 5415 | __metrics Screen width/height:1600/1200 07:15:54 INFO - PROCESS | 5415 | colorDepth:24 07:15:54 INFO - PROCESS | 5415 | Browser inner width/height: 1024/697 07:15:54 INFO - PROCESS | 5415 | __metrics 07:15:54 INFO - PROCESS | 5415 | 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:15:54 INFO - PROCESS | 5415 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:15:56 INFO - TEST-INFO | 5415: exit 0 07:15:56 INFO - Browser initialized. 07:15:56 INFO - Running cycle 1/1 for kraken test... 07:15:56 INFO - TEST-INFO | started process 5498 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO5vg6r/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:07 INFO - PROCESS | 5498 | RSS: Main: 150847488 07:16:07 INFO - PROCESS | 5498 | 07:16:10 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39644/tests/kraken/driver.html?testName=audio-beat-detection) 07:16:10 INFO - PROCESS | 5498 | RSS: Main: 187641856 07:16:10 INFO - PROCESS | 5498 | 07:16:13 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39644/tests/kraken/driver.html?testName=audio-dft) 07:16:14 INFO - PROCESS | 5498 | RSS: Main: 177930240 07:16:14 INFO - PROCESS | 5498 | 07:16:17 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39644/tests/kraken/driver.html?testName=audio-fft) 07:16:17 INFO - PROCESS | 5498 | RSS: Main: 160878592 07:16:17 INFO - PROCESS | 5498 | 07:16:19 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39644/tests/kraken/driver.html?testName=audio-oscillator) 07:16:20 INFO - PROCESS | 5498 | RSS: Main: 162357248 07:16:20 INFO - PROCESS | 5498 | 07:16:22 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39644/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:16:22 INFO - PROCESS | 5498 | RSS: Main: 164823040 07:16:22 INFO - PROCESS | 5498 | 07:16:25 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39644/tests/kraken/driver.html?testName=imaging-darkroom) 07:16:26 INFO - PROCESS | 5498 | RSS: Main: 164872192 07:16:26 INFO - PROCESS | 5498 | 07:16:29 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39644/tests/kraken/driver.html?testName=imaging-desaturate) 07:16:30 INFO - PROCESS | 5498 | RSS: Main: 165675008 07:16:30 INFO - PROCESS | 5498 | 07:16:33 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39644/tests/kraken/driver.html?testName=json-parse-financial) 07:16:33 INFO - PROCESS | 5498 | RSS: Main: 165642240 07:16:33 INFO - PROCESS | 5498 | 07:16:35 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39644/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:16:35 INFO - PROCESS | 5498 | RSS: Main: 173621248 07:16:35 INFO - PROCESS | 5498 | 07:16:37 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:16:38 INFO - PROCESS | 5498 | RSS: Main: 170516480 07:16:38 INFO - PROCESS | 5498 | 07:16:40 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:16:40 INFO - PROCESS | 5498 | RSS: Main: 181522432 07:16:40 INFO - PROCESS | 5498 | 07:16:43 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:16:43 INFO - PROCESS | 5498 | RSS: Main: 190349312 07:16:43 INFO - PROCESS | 5498 | 07:16:46 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:16:46 INFO - PROCESS | 5498 | RSS: Main: 187961344 07:16:46 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39644/tests/kraken/driver.html?testName=ai-astar) 07:16:48 INFO - PROCESS | 5498 | RSS: Main: 245747712 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | __start_tp_report 07:16:48 INFO - PROCESS | 5498 | _x_x_mozilla_page_load 07:16:48 INFO - PROCESS | 5498 | _x_x_mozilla_page_load_details 07:16:48 INFO - PROCESS | 5498 | |i|pagename|runs| 07:16:48 INFO - PROCESS | 5498 | |0;ai-astar;108;109;106;110;111;109;99;108;109;110 07:16:48 INFO - PROCESS | 5498 | |1;audio-beat-detection;162;126;149;168;135;159;151;131;162;128 07:16:48 INFO - PROCESS | 5498 | |2;audio-dft;160;160;160;160;158;160;159;163;162;163 07:16:48 INFO - PROCESS | 5498 | |3;audio-fft;72;75;104;92;71;81;71;118;92;72 07:16:48 INFO - PROCESS | 5498 | |4;audio-oscillator;97;97;139;96;96;97;141;96;96;138 07:16:48 INFO - PROCESS | 5498 | |5;imaging-gaussian-blur;109;109;110;109;109;109;109;109;109;109 07:16:48 INFO - PROCESS | 5498 | |6;imaging-darkroom;147;146;146;146;147;145;145;145;146;145 07:16:48 INFO - PROCESS | 5498 | |7;imaging-desaturate;95;96;95;95;95;96;95;96;95;96 07:16:48 INFO - PROCESS | 5498 | |8;json-parse-financial;57;59;57;56;58;56;58;64;54;54 07:16:48 INFO - PROCESS | 5498 | |9;json-stringify-tinderbox;68;68;68;68;69;69;68;69;69;69 07:16:48 INFO - PROCESS | 5498 | |10;stanford-crypto-aes;82;82;81;81;81;82;82;83;81;81 07:16:48 INFO - PROCESS | 5498 | |11;stanford-crypto-ccm;115;120;116;120;113;120;123;115;116;130 07:16:48 INFO - PROCESS | 5498 | |12;stanford-crypto-pbkdf2;133;147;142;143;144;135;150;143;141;143 07:16:48 INFO - PROCESS | 5498 | |13;stanford-crypto-sha256-iterative;66;66;68;66;69;67;70;67;66;66 07:16:48 INFO - PROCESS | 5498 | __end_tp_report 07:16:48 INFO - PROCESS | 5498 | __start_cc_report 07:16:48 INFO - PROCESS | 5498 | _x_x_mozilla_cycle_collect,956 07:16:48 INFO - PROCESS | 5498 | __end_cc_report 07:16:48 INFO - PROCESS | 5498 | __startTimestamp1452957408786__endTimestamp 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | ------- Summary: start ------- 07:16:48 INFO - PROCESS | 5498 | Number of tests: 14 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.50 stddev:3.41 (3.1%) stddev-sans-first:3.62 07:16:48 INFO - PROCESS | 5498 | Values: 108.0 109.0 106.0 110.0 111.0 109.0 99.0 108.0 109.0 110.0 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:155.00 stddev:15.84 (10.2%) stddev-sans-first:15.85 07:16:48 INFO - PROCESS | 5498 | Values: 162.0 126.0 149.0 168.0 135.0 159.0 151.0 131.0 162.0 128.0 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 07:16:48 INFO - PROCESS | 5498 | Values: 160.0 160.0 160.0 160.0 158.0 160.0 159.0 163.0 162.0 163.0 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#3] audio-fft Cycles:10 Average:84.80 Median:73.50 stddev:16.31 (22.2%) stddev-sans-first:16.63 07:16:48 INFO - PROCESS | 5498 | Values: 72.0 75.0 104.0 92.0 71.0 81.0 71.0 118.0 92.0 72.0 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:96.00 stddev:20.74 (21.6%) stddev-sans-first:21.52 07:16:48 INFO - PROCESS | 5498 | Values: 97.0 97.0 139.0 96.0 96.0 97.0 141.0 96.0 96.0 138.0 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:16:48 INFO - PROCESS | 5498 | Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 07:16:48 INFO - PROCESS | 5498 | Values: 147.0 146.0 146.0 146.0 147.0 145.0 145.0 145.0 146.0 145.0 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:16:48 INFO - PROCESS | 5498 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.50 stddev:2.87 (5.0%) stddev-sans-first:3.04 07:16:48 INFO - PROCESS | 5498 | Values: 57.0 59.0 57.0 56.0 58.0 56.0 58.0 64.0 54.0 54.0 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 07:16:48 INFO - PROCESS | 5498 | Values: 68.0 68.0 68.0 68.0 69.0 69.0 68.0 69.0 69.0 69.0 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:0.70 (0.9%) stddev-sans-first:0.73 07:16:48 INFO - PROCESS | 5498 | Values: 82.0 82.0 81.0 81.0 81.0 82.0 82.0 83.0 81.0 81.0 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:120.00 stddev:5.01 (4.2%) stddev-sans-first:5.12 07:16:48 INFO - PROCESS | 5498 | Values: 115.0 120.0 116.0 120.0 113.0 120.0 123.0 115.0 116.0 130.0 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.10 Median:143.00 stddev:5.02 (3.5%) stddev-sans-first:4.11 07:16:48 INFO - PROCESS | 5498 | Values: 133.0 147.0 142.0 143.0 144.0 135.0 150.0 143.0 141.0 143.0 07:16:48 INFO - PROCESS | 5498 | 07:16:48 INFO - PROCESS | 5498 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.45 (2.2%) stddev-sans-first:1.48 07:16:48 INFO - PROCESS | 5498 | Values: 66.0 66.0 68.0 66.0 69.0 67.0 70.0 67.0 66.0 66.0 07:16:48 INFO - PROCESS | 5498 | -------- Summary: end -------- 07:16:48 INFO - PROCESS | 5498 | 07:16:49 INFO - TEST-INFO | 5498: exit 0 07:16:49 INFO - TEST-OK | kraken | took 58591ms 07:16:49 INFO - TEST-START | v8_7 07:16:49 INFO - operating with platform_type : linux_ 07:16:49 INFO - Initialising browser for v8_7 test... 07:16:49 INFO - TEST-INFO | started process 5746 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVcoqzr/profile http://localhost:39644/getInfo.html) 07:16:53 INFO - PROCESS | 5746 | __metrics Screen width/height:1600/1200 07:16:53 INFO - PROCESS | 5746 | colorDepth:24 07:16:53 INFO - PROCESS | 5746 | Browser inner width/height: 1024/697 07:16:53 INFO - PROCESS | 5746 | __metrics 07:16:53 INFO - PROCESS | 5746 | 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:16:53 INFO - PROCESS | 5746 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:16:54 INFO - TEST-INFO | 5746: exit 0 07:16:54 INFO - Browser initialized. 07:16:54 INFO - Running cycle 1/1 for v8_7 test... 07:16:54 INFO - TEST-INFO | started process 5827 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVcoqzr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:06 INFO - PROCESS | 5827 | RSS: Main: 150032384 07:17:06 INFO - PROCESS | 5827 | 07:17:28 INFO - PROCESS | 5827 | Cycle 1(1): loaded http://localhost:39644/tests/v8_7/run.html (next: http://localhost:39644/tests/v8_7/run.html) 07:17:28 INFO - PROCESS | 5827 | RSS: Main: 603131904 07:17:28 INFO - PROCESS | 5827 | 07:17:28 INFO - PROCESS | 5827 | __start_tp_report 07:17:28 INFO - PROCESS | 5827 | _x_x_mozilla_page_load 07:17:28 INFO - PROCESS | 5827 | _x_x_mozilla_page_load_details 07:17:28 INFO - PROCESS | 5827 | |i|pagename|runs| 07:17:28 INFO - PROCESS | 5827 | |0;Richards;167.33601070950468 07:17:28 INFO - PROCESS | 5827 | |1;DeltaBlue;188.85741265344666 07:17:28 INFO - PROCESS | 5827 | |2;Encrypt;280.8199943836001 07:17:28 INFO - PROCESS | 5827 | |3;Decrypt;5251.308900523561 07:17:28 INFO - PROCESS | 5827 | |4;RayTrace;1960.7843137254902 07:17:28 INFO - PROCESS | 5827 | |5;Earley;794.912559618442 07:17:28 INFO - PROCESS | 5827 | |6;Boyer;12456.79012345679 07:17:28 INFO - PROCESS | 5827 | |7;RegExp;42729.166666666664 07:17:28 INFO - PROCESS | 5827 | |8;Splay;651.4657980456026 07:17:28 INFO - PROCESS | 5827 | |9;NavierStokes;4830.917874396136 07:17:28 INFO - PROCESS | 5827 | __end_tp_report 07:17:28 INFO - PROCESS | 5827 | __startTimestamp1452957448954__endTimestamp 07:17:28 INFO - PROCESS | 5827 | 07:17:28 INFO - PROCESS | 5827 | ------- Summary: start ------- 07:17:28 INFO - PROCESS | 5827 | Number of tests: 10 07:17:28 INFO - PROCESS | 5827 | 07:17:28 INFO - PROCESS | 5827 | [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 07:17:28 INFO - PROCESS | 5827 | Values: 167.3 07:17:28 INFO - PROCESS | 5827 | 07:17:28 INFO - PROCESS | 5827 | [#1] DeltaBlue Cycles:1 Average:188.86 Median:188.86 stddev:0.00 (0.0%) 07:17:28 INFO - PROCESS | 5827 | Values: 188.9 07:17:28 INFO - PROCESS | 5827 | 07:17:28 INFO - PROCESS | 5827 | [#2] Encrypt Cycles:1 Average:280.82 Median:280.82 stddev:0.00 (0.0%) 07:17:28 INFO - PROCESS | 5827 | Values: 280.8 07:17:28 INFO - PROCESS | 5827 | 07:17:28 INFO - PROCESS | 5827 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 07:17:28 INFO - PROCESS | 5827 | Values: 5251.3 07:17:28 INFO - PROCESS | 5827 | 07:17:28 INFO - PROCESS | 5827 | [#4] RayTrace Cycles:1 Average:1960.78 Median:1960.78 stddev:0.00 (0.0%) 07:17:28 INFO - PROCESS | 5827 | Values: 1960.8 07:17:28 INFO - PROCESS | 5827 | 07:17:28 INFO - PROCESS | 5827 | [#5] Earley Cycles:1 Average:794.91 Median:794.91 stddev:0.00 (0.0%) 07:17:28 INFO - PROCESS | 5827 | Values: 794.9 07:17:28 INFO - PROCESS | 5827 | 07:17:28 INFO - PROCESS | 5827 | [#6] Boyer Cycles:1 Average:12456.79 Median:12456.79 stddev:0.00 (0.0%) 07:17:28 INFO - PROCESS | 5827 | Values: 12456.8 07:17:28 INFO - PROCESS | 5827 | 07:17:28 INFO - PROCESS | 5827 | [#7] RegExp Cycles:1 Average:42729.17 Median:42729.17 stddev:0.00 (0.0%) 07:17:28 INFO - PROCESS | 5827 | Values: 42729.2 07:17:28 INFO - PROCESS | 5827 | 07:17:28 INFO - PROCESS | 5827 | [#8] Splay Cycles:1 Average:651.47 Median:651.47 stddev:0.00 (0.0%) 07:17:28 INFO - PROCESS | 5827 | Values: 651.5 07:17:28 INFO - PROCESS | 5827 | 07:17:28 INFO - PROCESS | 5827 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:17:28 INFO - PROCESS | 5827 | Values: 4830.9 07:17:28 INFO - PROCESS | 5827 | -------- Summary: end -------- 07:17:28 INFO - PROCESS | 5827 | 07:17:29 INFO - TEST-INFO | 5827: exit 0 07:17:29 INFO - TEST-OK | v8_7 | took 40116ms 07:17:29 INFO - SUITE-END | took 1211s 07:17:29 INFO - Completed test suite (00:20:11) 07:17:29 INFO - Working with test: dromaeo_css 07:17:29 INFO - Generating results file: dromaeo_css 07:17:29 INFO - Working with test: kraken 07:17:29 INFO - Generating results file: kraken 07:17:29 INFO - javascript benchmark 07:17:29 INFO - Working with test: v8_7 07:17:29 INFO - Generating results file: v8_7 07:17:29 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:17:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 07:17:30 INFO - process_Request line: dromaeo_css 6738.45 graph.html#tests=[[72,63,35]] 07:17:30 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:17:30 INFO - process_Request line: kraken 1495.30 graph.html#tests=[[232,63,35]] 07:17:30 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:17:30 INFO - process_Request line: v8_7 18688.00 graph.html#tests=[[230,63,35]] 07:17:30 INFO - RETURN: dromaeo_css: 6738.45 07:17:30 INFO - RETURN: kraken: 1495.30 07:17:30 INFO - RETURN: v8_7: 18688.00 07:17:30 INFO - javascript benchmark 07:17:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3059.1042401948603, 3078.4458797416464, 3113.3461972985674, 3123.4065527549765, 3133.5143052826807, 4887.095887260854, 4914.926276105862, 4957.429895562007, 4964.726940018298, 4994.925076123861, 4959.528844759742, 5017.397912250535, 5034.270030845525, 5046.7224302663335, 5116.565091967178, 4579.221532339502, 4630.74530900802, 4646.86059418218, 4701.647376446763, 4702.670813043088, 4603.838865639704, 4688.437387513486, 4710.458297295821, 4710.952890471086, 4734.668573199878, 4544.727316361029, 4625.7687115644085, 4650.86047418578, 4701.694389864648, 4712.458067322267, 4554.726716397026, 4595.9310610340535, 4609.078184363141, 4619.399478067863, 4625.976870115662, 4569.973998080931, 4573.245414506602, 4577.404937358156, 4620.838270660511, 4628.629709623256, 4739.6208303336, 4843.0, 4859.829905953275, 4863.562279394871, 4924.285978533128, 5394.946050539523, 5409.891802163935, 5431.918521222185, 5432.592555558349, 5478.123500239983, 5404.216388623628, 5415.783368665248, 5430.239766432703, 5430.67415955044, 5433.049216387117, 5025.84922452327, 5091.05815424144, 5098.08234517783, 5113.974430127825, 5146.6911985281, 5504.587155963239, 5526.281583394133, 5532.5573954083575, 5539.196816461671, 5566.35986861508, 5336.092864213093, 5339.225812257278, 5343.385510666323, 5347.0375332440535, 5397.028534863763, 5335.199720042025, 5391.784328626811, 5416.945830541723, 5425.83722488326, 5446.537044351275, 5354.036273470735, 5377.623566350318, 5386.084365657847, 5387.676739395649, 5390.649607775482, 5397.676139431646, 5409.43200963901, 5415.241866138744, 5418.133098704188, 5464.480874316933, 4204.201201771653, 4211.073563816017, 4239.025024244441, 4245.745255284693, 4271.893202669896, 3816.5420149581673, 3817.3892177251505, 3818.1790914953417, 3838.1556057667267, 3850.8459661613783, 5012.147934851011, 5025.522575355335, 5025.623078269071, 5028.522290382408, 5038.899222015539, 5300.0, 5396.028714831289, 5425.186222066722, 5466.863328416742, 5516.14499752539, 4969.900601988013, 4983.103041452501, 4985.277134815431, 5005.3242812220615, 5023.472535383805, 4597.241455159861, 4632.884177895512, 4640.559146881041, 4682.719036857799, 4725.692829966041, 5571.66570005801, 5599.104143337128, 5636.887262254814, 5656.773729050874, 5712.428757124254, 5400.243965844864, 5425.891482170256, 5426.0504411727, 5429.077056900415, 5430.728463576726, 5498.560115190855, 5583.637063590853, 5611.270534830446, 5624.465675760796, 5679.971600141973, 5350.197470379474, 5410.59420543453, 5412.377576578744, 5414.485623865727, 5429.511343979061, 5393.002294575516, 5433.375161856437, 5435.537979271806, 5435.701036443033, 5481.917771233514, 5235.869103272448, 5280.551153152025, 5320.14877619579, 5331.653442526223, 5333.306670132858, 5293.047251494768, 5311.840644780663, 5314.681119132864, 5315.495027972336, 5342.759575819176, 5176.094183517945, 5225.764840582259, 5232.005918875401, 5240.4759524047295, 5264.289320941624, 5175.948240517547, 5293.708846013506, 5296.602754793483, 5307.575393968396, 5319.308489896289, 5235.083860324352, 5254.238135470412, 5256.001359741636, 5256.10646190141, 5260.105782017143], "unit": "score", "name": "dojo.html", "value": 5002.433237985966}, {"lowerIsBetter": false, "replicates": [522.4383787428516, 544.0750723769592, 557.342336043469, 565.0309718832202, 579.4726798613262, 30631.7836627154, 31274.84362578184, 31278.68721312786, 31306.686933130663, 31341.903033393864, 32237.194070148256, 32863.0, 32887.99999999994, 36876.446853297224, 37639.05902352442, 8569.91430085699, 8771.649134034662, 8772.517511536864, 8773.298136149093, 8773.385862989593, 8517.105703901063, 8636.740897773045, 8646.870296945552, 8650.913490865074, 8650.913490865105, 8629.352798540103, 8687.044425113232, 8694.434861733967, 8696.21734043936, 8699.913000869974, 8556.358273129508, 8615.784605384853, 8629.784255393666, 8630.395872288942, 8649.65401383944, 8487.40588158829, 8591.5704214789, 8608.913910860874, 8624.870626940601, 8630.697925572575, 39648.80175599132, 39859.40210896839, 40195.39706904399, 40260.59739402598, 40301.39547906784, 3064.8161110333226, 3112.237501812048, 3356.412627790127, 3825.2731980923536, 3847.4228865670093, 29079.41841163186, 29229.707702923122, 29801.850990744908, 30309.545356819664, 30878.382432351453, 3880.4373365861793, 3952.426898099788, 4026.617471340218, 4049.696272779524, 4095.8566450174103, 259588.0, 261197.0, 261828.0, 261995.9999999981, 263640.0, 53826.461735382145, 54695.45304546983, 59989.0, 61142.0, 61159.0, 53559.0, 54341.72829135829, 54414.18378724322, 54441.45558544364, 54570.0, 13660.521881734092, 13785.51750688721, 13991.720165596631, 14010.789838152436, 14104.717905642035, 11060.612878549373, 11254.21220514556, 11312.604058858065, 11318.717032074264, 11337.922897324741, 19492.809046055165, 20397.0, 20496.487587810425, 20603.484912876997, 20666.793332066485, 7620.0, 7706.7687969361, 7772.727954521564, 7793.64928578204, 7823.491473054233, 932.4079209701753, 1015.6749840051112, 1016.8627235323137, 1028.290479569095, 1084.1814430105221, 28350.724217410265, 28401.57397638996, 28545.85727071393, 28618.427631447255, 29090.854545727136, 1039.147898723055, 1057.2282233969245, 1141.6517962021662, 1206.4209179593668, 1218.7318789866215, 14690.632734181518, 14699.191544464944, 14987.175705336093, 15201.923990379977, 15279.159646219343, 335713.0, 339992.0, 340689.0, 341074.0, 341264.0, 51857.48142518602, 52206.21690674643, 52247.0, 52280.47719522832, 52292.0, 1293.1012946002438, 1313.750387426405, 1318.45284207053, 1319.2546211390534, 1342.328835582209, 26941.0, 27522.587161192198, 27882.302942426602, 27917.441651167268, 28017.71982280151, 46536.301955470015, 47059.29411058906, 47067.0, 47075.52782485658, 47095.293570595786, 300626.0, 301338.0, 301836.0, 302055.0, 302321.0, 28094.0, 28481.715182847907, 32086.0, 32188.356232875678, 32805.17987050343, 37189.25621487609, 37243.25513489769, 37362.25275494529, 38107.23785524219, 38171.23657526779, 31870.52194217042, 32098.358032838747, 32207.14676208973, 32335.838320808245, 32519.837400812845, 28507.714922851337, 31560.52659210068, 33743.4938475928, 34433.0, 34494.65505345015, 31656.525152122274, 31982.840085799424, 32356.676433235367, 32386.514202286515, 32399.0, 27030.459390812466, 29198.7080129196, 29496.0, 29773.70226297796, 29788.55317170201, 23494.412639684146, 23989.640155398032, 24013.159539416036, 24067.27798166058, 24127.396815079763], "unit": "score", "name": "ext.html", "value": 17866.464276920062}, {"lowerIsBetter": false, "replicates": [365.512041424698, 367.366293144326, 367.9742418030739, 368.0798004987531, 373.4659437005085, 13084.411201495932, 13123.606291811237, 15746.527604171879, 16132.274047667854, 16842.831571684295, 9972.601095956154, 10327.0, 16484.0, 16875.240614172362, 16908.915455422735, 4439.356293337464, 4997.125503036972, 4997.550220480156, 4999.425066117388, 5001.324821149153, 3716.907077323075, 3878.224355128971, 4932.038252540756, 4972.353594032771, 5152.92270615941, 5307.787688492475, 5319.494648008453, 5338.252644629755, 5365.195220716884, 5371.113766228567, 5146.0, 5373.301470808769, 5381.300430943952, 5382.0, 5385.623006389555, 5030.647854650176, 5146.3824341078935, 5151.4333423323405, 5152.149895267276, 5288.180332048539, 19115.23539058436, 19726.13970974215, 19853.9007304964, 19878.403647890587, 19904.20383184671, 1954.687250040001, 2058.5779915117514, 2067.1524674883376, 2073.409078412645, 2192.243675931801, 9582.472963986978, 12133.696657583543, 12233.204841685261, 12457.563985260564, 13028.739425211443, 1793.2378739035858, 1868.5141863115552, 1883.0, 1900.686386746199, 1907.8473722102199, 54036.72981635106, 55321.44678553203, 55603.0, 55673.721631391985, 56125.71937140329, 9799.461029643438, 9899.851502227473, 10111.241656875764, 10133.847992280122, 10170.542325595366, 13305.933470332586, 13384.531541396005, 13384.598462046155, 13429.0, 13436.932815336057, 7051.435885129177, 7130.572165670076, 7266.309700578437, 7269.563826170447, 7336.193018767931, 6927.099477067949, 6935.133108361455, 6972.1284839395075, 7020.403265722369, 7029.753958611424, 4329.220740266719, 4367.759773212504, 4368.672349573794, 4394.736315820997, 4409.603135717736, 1702.4126676296657, 1718.5789481577094, 1782.1712903499676, 1818.9818101819078, 1834.7981722010568, 905.0813424374265, 983.4885859353096, 989.2827699917502, 993.8062077894741, 1063.0645032371617, 13323.800142997863, 14571.635709107146, 16042.197890105448, 16453.753193702105, 16478.176091195393, 931.8648795924553, 933.6482029514077, 960.7261930349956, 978.5449765858909, 987.0080569028224, 8789.165029322205, 9069.093090690878, 9074.411977903841, 9194.12655797698, 9229.215516681157, 500052.0, 503796.0, 514530.0, 515109.0, 515983.0, 70089.0, 70771.64614176999, 72781.0, 72860.63569682118, 74273.6286318565, 1037.7768779712399, 1047.3035431438009, 1063.0485715284776, 1077.8329358949375, 1080.1412876762993, 14006.64983375383, 14349.210793406046, 14397.280135992949, 14677.0, 14690.192039437934, 31995.200119997186, 32709.836450817595, 32853.01440956775, 33228.66771332353, 33243.16892077717, 40012.59987400089, 41199.382009269284, 41712.0, 42012.0, 42228.98824611657, 6788.796336109727, 7042.401395881408, 7463.626818659154, 7511.0, 7574.659140338808, 8375.288100511525, 10687.46562671879, 11081.002709756161, 11468.254563453349, 11487.597934072268, 8969.327300452362, 9501.192398645917, 9703.466309353053, 9820.263480238867, 9923.454210018519, 9380.765480863032, 9436.764080898032, 9609.807803844024, 9865.605375784888, 9993.750156246151, 9446.38598491096, 9810.313278070467, 10027.398356098658, 10081.89918100839, 10309.123724483203, 7105.467089968376, 7147.714091436493, 7164.068671072727, 7193.172785129568, 7577.393808495197, 7555.962220188864, 9735.464549449565, 9790.75523111928, 9948.204143668634, 10089.243306751876], "unit": "score", "name": "jquery.html", "value": 8001.784616486415}, {"lowerIsBetter": false, "replicates": [1302.4204229118047, 1486.4425840309884, 1494.3574263066885, 1643.3344495479328, 1801.0184449475043, 6707.396334329909, 7371.373433258173, 7543.547387156775, 7565.205653406396, 7567.3567746741455, 7473.738419155331, 7635.961820190905, 7642.503237289572, 7649.502782319146, 7665.5783931883725, 2023.5143565544238, 2063.731714877064, 2069.1309649946984, 2307.665388518664, 2329.988350058256, 2296.7588403217674, 2355.458244603742, 2363.9290821275304, 2366.4557151854997, 2366.656834758959, 2264.6376579747243, 2280.703508543887, 2309.90760369585, 2320.211128216406, 2323.488832456857, 2299.609066458706, 2304.942376440594, 2314.0628045641456, 2317.4901521665206, 2353.5410594933996, 2316.096722278313, 2326.732425771041, 2333.5449587330477, 2335.5795956727784, 2348.97651023491, 7597.924020759832, 7623.695052197905, 7630.4658673892845, 7636.69453221876, 7639.541627502367, 4685.1332503486965, 4783.354247176656, 4785.0, 4787.210110331791, 4791.065742180276, 3003.2041509000132, 3055.434744572261, 3120.0, 3124.562561241428, 3133.357661679373, 1000.8848982367048, 1010.5553556435218, 1013.8834034086101, 1041.927065105443, 1052.6841947415744, 10388.740281492948, 10475.58097676092, 10528.0, 10548.20888433363, 10569.207309451745, 4345.9348109778375, 4430.490493593278, 4507.166174257773, 4529.433820772403, 4533.84131555394, 9216.124468175512, 9221.90778092224, 9230.53847307632, 9236.0, 9256.907430925605, 4950.282209079735, 4972.8508144755715, 4978.5270399312, 4992.500749924979, 4994.001199760062, 4404.493483249467, 4412.139632771643, 4454.643628509712, 4456.888577785581, 4463.464384273908, 3516.542849429609, 3594.2991116731987, 3596.118950857057, 3679.742418030712, 3748.7938163401277, 1261.779188641984, 1266.7339858629607, 1271.6439396968863, 1272.8981681465461, 1282.8139919711589, 1305.556110922291, 1308.7578797922415, 1313.6453157647381, 1329.4815022141372, 1329.667583104224, 7121.89317160243, 7133.251008644018, 7150.5352152109945, 7159.463040272, 7167.605781682058, 1100.1528822806395, 1104.089126470665, 1129.9378534180535, 1131.216082205023, 1132.422464543089, 5676.233708449389, 5743.913841292384, 5747.0, 5750.4249575042995, 5761.0, 8910.064443233498, 8913.331500137516, 9004.684836030707, 9007.774805629911, 9121.224695900923, 8877.600507977157, 8880.955595221982, 9001.819963600823, 9051.185393314501, 9080.273578113734, 6929.099217101744, 7054.329838665216, 7073.71705131789, 7082.39799617028, 7136.607486588287, 6854.794356169323, 6875.5874647521305, 6887.035814986006, 6892.241853396223, 6895.827604309932, 7893.329067029367, 7921.485103468256, 7968.123506414406, 7989.121196668478, 8039.919600803917, 8173.18268173178, 8370.665173392996, 8488.74533763988, 8505.319574434154, 8511.787205319917, 6838.487113466411, 6848.3494068063455, 6862.279460656759, 6911.205211400552, 6919.273476285119, 6226.40849119333, 6320.873582528232, 6887.381465355537, 7064.894026589708, 7355.374793142429, 6741.0, 6748.93251067483, 6795.0, 6857.828554286183, 6924.4460443165435, 6660.83347916306, 6694.263631000488, 6704.899426508704, 6763.053172555748, 6866.828329291608, 6784.728610855511, 7011.0, 7011.894821577578, 7014.473914456335, 7023.086998690138, 6268.216472940882, 6291.119243306032, 6341.319550319077, 6362.904556431565, 6394.808155755335, 6368.395002474757, 6381.680915954276, 6429.7749578764515, 6435.839104022437, 6457.031445283057], "unit": "score", "name": "mootools.html", "value": 4474.050635439221}, {"lowerIsBetter": false, "replicates": [337.7146311366895, 344.5503617778799, 348.3398958972745, 348.808155514467, 352.85674414895743, 5772.538196944245, 5773.989551828429, 5797.072468405061, 5833.941660583393, 5852.561057920651, 5537.197106419567, 5571.359293681227, 5677.914831277524, 5694.060480020791, 5737.684427356494, 4458.554144585548, 4468.75421851798, 4469.50835408104, 4482.932756008662, 4493.191225579394, 4319.568043195687, 4485.416895803557, 4496.055828276066, 4497.505274419811, 4503.0318481526465, 4353.891152721176, 4385.2106620808245, 4427.800748966288, 4462.553744625544, 4481.095534397884, 4419.160359531695, 4428.512863584987, 4437.800298986521, 4439.7780110994645, 4461.08547747711, 3928.194720082376, 3930.3711406174875, 3934.173823497069, 3938.212357528506, 3943.4084887266854, 5387.057264978652, 5480.862978425571, 5492.780288788444, 5493.395726470085, 5501.862453438656, 5107.438181799999, 5113.309703190059, 5115.181570948667, 5116.897662046738, 5117.6161787865685, 6044.637321760709, 6053.606515576474, 6055.2430946131735, 6056.666883321415, 6062.242219722535, 4299.161663475624, 4333.934990975138, 4343.847965321199, 4351.0, 4356.803943822504, 6252.249730032425, 6361.809145725636, 6370.8088757337355, 6379.968100159516, 6399.552031357854, 4424.46906371231, 4427.667924905581, 4432.135733531994, 4436.911261774746, 4438.822447102079, 4489.506154323022, 4490.977545112319, 4491.46102467706, 4494.685372023927, 4497.595216430537, 5112.335396398519, 5124.077666020077, 5129.717865517432, 5138.0, 5147.897042059213, 5997.160397544348, 6150.0, 6155.984262596711, 6158.630482171084, 6161.691915404302, 1582.2800625715272, 1608.5737279620676, 1609.4286528282526, 1609.7022050920616, 1610.8791840612, 1090.7545802194602, 1097.05653138301, 1098.3739268616812, 1105.2926127278547, 1115.9776804463866, 5839.386864379264, 5853.94146058534, 5857.502112320501, 5860.150278209636, 5861.882762344814, 6321.715522801485, 6328.968355158287, 6332.33510481402, 6334.113224148531, 6348.650824204713, 5654.293213348332, 5710.628809127394, 5723.513501352349, 5727.427257274323, 5783.045797443375, 3369.747268954838, 3388.7289016879085, 3397.2016576104597, 3407.522946787452, 3417.79493230407, 6605.834854128685, 6608.801735947929, 6610.6694665267505, 6611.140551728245, 6621.106150669694, 6366.172397588377, 6515.348465153446, 6519.7392104315295, 6549.181352330958, 6549.312322206195, 6628.966855165693, 6645.800625981228, 6647.900281495781, 6657.367550082734, 6665.700043498055, 6314.336994615683, 6340.461060809698, 6343.207099112611, 6354.586951848115, 6354.618722876642, 6157.846053848511, 6276.152719383008, 6301.747930082745, 6304.464120549805, 6315.621062736251, 6640.306721785913, 6649.933500665125, 6653.168353955755, 6653.500987425866, 6663.200415949923, 4514.435695538058, 4525.886852828706, 4530.954690453185, 4532.27483602622, 4533.206688829376, 6231.594946328474, 6357.1735674362035, 6381.8085457436355, 6391.552591318563, 6395.392437718409, 6165.784197553064, 6172.043333283348, 6173.59871608344, 6175.814725558241, 6175.814725558241, 6196.10156527292, 6200.0699895016105, 6205.968970155121, 6208.789286089169, 6211.503079753518, 5992.250968628921, 6048.90926636092, 6099.054646529795, 6114.388561144028, 6116.449519543263, 6195.070739389128, 6196.380361963767, 6205.751769929333, 6250.281217660027, 6274.058891166362, 6105.84735381619, 6110.69446527663, 6114.205153330038, 6115.0, 6118.908216376669], "unit": "score", "name": "prototype.html", "value": 4670.915206444084}, {"lowerIsBetter": false, "replicates": [659.3604203922193, 664.7706541243269, 757.4319260554585, 775.2751177648897, 800.6117033238878, 12746.17149885258, 12894.161879477839, 12966.286854223014, 12973.156744811604, 13010.479580816756, 12082.456289466973, 12093.213941093845, 12151.635450936486, 12163.087768417381, 12173.573924912629, 661.3650895140671, 668.4418510543702, 786.2137862137862, 803.2890891560967, 810.4893916832417, 805.7985503624094, 815.8613035783901, 819.647551552832, 819.7171975668415, 823.7281697039992, 848.6308455821737, 853.9188777066169, 854.581255184958, 855.1576696953496, 855.7133360324299, 701.1200942816757, 712.2628079937266, 835.0688981785296, 858.1418581418582, 859.0636206534907, 621.940915613016, 625.859181684122, 625.9155014073087, 633.1705465839718, 633.262249479356, 12036.0, 12066.9743071839, 12094.697632559168, 12121.878781212252, 12136.635900922987, 12059.216150950248, 12068.456919438559, 12131.939340303243, 12430.067744919168, 12533.874661253361, 10380.896191038144, 10408.219383546264, 10534.894651053544, 10583.15334773224, 10655.893441065646, 3610.097475631092, 3611.783293002402, 3637.8726744563814, 3638.708903287757, 3757.511523501927, 44089.338659919806, 44293.0, 44458.11083778339, 44475.110497789865, 44558.10883782338, 10281.845772313422, 10289.485525723683, 10330.896691033144, 10377.117944974761, 10524.736881577868, 17697.203625836868, 17812.55468613295, 17891.552711182325, 17901.641967160846, 17903.910480447776, 7710.653020613973, 7802.336801371834, 7850.882236766453, 8040.4773689711155, 8152.959235203786, 4381.956180438218, 4438.622717069021, 4442.397864955452, 4449.243628583149, 4514.029483661028, 3015.62304711911, 3055.388922215566, 3059.8623061962267, 3069.938601227963, 3072.8617212225504, 581.1689284323373, 581.316952580716, 585.2771826793906, 587.9235699359142, 609.6159419565645, 478.5406010230218, 547.9397266300704, 642.9327316654332, 666.9333066693389, 684.7021545627667, 8678.956605216934, 8697.869531957025, 8720.171583699539, 8797.12028797115, 8957.820843583091, 555.50837508805, 586.9413058694097, 635.9650219237893, 665.2250128600126, 744.5495475237403, 3936.193080418507, 4029.174019326031, 4045.292073887058, 4104.056067104523, 4157.127003329335, 54796.45203547993, 57449.712751435974, 58267.0, 58298.12552811711, 58448.0, 46195.0, 46417.53582464132, 46643.30035049477, 49115.0, 50269.24596131061, 46233.53766462292, 46389.30416043762, 47065.0, 47261.0, 47387.52612473831, 9047.411918225294, 9118.95440522793, 9165.862512062191, 9211.631534738535, 9219.549961289731, 31583.21041973969, 32455.350892982482, 32483.837580811945, 36103.0, 37097.814510927274, 40071.0, 40351.99120022023, 40560.79719601383, 42610.0, 47585.76207118942, 11361.943190283995, 11770.705732356759, 12078.637640870787, 12086.395680215777, 12112.818307725214, 12246.877531224574, 12323.630291091282, 12633.684157896127, 12638.810417843924, 12736.554220602235, 11703.531858725555, 12069.517219311128, 12128.636140915787, 12241.938790305992, 12661.493540258287, 11862.0, 11872.465739041936, 12086.516539338329, 12117.394130293625, 12183.0, 11591.6522504325, 11614.825777613512, 11762.82355764647, 11836.0, 11927.165098443025, 9293.395929264576, 9306.162445379949, 9417.576209070472, 9721.805563888542, 9732.562034708313, 8892.377533572846, 9129.5891684873, 10222.948885255824, 10248.119702336207, 10350.637727679496], "unit": "score", "name": "yui.html", "value": 6263.414243247175}], "name": "dromaeo_css", "value": 6738.446897848209}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 106.0, 110.0, 111.0, 109.0, 99.0, 108.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [162.0, 126.0, 149.0, 168.0, 135.0, 159.0, 151.0, 131.0, 162.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 160.0, 158.0, 160.0, 159.0, 163.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 104.0, 92.0, 71.0, 81.0, 71.0, 118.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 139.0, 96.0, 96.0, 97.0, 141.0, 96.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 57.0, 56.0, 58.0, 56.0, 58.0, 64.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 81.0, 81.0, 81.0, 82.0, 82.0, 83.0, 81.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [115.0, 120.0, 116.0, 120.0, 113.0, 120.0, 123.0, 115.0, 116.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.8}, {"lowerIsBetter": true, "replicates": [133.0, 147.0, 142.0, 143.0, 144.0, 135.0, 150.0, 143.0, 141.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 66.0, 69.0, 67.0, 70.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1495.2999999999995}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [188.85741265344666], "unit": "score", "name": "DeltaBlue", "value": 350.09481000000017}, {"lowerIsBetter": false, "replicates": [280.8199943836001], "unit": "score", "name": "Encrypt", "value": 947.8705409999999}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1960.7843137254902], "unit": "score", "name": "RayTrace", "value": 377.39439}, {"lowerIsBetter": false, "replicates": [794.912559618442], "unit": "score", "name": "Earley", "value": 838.4104539999996}, {"lowerIsBetter": false, "replicates": [12456.79012345679], "unit": "score", "name": "Boyer", "value": 53.501985133795806}, {"lowerIsBetter": false, "replicates": [42729.166666666664], "unit": "score", "name": "RegExp", "value": 21.319980497318397}, {"lowerIsBetter": false, "replicates": [651.4657980456026], "unit": "score", "name": "Splay", "value": 125.08868499999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 18688.002227248267}]} 07:17:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "18688.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1495.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6738.45"}}} 07:17:30 INFO - Return code: 0 07:17:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:17:30 INFO - # TBPL SUCCESS # 07:17:30 INFO - Running post-action listener: _resource_record_post_action 07:17:30 INFO - Running post-run listener: _resource_record_post_run 07:17:31 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 16384; Write bytes: 304566272; Read time: 96; Write time: 270016 07:17:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1626112; Read time: 0; Write time: 120 07:17:31 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 16384; Write bytes: 302428160; Read time: 96; Write time: 269896 07:17:31 INFO - Running post-run listener: _upload_blobber_files 07:17:31 INFO - Blob upload gear active. 07:17:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:17:31 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:17:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:17:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:17:32 INFO - (blobuploader) - INFO - Open directory for files ... 07:17:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:17:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:17:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:33 INFO - (blobuploader) - INFO - Done attempting. 07:17:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:17:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:17:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:33 INFO - (blobuploader) - INFO - Done attempting. 07:17:33 INFO - (blobuploader) - INFO - Iteration through files over. 07:17:33 INFO - Return code: 0 07:17:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:17:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:17:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2ddc2a32e7b7e98bd6eda140fb9e254ddf4ab1b9d7ab832f7dfa3a64ab63017f91c9191bc608527301a155b448be158289c28a9bdb48e8f6f9525705b70d4759", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b4d6114e750dc362346994de9b55850ea05c29f71fb67d95d678be54abf716ad07560d8d1ea3e758a4609b501ea2ebe365e9e9728813d3ced6b595491fee71d4"} 07:17:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:17:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:17:33 INFO - Contents: 07:17:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2ddc2a32e7b7e98bd6eda140fb9e254ddf4ab1b9d7ab832f7dfa3a64ab63017f91c9191bc608527301a155b448be158289c28a9bdb48e8f6f9525705b70d4759", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b4d6114e750dc362346994de9b55850ea05c29f71fb67d95d678be54abf716ad07560d8d1ea3e758a4609b501ea2ebe365e9e9728813d3ced6b595491fee71d4"} 07:17:33 INFO - Running post-run listener: copy_logs_to_upload_dir 07:17:33 INFO - Copying logs to upload dir... 07:17:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:17:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.899238 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-16 07:17:33.649515) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-16 07:17:33.653125) ========= 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=1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2ddc2a32e7b7e98bd6eda140fb9e254ddf4ab1b9d7ab832f7dfa3a64ab63017f91c9191bc608527301a155b448be158289c28a9bdb48e8f6f9525705b70d4759", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b4d6114e750dc362346994de9b55850ea05c29f71fb67d95d678be54abf716ad07560d8d1ea3e758a4609b501ea2ebe365e9e9728813d3ced6b595491fee71d4"} build_url:https://queue.taskcluster.net/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/GZdVPk13TZ-FQM9Uahx8cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2ddc2a32e7b7e98bd6eda140fb9e254ddf4ab1b9d7ab832f7dfa3a64ab63017f91c9191bc608527301a155b448be158289c28a9bdb48e8f6f9525705b70d4759", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b4d6114e750dc362346994de9b55850ea05c29f71fb67d95d678be54abf716ad07560d8d1ea3e758a4609b501ea2ebe365e9e9728813d3ced6b595491fee71d4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-16 07:17:33.678088) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 07:17:33.678424) ========= 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=1f5564757af27664ca02d71f000001b0-1452942285.949604-2028795898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 07:17:33.765522) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-16 07:17:33.766291) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-16 07:17:33.766969) ========= ========= Total master_lag: 0.32 =========