builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1479135054.77 results: success (0) buildid: 20161114021920 builduid: 34a00fa3aee34299865356c4ee83715c revision: 2d9b6132e7d75327e063a15d8e5e279077adf987 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 06:50:54.770980) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 06:50:54.771524) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 06:50:54.771803) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 06:50:54.814656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:50:54.815039) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 06:50:55-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.4M=0s 2016-11-14 06:50:55 (40.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097116 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:50:54.927760) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:50:54.928075) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014047 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:50:54.978676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 06:50:54.979001) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2d9b6132e7d75327e063a15d8e5e279077adf987 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2d9b6132e7d75327e063a15d8e5e279077adf987 --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 06:50:55,751 truncating revision to first 12 chars 2016-11-14 06:50:55,751 Setting DEBUG logging. 2016-11-14 06:50:55,751 attempt 1/10 2016-11-14 06:50:55,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2d9b6132e7d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 06:50:56,722 unpacking tar archive at: mozilla-aurora-2d9b6132e7d7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.404549 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 06:50:56.396878) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 06:50:56.397196) ========= script_repo_revision: 2d9b6132e7d75327e063a15d8e5e279077adf987 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 06:50:56.397576) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 06:50:56.397838) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 06:50:56.406881) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-11-14 06:50:56.407232) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:50:57 INFO - MultiFileLogger online at 20161114 06:50:57 in /builds/slave/test 06:50:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:50:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:50:57 INFO - {'append_to_log': False, 06:50:57 INFO - 'base_work_dir': '/builds/slave/test', 06:50:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:50:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:50:57 INFO - 'branch': 'Mozilla-Aurora', 06:50:57 INFO - 'buildbot_json_path': 'buildprops.json', 06:50:57 INFO - 'config_files': ('talos/linux_config.py',), 06:50:57 INFO - 'default_actions': ('clobber', 06:50:57 INFO - 'read-buildbot-config', 06:50:57 INFO - 'download-and-extract', 06:50:57 INFO - 'populate-webroot', 06:50:57 INFO - 'create-virtualenv', 06:50:57 INFO - 'install', 06:50:57 INFO - 'run-tests'), 06:50:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:50:57 INFO - 'download_minidump_stackwalk': True, 06:50:57 INFO - 'download_symbols': 'ondemand', 06:50:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:50:57 INFO - 'tooltool.py': '/tools/tooltool.py', 06:50:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:50:57 INFO - '/tools/misc-python/virtualenv.py')}, 06:50:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:50:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:50:57 INFO - 'installer_path': 'installer.exe', 06:50:57 INFO - 'log_level': 'info', 06:50:57 INFO - 'log_name': 'talos', 06:50:57 INFO - 'log_to_console': True, 06:50:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:50:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:50:57 INFO - 'opt_config_files': (), 06:50:57 INFO - 'pip_index': False, 06:50:57 INFO - 'sps_profile': False, 06:50:57 INFO - 'sps_profile_interval': 0, 06:50:57 INFO - 'suite': 'dromaeojs', 06:50:57 INFO - 'system_bits': '32', 06:50:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:50:57 INFO - 'title': 'talos-linux64-ix-012', 06:50:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:50:57 INFO - 'use_talos_json': True, 06:50:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:50:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:50:57 INFO - 'work_dir': 'build'} 06:50:57 INFO - [mozharness: 2016-11-14 14:50:57.278653Z] Running clobber step. 06:50:57 INFO - Running pre-action listener: _resource_record_pre_action 06:50:57 INFO - Running main action method: clobber 06:50:57 INFO - rmtree: /builds/slave/test/build 06:50:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:50:58 INFO - Running post-action listener: _resource_record_post_action 06:50:58 INFO - [mozharness: 2016-11-14 14:50:58.249004Z] Finished clobber step (success) 06:50:58 INFO - [mozharness: 2016-11-14 14:50:58.249107Z] Running read-buildbot-config step. 06:50:58 INFO - Running pre-action listener: _resource_record_pre_action 06:50:58 INFO - Running main action method: read_buildbot_config 06:50:58 INFO - Using buildbot properties: 06:50:58 INFO - { 06:50:58 INFO - "project": "", 06:50:58 INFO - "product": "firefox", 06:50:58 INFO - "script_repo_revision": "production", 06:50:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:50:58 INFO - "repository": "", 06:50:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 06:50:58 INFO - "buildid": "20161114021920", 06:50:58 INFO - "pgo_build": "True", 06:50:58 INFO - "basedir": "/builds/slave/test", 06:50:58 INFO - "buildnumber": 582, 06:50:58 INFO - "slavename": "talos-linux64-ix-012", 06:50:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:50:58 INFO - "platform": "ubuntu64_hw", 06:50:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:50:58 INFO - "branch": "mozilla-aurora", 06:50:58 INFO - "repo_path": "releases/mozilla-aurora", 06:50:58 INFO - "revision": "2d9b6132e7d75327e063a15d8e5e279077adf987", 06:50:58 INFO - "stage_platform": "linux64-pgo", 06:50:58 INFO - "builduid": "34a00fa3aee34299865356c4ee83715c", 06:50:58 INFO - "slavebuilddir": "test" 06:50:58 INFO - } 06:50:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 06:50:58 INFO - Running post-action listener: _resource_record_post_action 06:50:58 INFO - [mozharness: 2016-11-14 14:50:58.251573Z] Finished read-buildbot-config step (success) 06:50:58 INFO - [mozharness: 2016-11-14 14:50:58.251664Z] Running download-and-extract step. 06:50:58 INFO - Running pre-action listener: _resource_record_pre_action 06:50:58 INFO - Running main action method: download_and_extract 06:50:58 INFO - mkdir: /builds/slave/test/build/tests 06:50: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:58 INFO - trying https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 06:50:58 INFO - Downloading https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 06:50:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:50:58 INFO - Downloaded 1361 bytes. 06:50:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 06:50:58 INFO - Using the following test package requirements: 06:50:58 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 06:50:58 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:50:58 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:50:58 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'jsshell-linux-x86_64.zip'], 06:50:58 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:50:58 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 06:50:58 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:50:58 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:50:58 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:50:58 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:50:58 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:50:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 06:50:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:50:58 INFO - Fetch https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 06:50:59 INFO - Expected file size: 21962209 06:51:03 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:51:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 06:51:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:51:03 INFO - Fetch https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 06:51:04 INFO - Expected file size: 21962209 06:51:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 06:51:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:51:09 INFO - Fetch https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 06:51:09 INFO - Expected file size: 14414089 06:51:10 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:10 INFO - trying https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 06:51:10 INFO - Downloading https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 06:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:51:11 INFO - Downloaded 64088036 bytes. 06:51:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 06:51:11 INFO - mkdir: /builds/slave/test/properties 06:51:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:51:11 INFO - Writing to file /builds/slave/test/properties/build_url 06:51:11 INFO - Contents: 06:51:11 INFO - build_url:https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 06:51:11 INFO - Running post-action listener: _resource_record_post_action 06:51:11 INFO - Running post-action listener: set_extra_try_arguments 06:51:11 INFO - [mozharness: 2016-11-14 14:51:11.951076Z] Finished download-and-extract step (success) 06:51:11 INFO - [mozharness: 2016-11-14 14:51:11.951305Z] Running populate-webroot step. 06:51:11 INFO - Running pre-action listener: _resource_record_pre_action 06:51:11 INFO - Running main action method: populate_webroot 06:51:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:51:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:51:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:51:11 INFO - '--tppagecycles', 06:51:11 INFO - '7'], 06:51:11 INFO - 'tests': ['tsvgm']}}, 06:51:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:51:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:51:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:51:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:51:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:51:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:51:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:11 INFO - 'talos_options': ['--disable-e10s'], 06:51:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:11 INFO - 'talos_options': ['--disable-e10s'], 06:51:11 INFO - 'tests': ['damp', 'tps']}, 06:51:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:11 INFO - 'tests': ['damp', 'tps']}, 06:51:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:51:11 INFO - 'tests': ['dromaeo_dom']}, 06:51:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:51:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:51:11 INFO - 'tests': ['basic_compositor_video']}, 06:51:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:51:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:51:11 INFO - 'tests': ['a11yr', 06:51:11 INFO - 'ts_paint', 06:51:11 INFO - 'tpaint', 06:51:11 INFO - 'sessionrestore', 06:51:11 INFO - 'sessionrestore_no_auto_restore', 06:51:11 INFO - 'tabpaint']}, 06:51:11 INFO - 'other-e10s': {'tests': ['a11yr', 06:51:11 INFO - 'ts_paint', 06:51:11 INFO - 'tpaint', 06:51:11 INFO - 'sessionrestore', 06:51:11 INFO - 'sessionrestore_no_auto_restore', 06:51:11 INFO - 'tabpaint']}, 06:51:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:51:11 INFO - 'ts_paint', 06:51:11 INFO - 'tpaint', 06:51:11 INFO - 'sessionrestore', 06:51:11 INFO - 'sessionrestore_no_auto_restore', 06:51:11 INFO - 'tabpaint']}, 06:51:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:51:11 INFO - 'ts_paint', 06:51:11 INFO - 'tpaint', 06:51:11 INFO - 'sessionrestore', 06:51:11 INFO - 'sessionrestore_no_auto_restore', 06:51:11 INFO - 'tabpaint']}, 06:51:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:51:11 INFO - 'tests': ['a11yr', 06:51:11 INFO - 'ts_paint', 06:51:11 INFO - 'tpaint', 06:51:11 INFO - 'sessionrestore', 06:51:11 INFO - 'sessionrestore_no_auto_restore', 06:51:11 INFO - 'tabpaint']}, 06:51:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:51:11 INFO - 'tests': ['a11yr', 06:51:11 INFO - 'ts_paint', 06:51:11 INFO - 'tpaint', 06:51:11 INFO - 'sessionrestore', 06:51:11 INFO - 'sessionrestore_no_auto_restore', 06:51:11 INFO - 'tabpaint']}, 06:51:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:51:11 INFO - 'tests': ['tsvgx', 06:51:11 INFO - 'tsvgr_opacity', 06:51:11 INFO - 'tart', 06:51:11 INFO - 'tscrollx', 06:51:11 INFO - 'cart']}, 06:51:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:51:11 INFO - 'tsvgr_opacity', 06:51:11 INFO - 'tart', 06:51:11 INFO - 'tscrollx', 06:51:11 INFO - 'cart']}, 06:51:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:11 INFO - 'talos_options': ['--disable-e10s'], 06:51:11 INFO - 'tests': ['tp5o']}, 06:51:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:11 INFO - 'tests': ['tp5o']}, 06:51:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:11 INFO - 'talos_options': ['--disable-e10s', 06:51:11 INFO - '--xperf_path', 06:51:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:11 INFO - 'tests': ['tp5n']}, 06:51:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:11 INFO - 'talos_options': ['--xperf_path', 06:51:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:11 INFO - 'tests': ['tp5n']}}, 06:51:11 INFO - 'talos.zip': {'path': '', 06:51:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:51:11 INFO - Running post-action listener: _resource_record_post_action 06:51:11 INFO - [mozharness: 2016-11-14 14:51:11.973394Z] Finished populate-webroot step (success) 06:51:11 INFO - [mozharness: 2016-11-14 14:51:11.973483Z] Running create-virtualenv step. 06:51:11 INFO - Running pre-action listener: _resource_record_pre_action 06:51:11 INFO - Running main action method: create_virtualenv 06:51:11 INFO - Creating virtualenv /builds/slave/test/build/venv 06:51:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:51:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:51:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:51:12 INFO - Using real prefix '/usr' 06:51:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:51:12 INFO - Installing distribute.............................................................................................................................................................................................done. 06:51:14 INFO - Installing pip.................done. 06:51:14 INFO - Return code: 0 06:51:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:51:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fac8e607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4f60>, '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 0x14c5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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:51:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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/build 06:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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:51:14 INFO - Using env: {'DISPLAY': ':0', 06:51:14 INFO - 'HOME': '/home/cltbld', 06:51:14 INFO - 'LANG': 'en_US.UTF-8', 06:51:14 INFO - 'LANGUAGE': 'en_US:en', 06:51:14 INFO - 'LOGNAME': 'cltbld', 06:51:14 INFO - 'MAIL': '/var/mail/cltbld', 06:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:14 INFO - 'MOZ_NO_REMOTE': '1', 06:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:14 INFO - 'NO_EM_RESTART': '1', 06:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:14 INFO - 'PWD': '/builds/slave/test', 06:51:14 INFO - 'SHELL': '/bin/bash', 06:51:14 INFO - 'SHLVL': '1', 06:51:14 INFO - 'TERM': 'linux', 06:51:14 INFO - 'TMOUT': '86400', 06:51:14 INFO - 'USER': 'cltbld', 06:51:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', 06:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:14 INFO - '_': '/tools/buildbot/bin/python'} 06:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:14 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:51:14 INFO - Cleaning up... 06:51:14 INFO - Return code: 0 06:51:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:51:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac8e607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4f60>, '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 0x14c5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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:51:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 06:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 06:51:14 INFO - Using env: {'DISPLAY': ':0', 06:51:14 INFO - 'HOME': '/home/cltbld', 06:51:14 INFO - 'LANG': 'en_US.UTF-8', 06:51:14 INFO - 'LANGUAGE': 'en_US:en', 06:51:14 INFO - 'LOGNAME': 'cltbld', 06:51:14 INFO - 'MAIL': '/var/mail/cltbld', 06:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:14 INFO - 'MOZ_NO_REMOTE': '1', 06:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:14 INFO - 'NO_EM_RESTART': '1', 06:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:14 INFO - 'PWD': '/builds/slave/test', 06:51:14 INFO - 'SHELL': '/bin/bash', 06:51:14 INFO - 'SHLVL': '1', 06:51:14 INFO - 'TERM': 'linux', 06:51:14 INFO - 'TMOUT': '86400', 06:51:14 INFO - 'USER': 'cltbld', 06:51:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', 06:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:14 INFO - '_': '/tools/buildbot/bin/python'} 06:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:14 INFO - Downloading/unpacking psutil>=3.1.1 06:51:14 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:51:14 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:51:14 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:51:14 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:51:14 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:51:14 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:51:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:51:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:17 INFO - Installing collected packages: psutil 06:51:17 INFO - Running setup.py install for psutil 06:51:17 INFO - building 'psutil._psutil_linux' extension 06:51:17 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:51:17 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:51:17 INFO - building 'psutil._psutil_posix' extension 06:51:17 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:51:17 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:51:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:17 INFO - Successfully installed psutil 06:51:17 INFO - Cleaning up... 06:51:17 INFO - Return code: 0 06:51:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:51: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac8e607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4f60>, '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 0x14c5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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:51:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 06:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 06:51:17 INFO - Using env: {'DISPLAY': ':0', 06:51:17 INFO - 'HOME': '/home/cltbld', 06:51:17 INFO - 'LANG': 'en_US.UTF-8', 06:51:17 INFO - 'LANGUAGE': 'en_US:en', 06:51:17 INFO - 'LOGNAME': 'cltbld', 06:51:17 INFO - 'MAIL': '/var/mail/cltbld', 06:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:17 INFO - 'MOZ_NO_REMOTE': '1', 06:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:17 INFO - 'NO_EM_RESTART': '1', 06:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:17 INFO - 'PWD': '/builds/slave/test', 06:51:17 INFO - 'SHELL': '/bin/bash', 06:51:17 INFO - 'SHLVL': '1', 06:51:17 INFO - 'TERM': 'linux', 06:51:17 INFO - 'TMOUT': '86400', 06:51:17 INFO - 'USER': 'cltbld', 06:51:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', 06:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:17 INFO - '_': '/tools/buildbot/bin/python'} 06:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:51:17 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:51:17 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:51:17 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:51:17 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:51:17 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:51:17 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:51:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:51:19 INFO - Installing collected packages: mozsystemmonitor 06:51:19 INFO - Running setup.py install for mozsystemmonitor 06:51:19 INFO - Successfully installed mozsystemmonitor 06:51:19 INFO - Cleaning up... 06:51:19 INFO - Return code: 0 06:51:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac8e607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4f60>, '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 0x14c5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 06:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 06:51:19 INFO - Using env: {'DISPLAY': ':0', 06:51:19 INFO - 'HOME': '/home/cltbld', 06:51:19 INFO - 'LANG': 'en_US.UTF-8', 06:51:19 INFO - 'LANGUAGE': 'en_US:en', 06:51:19 INFO - 'LOGNAME': 'cltbld', 06:51:19 INFO - 'MAIL': '/var/mail/cltbld', 06:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:19 INFO - 'MOZ_NO_REMOTE': '1', 06:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:19 INFO - 'NO_EM_RESTART': '1', 06:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:19 INFO - 'PWD': '/builds/slave/test', 06:51:19 INFO - 'SHELL': '/bin/bash', 06:51:19 INFO - 'SHLVL': '1', 06:51:19 INFO - 'TERM': 'linux', 06:51:19 INFO - 'TMOUT': '86400', 06:51:19 INFO - 'USER': 'cltbld', 06:51:19 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', 06:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:19 INFO - '_': '/tools/buildbot/bin/python'} 06:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:20 INFO - Downloading/unpacking jsonschema==2.5.1 06:51:20 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:51:20 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:51:20 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:51:20 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:51:20 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:51:20 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:51:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:51:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:51:22 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:51:22 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:51:22 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:51:22 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:51:22 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:51:22 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:51:22 INFO - Downloading functools32-3.2.3-2.tar.gz 06:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:51:22 INFO - warning: no files found matching '*.txt' 06:51:22 INFO - no previously-included directories found matching 'build' 06:51:22 INFO - no previously-included directories found matching 'dist' 06:51:22 INFO - no previously-included directories found matching '.git*' 06:51:22 INFO - Installing collected packages: jsonschema, functools32 06:51:22 INFO - Running setup.py install for functools32 06:51:22 INFO - warning: no files found matching '*.txt' 06:51:22 INFO - no previously-included directories found matching 'build' 06:51:22 INFO - no previously-included directories found matching 'dist' 06:51:22 INFO - no previously-included directories found matching '.git*' 06:51:22 INFO - Successfully installed jsonschema functools32 06:51:22 INFO - Cleaning up... 06:51:22 INFO - Return code: 0 06:51:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:51: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac8e607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4f60>, '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 0x14c5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 functools32==3.2.3-2 06:51:22 INFO - Using env: {'DISPLAY': ':0', 06:51:22 INFO - 'HOME': '/home/cltbld', 06:51:22 INFO - 'LANG': 'en_US.UTF-8', 06:51:22 INFO - 'LANGUAGE': 'en_US:en', 06:51:22 INFO - 'LOGNAME': 'cltbld', 06:51:22 INFO - 'MAIL': '/var/mail/cltbld', 06:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:22 INFO - 'MOZ_NO_REMOTE': '1', 06:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:22 INFO - 'NO_EM_RESTART': '1', 06:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:22 INFO - 'PWD': '/builds/slave/test', 06:51:22 INFO - 'SHELL': '/bin/bash', 06:51:22 INFO - 'SHLVL': '1', 06:51:22 INFO - 'TERM': 'linux', 06:51:22 INFO - 'TMOUT': '86400', 06:51:22 INFO - 'USER': 'cltbld', 06:51:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', 06:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:22 INFO - '_': '/tools/buildbot/bin/python'} 06:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:51:22 INFO - Cleaning up... 06:51:22 INFO - Return code: 0 06:51:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:51: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fac8e607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4f60>, '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 0x14c5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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/build 06:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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:51:22 INFO - Using env: {'DISPLAY': ':0', 06:51:22 INFO - 'HOME': '/home/cltbld', 06:51:22 INFO - 'LANG': 'en_US.UTF-8', 06:51:22 INFO - 'LANGUAGE': 'en_US:en', 06:51:22 INFO - 'LOGNAME': 'cltbld', 06:51:22 INFO - 'MAIL': '/var/mail/cltbld', 06:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:22 INFO - 'MOZ_NO_REMOTE': '1', 06:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:22 INFO - 'NO_EM_RESTART': '1', 06:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:22 INFO - 'PWD': '/builds/slave/test', 06:51:22 INFO - 'SHELL': '/bin/bash', 06:51:22 INFO - 'SHLVL': '1', 06:51:22 INFO - 'TERM': 'linux', 06:51:22 INFO - 'TMOUT': '86400', 06:51:22 INFO - 'USER': 'cltbld', 06:51:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', 06:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:22 INFO - '_': '/tools/buildbot/bin/python'} 06:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:22 INFO - Downloading/unpacking blobuploader==1.2.4 06:51:22 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:51:22 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:51:22 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:51:22 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:51:22 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:51:22 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:51:24 INFO - Downloading blobuploader-1.2.4.tar.gz 06:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:51:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:51:24 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:51:24 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:51:24 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:51:24 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:51:24 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:51:24 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:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:51:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:25 INFO - Downloading docopt-0.6.1.tar.gz 06:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:51:25 INFO - Installing collected packages: blobuploader, requests, docopt 06:51:25 INFO - Running setup.py install for blobuploader 06:51:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:51:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:51:25 INFO - Running setup.py install for requests 06:51:26 INFO - Running setup.py install for docopt 06:51:26 INFO - Successfully installed blobuploader requests docopt 06:51:26 INFO - Cleaning up... 06:51:26 INFO - Return code: 0 06:51:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fac8e607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4f60>, '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 0x14c5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 06:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/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:51:26 INFO - Using env: {'DISPLAY': ':0', 06:51:26 INFO - 'HOME': '/home/cltbld', 06:51:26 INFO - 'LANG': 'en_US.UTF-8', 06:51:26 INFO - 'LANGUAGE': 'en_US:en', 06:51:26 INFO - 'LOGNAME': 'cltbld', 06:51:26 INFO - 'MAIL': '/var/mail/cltbld', 06:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:26 INFO - 'MOZ_NO_REMOTE': '1', 06:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:26 INFO - 'NO_EM_RESTART': '1', 06:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:26 INFO - 'PWD': '/builds/slave/test', 06:51:26 INFO - 'SHELL': '/bin/bash', 06:51:26 INFO - 'SHLVL': '1', 06:51:26 INFO - 'TERM': 'linux', 06:51:26 INFO - 'TMOUT': '86400', 06:51:26 INFO - 'USER': 'cltbld', 06:51:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', 06:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:26 INFO - '_': '/tools/buildbot/bin/python'} 06:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:26 INFO - Running setup.py (path:/tmp/pip-AvMNCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:26 INFO - Running setup.py (path:/tmp/pip-A6hwOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:26 INFO - Running setup.py (path:/tmp/pip-b4iTA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:26 INFO - Running setup.py (path:/tmp/pip-k5aZ3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:26 INFO - Running setup.py (path:/tmp/pip-7AiXim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:26 INFO - Running setup.py (path:/tmp/pip-40dNyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:26 INFO - Running setup.py (path:/tmp/pip-JN32bW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:26 INFO - Running setup.py (path:/tmp/pip-5g8ltw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:27 INFO - Running setup.py (path:/tmp/pip-qMVFjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:27 INFO - Running setup.py (path:/tmp/pip-xP5RBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:27 INFO - Running setup.py (path:/tmp/pip-y9UcmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:27 INFO - Running setup.py (path:/tmp/pip-WyVZs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:27 INFO - Running setup.py (path:/tmp/pip-wx4FYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:27 INFO - Running setup.py (path:/tmp/pip-3VRbox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:27 INFO - Running setup.py (path:/tmp/pip-Hbv2eX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:27 INFO - Running setup.py (path:/tmp/pip-mYsgfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:27 INFO - Running setup.py (path:/tmp/pip-6dYQIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:51:27 INFO - Running setup.py install for manifestparser 06:51:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:51:27 INFO - Running setup.py install for mozcrash 06:51:27 INFO - Running setup.py install for mozdebug 06:51:27 INFO - Running setup.py install for mozdevice 06:51:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:51:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:51:28 INFO - Running setup.py install for mozfile 06:51:28 INFO - Running setup.py install for mozhttpd 06:51:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:51:28 INFO - Running setup.py install for mozinfo 06:51:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:51:28 INFO - Running setup.py install for mozInstall 06:51:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:51:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:51:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:51:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:51:28 INFO - Running setup.py install for mozleak 06:51:28 INFO - Running setup.py install for mozlog 06:51:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:51:28 INFO - Running setup.py install for moznetwork 06:51:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:51:28 INFO - Running setup.py install for mozprocess 06:51:28 INFO - Running setup.py install for mozprofile 06:51:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:51:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:51:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:51:29 INFO - Running setup.py install for mozrunner 06:51:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:51:29 INFO - Running setup.py install for mozscreenshot 06:51:29 INFO - Running setup.py install for moztest 06:51:29 INFO - Running setup.py install for mozversion 06:51:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:51:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:51:29 INFO - Cleaning up... 06:51:29 INFO - Return code: 0 06:51:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:29 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:29 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fac8e607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4f60>, '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 0x14c5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 06:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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:51:29 INFO - Using env: {'DISPLAY': ':0', 06:51:29 INFO - 'HOME': '/home/cltbld', 06:51:29 INFO - 'LANG': 'en_US.UTF-8', 06:51:29 INFO - 'LANGUAGE': 'en_US:en', 06:51:29 INFO - 'LOGNAME': 'cltbld', 06:51:29 INFO - 'MAIL': '/var/mail/cltbld', 06:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:29 INFO - 'MOZ_NO_REMOTE': '1', 06:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:29 INFO - 'NO_EM_RESTART': '1', 06:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:29 INFO - 'PWD': '/builds/slave/test', 06:51:29 INFO - 'SHELL': '/bin/bash', 06:51:29 INFO - 'SHLVL': '1', 06:51:29 INFO - 'TERM': 'linux', 06:51:29 INFO - 'TMOUT': '86400', 06:51:29 INFO - 'USER': 'cltbld', 06:51:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', 06:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:29 INFO - '_': '/tools/buildbot/bin/python'} 06:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:29 INFO - Running setup.py (path:/tmp/pip-0hzuPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:29 INFO - Running setup.py (path:/tmp/pip-nVSSYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:29 INFO - Running setup.py (path:/tmp/pip-5joGnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:29 INFO - Running setup.py (path:/tmp/pip-h96vGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:30 INFO - Running setup.py (path:/tmp/pip-12OEmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:30 INFO - Running setup.py (path:/tmp/pip-vcqAVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:30 INFO - Running setup.py (path:/tmp/pip-ZEqCOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:30 INFO - Running setup.py (path:/tmp/pip-ELPKc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:30 INFO - Running setup.py (path:/tmp/pip-7ERa6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:30 INFO - Running setup.py (path:/tmp/pip-Jar4bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:30 INFO - Running setup.py (path:/tmp/pip-F4RikP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:30 INFO - Running setup.py (path:/tmp/pip-zmUeLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:30 INFO - Running setup.py (path:/tmp/pip-81Yr01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:30 INFO - Running setup.py (path:/tmp/pip-2qrQE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:30 INFO - Running setup.py (path:/tmp/pip-qSbm4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:30 INFO - Running setup.py (path:/tmp/pip-4almkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:30 INFO - Running setup.py (path:/tmp/pip-ac31g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:51:30 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:51:30 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:51:30 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:51:30 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:51:30 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:51:30 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:51:32 INFO - Downloading blessings-1.6.tar.gz 06:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:51:32 INFO - Installing collected packages: blessings 06:51:32 INFO - Running setup.py install for blessings 06:51:33 INFO - Successfully installed blessings 06:51:33 INFO - Cleaning up... 06:51:33 INFO - Return code: 0 06:51:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:33 INFO - Reading from file tmpfile_stdout 06:51:33 INFO - Current package versions: 06:51:33 INFO - argparse == 1.2.1 06:51:33 INFO - blessings == 1.6 06:51:33 INFO - blobuploader == 1.2.4 06:51:33 INFO - docopt == 0.6.1 06:51:33 INFO - functools32 == 3.2.3-2 06:51:33 INFO - jsonschema == 2.5.1 06:51:33 INFO - manifestparser == 1.1 06:51:33 INFO - mozInstall == 1.12 06:51:33 INFO - mozcrash == 0.17 06:51:33 INFO - mozdebug == 0.1 06:51:33 INFO - mozdevice == 0.48 06:51:33 INFO - mozfile == 1.2 06:51:33 INFO - mozhttpd == 0.7 06:51:33 INFO - mozinfo == 0.9 06:51:33 INFO - mozleak == 0.1 06:51:33 INFO - mozlog == 3.4 06:51:33 INFO - moznetwork == 0.27 06:51:33 INFO - mozprocess == 0.23 06:51:33 INFO - mozprofile == 0.28 06:51:33 INFO - mozrunner == 6.12 06:51:33 INFO - mozscreenshot == 0.1 06:51:33 INFO - mozsystemmonitor == 0.3 06:51:33 INFO - moztest == 0.7 06:51:33 INFO - mozversion == 1.4 06:51:33 INFO - psutil == 3.1.1 06:51:33 INFO - requests == 1.2.3 06:51:33 INFO - wsgiref == 0.1.2 06:51:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fac8e607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4f60>, '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 0x14c5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 06:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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:51:33 INFO - Using env: {'DISPLAY': ':0', 06:51:33 INFO - 'HOME': '/home/cltbld', 06:51:33 INFO - 'LANG': 'en_US.UTF-8', 06:51:33 INFO - 'LANGUAGE': 'en_US:en', 06:51:33 INFO - 'LOGNAME': 'cltbld', 06:51:33 INFO - 'MAIL': '/var/mail/cltbld', 06:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:33 INFO - 'MOZ_NO_REMOTE': '1', 06:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:33 INFO - 'NO_EM_RESTART': '1', 06:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:33 INFO - 'PWD': '/builds/slave/test', 06:51:33 INFO - 'SHELL': '/bin/bash', 06:51:33 INFO - 'SHLVL': '1', 06:51:33 INFO - 'TERM': 'linux', 06:51:33 INFO - 'TMOUT': '86400', 06:51:33 INFO - 'USER': 'cltbld', 06:51:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', 06:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:33 INFO - '_': '/tools/buildbot/bin/python'} 06:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:51:33 INFO - Cleaning up... 06:51:33 INFO - Return code: 0 06:51:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fac8e607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4f60>, '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 0x14c5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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/build 06:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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:51:33 INFO - Using env: {'DISPLAY': ':0', 06:51:33 INFO - 'HOME': '/home/cltbld', 06:51:33 INFO - 'LANG': 'en_US.UTF-8', 06:51:33 INFO - 'LANGUAGE': 'en_US:en', 06:51:33 INFO - 'LOGNAME': 'cltbld', 06:51:33 INFO - 'MAIL': '/var/mail/cltbld', 06:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:33 INFO - 'MOZ_NO_REMOTE': '1', 06:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:33 INFO - 'NO_EM_RESTART': '1', 06:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:33 INFO - 'PWD': '/builds/slave/test', 06:51:33 INFO - 'SHELL': '/bin/bash', 06:51:33 INFO - 'SHLVL': '1', 06:51:33 INFO - 'TERM': 'linux', 06:51:33 INFO - 'TMOUT': '86400', 06:51:33 INFO - 'USER': 'cltbld', 06:51:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', 06:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:33 INFO - '_': '/tools/buildbot/bin/python'} 06:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:51:33 INFO - Cleaning up... 06:51:33 INFO - Return code: 0 06:51:33 INFO - Running post-action listener: _resource_record_post_action 06:51:33 INFO - Running post-action listener: _start_resource_monitoring 06:51:33 INFO - Starting resource monitoring. 06:51:33 INFO - [mozharness: 2016-11-14 14:51:33.821050Z] Finished create-virtualenv step (success) 06:51:33 INFO - [mozharness: 2016-11-14 14:51:33.821512Z] Running install step. 06:51:33 INFO - Running pre-action listener: _resource_record_pre_action 06:51:33 INFO - Running main action method: install 06:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:34 INFO - Reading from file tmpfile_stdout 06:51:34 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:51:34 INFO - Reading from file tmpfile_stdout 06:51:34 INFO - Output received: 06:51:34 INFO - Usage: mozinstall [options] installer 06:51:34 INFO - Options: 06:51:34 INFO - -h, --help show this help message and exit 06:51:34 INFO - -d DEST, --destination=DEST 06:51:34 INFO - Directory to install application into. [default: 06:51:34 INFO - "/builds/slave/test"] 06:51:34 INFO - --app=APP Application being installed. [default: firefox] 06:51:34 INFO - mkdir: /builds/slave/test/build/application 06:51:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:51:50 INFO - Reading from file tmpfile_stdout 06:51:50 INFO - Output received: 06:51:50 INFO - /builds/slave/test/build/application/firefox/firefox 06:51:50 INFO - Running post-action listener: _resource_record_post_action 06:51:50 INFO - [mozharness: 2016-11-14 14:51:50.115435Z] Finished install step (success) 06:51:50 INFO - [mozharness: 2016-11-14 14:51:50.115680Z] Running run-tests step. 06:51:50 INFO - Running pre-action listener: _resource_record_pre_action 06:51:50 INFO - Running main action method: run_tests 06:51:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:51:50 INFO - Python 2.7.3 06:51:50 INFO - Return code: 0 06:51:50 INFO - grabbing minidump binary from tooltool 06:51:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:50 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/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4f60>, '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 0x14c5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:51:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:51:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:51:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:51:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:51:50 INFO - Return code: 0 06:51:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:51:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:51:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:51:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:51:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:51:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:51:50 INFO - Using env: {'DISPLAY': ':0', 06:51:50 INFO - 'HOME': '/home/cltbld', 06:51:50 INFO - 'LANG': 'en_US.UTF-8', 06:51:50 INFO - 'LANGUAGE': 'en_US:en', 06:51:50 INFO - 'LOGNAME': 'cltbld', 06:51:50 INFO - 'MAIL': '/var/mail/cltbld', 06:51:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:51:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:50 INFO - 'MOZ_NO_REMOTE': '1', 06:51:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:50 INFO - 'NO_EM_RESTART': '1', 06:51:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:50 INFO - 'PWD': '/builds/slave/test', 06:51:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:51:50 INFO - 'SHELL': '/bin/bash', 06:51:50 INFO - 'SHLVL': '1', 06:51:50 INFO - 'TERM': 'linux', 06:51:50 INFO - 'TMOUT': '86400', 06:51:50 INFO - 'USER': 'cltbld', 06:51:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695', 06:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:50 INFO - '_': '/tools/buildbot/bin/python'} 06:51:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:51:50 INFO - mozversion application_buildid: 20161114021920 06:51:50 INFO - mozversion application_changeset: 2d9b6132e7d75327e063a15d8e5e279077adf987 06:51:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:51:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:51:50 INFO - mozversion application_name: Firefox 06:51:50 INFO - mozversion application_remotingname: firefox-dev 06:51:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:51:50 INFO - mozversion application_vendor: Mozilla 06:51:50 INFO - mozversion application_version: 51.0a2 06:51:50 INFO - mozversion platform_buildid: 20161114021920 06:51:50 INFO - mozversion platform_changeset: 2d9b6132e7d75327e063a15d8e5e279077adf987 06:51:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:51:50 INFO - mozversion platform_version: 51.0a2 06:51:50 INFO - using testdate: 1479135110 06:51:50 INFO - actual date: 1479135110 06:51:50 INFO - starting webserver on 'localhost:51567' 06:51:50 INFO - SUITE-START | Running 2 tests 06:51:50 INFO - TEST-START | dromaeo_css 06:51:50 INFO - operating with platform_type : linux_ 06:51:50 INFO - Initialising browser for dromaeo_css test... 06:51:50 INFO - TEST-INFO | started process 8872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6VQdBs/profile http://localhost:51567/getInfo.html) 06:51:54 INFO - PROCESS | 8872 | __metrics Screen width/height:1600/1200 06:51:54 INFO - PROCESS | 8872 | colorDepth:24 06:51:54 INFO - PROCESS | 8872 | Browser inner width/height: 1024/697 06:51:54 INFO - PROCESS | 8872 | __metrics 06:51:54 INFO - PROCESS | 8872 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:51:54 INFO - PROCESS | 8872 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:51:55 INFO - PROCESS | 8872 | console.error: PushService: 06:51:55 INFO - PROCESS | 8872 | stateChangeProcessEnqueue: Error transitioning state 06:51:55 INFO - PROCESS | 8872 | UnknownError 06:51:55 INFO - TEST-INFO | 8872: exit 0 06:51:55 INFO - Browser initialized. 06:51:55 INFO - Running cycle 1/1 for dromaeo_css test... 06:51:55 INFO - TEST-INFO | started process 8962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6VQdBs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:07 INFO - PROCESS | 8962 | RSS: Main: 144568320 06:52:07 INFO - PROCESS | 8962 | 06:52:58 INFO - PROCESS | 8962 | 1479135178571 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:55:07 INFO - PROCESS | 8962 | Cycle 1(1): loaded http://localhost:51567/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51567/tests/dromaeo/cssquery-ext.html) 06:55:08 INFO - PROCESS | 8962 | RSS: Main: 245735424 06:55:08 INFO - PROCESS | 8962 | 06:58:11 INFO - PROCESS | 8962 | Cycle 1(1): loaded http://localhost:51567/tests/dromaeo/cssquery-ext.html (next: http://localhost:51567/tests/dromaeo/cssquery-jquery.html) 06:58:11 INFO - PROCESS | 8962 | RSS: Main: 230203392 06:58:11 INFO - PROCESS | 8962 | 07:01:13 INFO - PROCESS | 8962 | Cycle 1(1): loaded http://localhost:51567/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51567/tests/dromaeo/cssquery-mootools.html) 07:01:14 INFO - PROCESS | 8962 | RSS: Main: 222507008 07:01:14 INFO - PROCESS | 8962 | 07:04:16 INFO - PROCESS | 8962 | Cycle 1(1): loaded http://localhost:51567/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51567/tests/dromaeo/cssquery-prototype.html) 07:04:16 INFO - PROCESS | 8962 | RSS: Main: 217665536 07:04:16 INFO - PROCESS | 8962 | 07:07:19 INFO - PROCESS | 8962 | Cycle 1(1): loaded http://localhost:51567/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51567/tests/dromaeo/cssquery-yui.html) 07:07:20 INFO - PROCESS | 8962 | RSS: Main: 176709632 07:07:20 INFO - PROCESS | 8962 | 07:10:22 INFO - PROCESS | 8962 | Cycle 1(1): loaded http://localhost:51567/tests/dromaeo/cssquery-yui.html (next: http://localhost:51567/tests/dromaeo/cssquery-dojo.html) 07:10:22 INFO - PROCESS | 8962 | RSS: Main: 268341248 07:10:22 INFO - PROCESS | 8962 | 07:10:22 INFO - PROCESS | 8962 | __start_tp_report 07:10:22 INFO - PROCESS | 8962 | _x_x_mozilla_page_load 07:10:22 INFO - PROCESS | 8962 | _x_x_mozilla_page_load_details 07:10:22 INFO - PROCESS | 8962 | |i|pagename|runs| 07:10:22 INFO - PROCESS | 8962 | |0;dojo.html;3084.6761090085542;3120.812751234926;3129.7026782455673;3144.6226452825663;3171.112088615187;5389.353277606688;5452.372977107634;5453.890922181554;5470.343558772943;5470.78116875325;5541.5289700375415;5564.387917329091;5564.443555644433;5566.888662226763;5573.08044172712;5010.574101201402;5027.698338099707;5040.949590504103;5076.898462030757;5139.306193663863;4962.528559786814;5052.772625231855;5110.514501122388;5112.616553758465;5116.386033675964;4937.037277730826;5019.824306149286;5043.36957880265;5094.923576146361;5101.566366858803;5118.513741194581;5129.461406552296;5197.116490196638;5200.29795977542;5225.712585807779;4874.366332376769;5098.796048158069;5119.513646203604;5156.535911767959;5179.507946745053;5422;5464.535514481274;5468.48049435303;5512.283403157604;5519.69641669708;5885.911711324334;5886.028805247129;5929.110633404981;5947.583669143161;6004.819855404345;5807.2160258365;5951.940480595182;5961.552883533709;5966.671833049224;5968.791092311748;5473.042217611902;5573.052581061229;5619.100943848965;5633.57748168889;5642.069058605366;6191.535634827406;6199.783007594712;6199.876002479925;6200.906986395207;6200.906986395207;5700.429957004267;5955.166276721263;5965.6718880461995;5967.955607768623;5968.880622387528;5829.970850145807;5936.9406305937255;5996.280446346466;5996.700164991733;6071.210742603434;6006.3693312201585;6013.098035294741;6013.669248191304;6018.759249629966;6019.307779605314;5965.045592705146;6002.729877155539;6024.608400453956;6028.608140470856;6048.183495228176;4460.7323560586465;4493.7977790999485;4555.5899969002285;4577.519360467103;4590.265557510782;4057.8173982170874;4072.7963601819793;4076.3885417187657;4103;4103.2409004334295;5683.318001839806;5691.743871525791;5691.9146212806845;5701.40135285789;5730.598858079894;5861.765529378862;5923.141144534018;5961.5230781537375;5971.462568368867;5999.760009599567;5757.193992841006;5775.711214439261;5783.421657834183;5784.508316793035;5814.476697097197;5104.923426148611;5105.693658380509;5116;5117.41149767774;5144.819931302462;5887.411258874078;5993.820185394445;6019.307779605314;6248.656323902138;6260.593061450991;5908.734106965111;6000.429959153874;6000.759969601341;6034.577579569388;6035.78874739382;6170.7223174958135;6171.043488259327;6191.907121393093;6192.783252586138;6197.876042479035;5651.406602306699;5667.263255776723;5885.087811389241;5899.439553242435;5901.527877769682;5949.970250148722;5984.551158663031;6005.699715014144;6063.6664983426335;6094.695265236632;5875;5913.319968203712;5927.436893495111;5930.822075337746;5933.881322373615;5601.131824567198;5904.468597826216;5915.704214789157;5916.526677865674;5921.911171332347;5678.77284908599;5759.0209664358;5804.738786754522;5823.388544202798;5895.852603684943;5923.49650279731;5929.6145750526075;5934.19888315072;5935.347111817783;5936.317323507852;5441.319835020622;5461.208124821958;5761.884762304647;5784.971075144597;5789.478946894799 07:10:22 INFO - PROCESS | 8962 | |1;ext.html;593.3176846626379;603.303184821531;612.1857928954491;619.4455961914084;632.6804963493435;34568.1357966051;45569.77215113928;46567.76716116423;46666.833329166744;46708.53291467085;48730.51269487304;49362.50637493624;49372.50627493724;49406.50593494064;49457.50542494574;8324.125966773492;9142.131497507742;9276.768080798;9285.164335209829;9287.628494860197;8267.95866020669;10895.891041089568;11145.16411269158;11147.665570032872;11541.826872596917;11334.489947952361;11396.25924314921;11396.601118960796;11404.258723183008;11414.600488982887;10971.561137554489;11016.889831101667;11088;11090.55637774488;11106.278091924;11012.779744405067;11059.22585419021;11080.722981925435;11083.778324433546;11084.501197446054;44232.3365149523;44415.77792111051;44550.331745023854;44600.330995034776;44629.553704463186;3697.5193224880863;3801.7909015004166;3808.6572208501366;4014.658754005884;4375.78121093944;34608.30783384318;34652.13369665753;35142.472862907074;35729.28541429157;35940.64059359399;4729.408823897013;4779.069013824696;4820.469748327681;4845.563899249085;4999.975005123941;341188;341971;344561;345141;345885;63518;64106.35893641004;64303;64501.677491612245;64947;43501.78249108734;69290.65354673295;69880.3011969884;69880.65059674771;69942.3005769946;18922.81077189238;19446.8055319445;19469;19538;19545.218191272474;12051.397430128458;12116.878831211576;14472.638184045483;15095.32071056805;15301.846981530041;20362.898185508977;21286.467838304165;21359.67960480594;21373;21462.356129316144;7480.765673663894;7726;7745.922540774633;7772.68909243624;7809.414293927978;1053.9051485366201;1117.782032503654;1121.3608243301403;1135.40391294571;1138.408027825526;35161;38977.610223897966;38999.41500877489;39528.40707389391;39837.402438963436;1111.0278506306981;1143.8341440491083;1163.284579983321;1179.9646010619695;1209.564556759566;18287.268509259746;18419.907900460414;18594.349197778014;18597.81402185961;18655;562532;566297;567704;569067;569415;62590.0611490828;62995.05507417392;63020;63212.367876321565;63255.367446325865;1318.3869500682229;1368.4184221705734;1386.5424409944492;1465.8387577366482;1470.8455612160783;30743.53884691687;31016.68983310138;33590.83204583961;33864.49203262002;33913.49129763105;61517.69241153765;62289.377106228356;62335.37664623296;62494;62566.374336256056;483759;485889;486021;487715;489375;40552.18895622012;40845.38731918964;44577.777111114236;46290.76854615705;47735.761321193175;51591;52073.218901717264;52101.7394913023;52282.21576676277;52581.21128183004;44097;44889.32666010078;45344.31983520316;45849.77075114603;46738;42851.571484286;43173;44450.62531663163;44973;45165.54834451614;44663.55336446724;45234.77382613066;45856.7707161462;45927.77036114798;45998.08003839971;36632.81683591565;39007;39214.2157156861;39374.2125157501;39447.408288876264;24294.75705242925;24493;24726.629100563867;29576.556351655174;31081 07:10:22 INFO - PROCESS | 8962 | |2;jquery.html;431.9935200971984;436.72900915240746;441.6047637364559;442.46019855775955;454.60222305482705;18792;18826.62346753066;20164.495887602818;20282.6957595636;20355.898220508876;19383.356070941336;19724.605507889835;20187.697184542245;20404;20502.89748551259;5758.222639943607;6027.789027384042;6030;6030.487408570277;6032.125341825433;5803.274590676166;5914.260717410324;5961.225040744697;5965.403459654043;6004.759809607633;5952.047672372421;5963.85090372742;5967.8209653710455;5968;5975;5748.856278593027;5896.321922978848;5954.017587098124;5962.224910761595;5962.433568810956;5353.866153346158;5353.946460535384;5359.276497672803;5367.81212657559;5369.892602147975;23712.7628723714;23725.288241352613;23826.285211443683;23957;24001.15995940134;2472.5178590174924;2577.7422257774074;2598.298459415947;2620.6986196587445;3040.3767227718263;14875;14966.925165374103;15297.847021529753;15336;15482.148481833494;1907.7424547686162;1934.2263094762209;1945.6984167454068;1948.503131701407;1994.2421879685771;52034.21948670773;58413.41586584122;87614;91943.54028229883;93897.530512347;10819.56721731122;10850.620228291971;11338;11667.35829529384;11723.182906649483;14160.645983850487;14175.85824141766;14769.483068092564;15016;15095.245237738069;8796.604152813139;8911.643534258557;8976.37165398429;9153.54232288383;9252.352335336596;8837.513936733541;8919.910800892038;9043.68347107848;9053.094690530894;9209.35534512591;6771.695273712695;6831.9658401707675;6947.166340039228;6964.408025317804;7014.263502332284;2017.3746138697052;2039.6328660840895;2049.1086377425568;2074.4917495213767;2096.465401322653;819.5574389829426;924.3021518753299;928.7817362919709;1021.1116328793996;1114.9442527873573;20857.89571052135;21025.474363141046;21101.155953761678;21240.362789116352;21387.25144619931;1084.4902895639036;1090.7000574841982;1097.2538673701958;1103.7185517692938;1116.5812820192427;11014.559417623366;11120.944395278133;11837.053035757119;12127.211731237441;12167.452464639113;364738;477162;477536;481149;486252;94905.5254723722;95904;96555;97003.51498242604;97419.51290243503;1053.8629978102952;1092.5356723392526;1136.2671077155353;1158.623447379605;1159.3623507071077;18388.264469421072;18678.159482823576;18812.52968675794;18863.717044244622;19512.707309390087;46139.30791038204;46325.536744632125;46485.302720458545;46513.76743116398;46947.295790562486;57928;61086.38913610985;61595.6920215396;62024.37975620366;63432.682836587366;8830.64677412922;8837.425567338103;9084.909150908406;9344.579493922925;9441.669541566012;11401.132358715906;14007.1595704254;14073.648158796112;14075.155490670593;14140;11566.537338506365;11985;12021.737717539881;12144.33206173669;12241.081918855944;12019.879801201876;12076.094292928241;12259.570915017932;12263.202891812003;12838.422270998015;12083.033357331216;12154.635360939186;12302.138850280395;12376.504939802307;12461.563845265735;9033.59348829291;9073.637054518009;9148.725538233864;9198.632054718004;9332.766680833034;11937.94031029874;12002.939985300018;12037.578684745991;12411;12578.855286178456 07:10:22 INFO - PROCESS | 8962 | |3;mootools.html;1539.5304432148193;1570.2462817847434;1732.6188238587506;1828.1864570266237;1872.9157187926533;8096.635651395686;8715.69495067672;8724.607392667338;8739.344549158823;8744.78138046549;7376.1148662160485;7688.807779805494;8023.67905283788;8295.336373090153;8303.045149807758;2440.231327131952;2467.1734968785477;2467.6915385576804;2471.1721573272976;2472.7032756069207;2042.60169266993;2374.005835098517;2441.438469152096;2443.1448992852447;2445.572024895645;2130.4886827161527;2321.083172147001;2379.6311571706415;2405;2409;2360.976390236093;2372.3713215997686;2373.1693907132367;2381.9047238110456;2382.29722231942;2310.353101131686;2313.9305820825234;2316.1893337331967;2317.40906068953;2318.2233951626226;8627.180417860292;8704;8704.521251331174;8710.520921349324;8722.04057553675;5289.365276166846;5368.087425137736;5428.61999660024;5431.131019036975;5434.0218760623075;3314.3537010283003;3356.093854659253;3482.6343233960324;3483.111806489329;3491.6508349165133;1217.5190799634183;1225.9387030648431;1242.6644805902447;1265.221888538542;1271.1800888427006;11630.651080467514;11675.824862627067;11684.824727629093;11725.530978760755;11752.236104653255;4717.750252929598;4765.76171191446;4796.088743138793;4883.536064073907;4888.926666100011;9975.700728978143;9987.900120998842;9995.350302230332;10000.399976001463;10020.799584008279;5478.91781623276;5488.780448782004;5490.396056433789;5493.697846618395;5495.560355171577;4840.419149701988;4996.175631020841;5008.248762685554;5033.0437216929395;5053.84838454847;4158.293090174617;4168.468220588816;4230.344296634026;4276.914461710749;4290.141971605692;1278.7826069568196;1376.3256004557895;1427.1437137717287;1434.734574103794;1445.3784872504714;861.5606040919051;1057.4554104636118;1059.56557811297;1063.7766069125416;1070.743021674808;5836.9124463133085;5934.703264836828;6065.211522502046;6086.391360863879;6108.6029408089225;1019.6482213636284;1039.6880935719255;1042.3224903812581;1056.27645063132;1062.1715062251455;4104.733192342488;4230.70385073042;4236.597523235288;4239.448871646666;4268.850590229389;10285.794284114276;10548.630797922036;10572.15422766177;10583.100436462986;10593.576256949636;10353;10422.739431514272;10481.790364192826;10493.370397776158;10505.894941050645;7979.0425148982495;8079.474834135763;8092.757217283491;8094.999999999882;8097.595120243965;5784.248047753765;5806.1000544915605;5938.406159384027;6096.268447786294;6293.905591416041;9185.586648600696;9490.193333566724;9626.518674066128;9631.9036809631;9636.46999415039;9593.328467007243;9766.9023309766;9782.804343913223;9823.214142868695;9840.753981150243;7343.77968660941;7487.3261406473675;7487.363574096263;7505.66224519887;7565.205653406533;8192.426530143071;8228.50628962264;8276.875846862422;8295.917040829756;8299.502029878227;7482.176960534228;7517.473776835569;7561.508501947355;7617.619119043915;7634.770956871303;7267.345938865316;7279.927200727925;7301.561906285639;7302.598357090411;7334.266573342837;6949.061876646791;6992.580445173306;7036.437085033287;7046;7072.434205263464;5020.99580083992;5057.797688092435;5175.223716442564;5282.867928301823;5344.011357898801;4989.476105008922;5123.948760512347;5174.353205849269;5224.58203343724;5441.29263195782 07:10:22 INFO - PROCESS | 8962 | |4;prototype.html;358.99461508077366;366.7194596133957;372.31679867443233;377.4018181182827;378.2378507307774;5421.024215641183;5493.697846618435;5520.22716819645;5535.114381698929;5554.472325129106;5152.793888244475;5226.804742008366;5301.416844147141;5357.973210133953;5465.152901300295;4296.97851510742;4317.309230523117;4324.935125973113;4331.242032644291;4331.350297455376;4316.697831151805;4319.892002699926;4341.674374421915;4342.609165175134;4361.760103194323;4133.6486398656;4243.193793179302;4296.0978194579175;4309.181255561449;4317.870463886073;4271.91456170878;4283.678724095674;4290.099079193373;4305.590968857953;4308.46144231971;3813.2564149990762;3833.5016447861876;3835.9232815343817;3841.9615803841884;3843.385058390672;5195.740212989335;5263.210518422267;5289.153735402318;5302.2841916341185;5326.493983071602;4969.527894849984;4972.105021096201;4976.800927962877;4977.054359671651;4985.875353116165;5682.346530149003;5686.289213848269;5699.601027928005;5700.916825803084;5726.541876649858;4145.523264824554;4231.70378073535;4270.316749320094;4294.441722576076;4301.204277208695;5850.824475265749;5888.764449422018;5907.075997381324;5909.015946946764;5919.408059194089;4388.407564978751;4394.670399720034;4395.560443955643;4410.669199810027;4436.378906953029;4387.539308372575;4454.619068088903;4481.574250446202;4488.4165058542185;4489.438820147481;4940.2342636891335;4946.233333833262;4965.013994402196;4971.328870602495;5001.44984051754;5700.857478563069;5703.116017017369;5709.429057094258;5711.829075039607;5714.228579141763;1436.6480212348042;1462.4808193091299;1488.2261224163374;1520.3994422203168;1541.306412114553;1065.8134826405349;1074.505727365405;1097.3415950429678;1102.1568500097433;1102.5314241447513;5450.645708028966;5491.780328786804;5522.232885476689;5522.8678120985105;5537.612367134262;5750.30996280449;5771.365149833515;5795.304563452329;5795.710214489343;5799.797007104731;5249.2126181073145;5486.341639003345;5508.91736623951;5528.502434780889;5567.526760225426;3058.4494790937847;3116.98441507791;3125.2186953261685;3131.6242050954033;3162.98418507906;6064.696765161724;6073.271207455134;6074.179985701962;6082.60463069899;6099.725512351954;5755.913661295001;6045.697715114226;6084.452399284086;6098.603590766586;6105;6120.959436895739;6130.314163605044;6135;6137.846553836101;6155.1075094112;5597.63615365;5822.970885145547;5878.2358293421585;5945.286565612154;5956.166136740946;5816.272965879265;5823.563232757476;5837.824865254049;5880.705964701833;5880.7356418370255;5798.56510761703;5983.414395185192;6039.184710064085;6100.75596976116;6103.6032657877095;4285.5643359474925;4305.268104422318;4306.720063195882;4306.806193721228;4326.307790753464;5924;5926.851828704144;5930.436608522184;5931.288245410578;5954.3152537458745;5558.444155584571;5609.9158512621525;5624.212610234488;5745.396733343106;5788.565857560784;5703.602617358773;5728.140778883034;5740.536163278337;5760.732638819453;5764;5566.610337276352;5642.486711715117;5675.602707810413;5701.315842098975;5751.9424805751405;5787.701010424018;5791.189233507228;5792.9710351447975;5797.768089276382;5798.275215598051;5636.689982051026;5641.26663533738;5653.802116925888;5663.3770285267765;5665.971670141787 07:10:22 INFO - PROCESS | 8962 | |5;yui.html;789.8380831929455;813.459049731928;839.8362319347726;902.5757893789917;917.6375331743966;16393;16911.238994245257;17063.23215455303;17075.658486830256;17079.743803842954;13883.236421996786;14292.625751265612;14485.710285794305;14568.562943111698;14587.051841630286;872.6073267029831;878.2666473494639;878.9868151977726;879.0725784297564;879.4986857491233;842.4397775479299;847.4533925617973;847.9491230526157;847.9576021198947;848.9533075680835;884.2439714044496;885.1944730295401;885.2342723544152;885.6147575804514;889.9866502002443;877.6708734224666;879.3888247667842;879.7140929198036;882.4352414454754;887.6316328723572;644.0982624325981;644.9580777249464;645.0195702532125;645.2225068792094;651.2347991110473;14231.003829731922;14353.78469322961;14367.281635918267;14432.639184020378;14520;13757;13919.304034798219;14048.086874353237;14152.716945661132;14244.359003844747;12121.151519393647;12176;12234.143609947307;12291.877081229162;12462.501499939992;4026.8187931543152;4040.333344998072;4053.574374690674;4087;4185.434966279544;53744.731276343366;55559.16661250084;68376;68494.65752671254;81823.5908820458;12352.876471235353;12521.686957825945;12542.623721288375;12671.809922851164;12693.301868397326;21742.891285543472;21794.673079903812;21821.127154913942;21828.672569911465;21831.672524912137;8189.181081891882;8763.56182190888;8880.200781929658;8947.642094316285;9023.864642030374;5007.324011258506;5204.297419848348;5270.393904700932;5311.575073994071;5459.344878614592;3555.3955827509385;3699.186179040607;3703.7222208334483;3710.8515659373325;3717.0893131183034;641.9967900160469;646.9256035555877;647.8930976388938;648.1185587600859;684.5037347922716;716.6560051175464;721.5129787393488;744.3672878053719;770.938324934004;808.7856717969743;9452.574634141343;10290.331128476775;10352.482375881176;10470.528826202839;10478.476076196159;776.9417293702995;795.5465384730647;796.4663675337538;807.5437377881595;819.815541503157;5009.727868477222;5069.239614057847;5137.6660517066275;5141.177411614124;5146.511081447256;50020.49979500231;67827;67946.32053679498;68217;69933.65033174903;69493.65253173701;69680.65159674271;71379;102327.4883625577;110933.44533277443;79424;94602;94882;96005.039949601;97105;9782.85325720129;10368.326058806153;10406.583736650751;10428.791424171626;10492.108170805566;54056;54287;54508.454915451926;54517.72741136269;56474.92066026685;72643;73795;80152.59923700344;81828;82728.58635707023;13299.46802127904;13321.200727956353;13813.792793108312;14054.134443783381;14086.084404513675;15016.174110423595;15129.924350378178;15191.620209494851;15270.694586107993;16190.514284571482;13521.121127126706;14254.28728563547;14257.928710356382;14306.141631501727;14621.0496317739;14132.15207087578;14236.715265694422;14393.568192954228;14412.855871441152;14512.419503219753;13262.66843328886;13565.932170339085;13963.790543141658;14018.859811401755;14320.928395357956;11442.313461192354;11554.364509952033;12008.759824803281;12113.75772484563;12201.877981220074;12123.75752484963;12143.271403715806;12164.574239901562;12421.19262247951;12482.875171248172 07:10:22 INFO - PROCESS | 8962 | __end_tp_report 07:10:22 INFO - PROCESS | 8962 | __start_cc_report 07:10:22 INFO - PROCESS | 8962 | _x_x_mozilla_cycle_collect,914 07:10:22 INFO - PROCESS | 8962 | __end_cc_report 07:10:22 INFO - PROCESS | 8962 | __startTimestamp1479136222672__endTimestamp 07:10:22 INFO - PROCESS | 8962 | 07:10:22 INFO - PROCESS | 8962 | ------- Summary: start ------- 07:10:22 INFO - PROCESS | 8962 | Number of tests: 6 07:10:22 INFO - PROCESS | 8962 | 07:10:22 INFO - PROCESS | 8962 | [#0] dojo.html Cycles:165 Average:5545.06 Median:5784.51 stddev:647.74 (11.2%) stddev-sans-first:620.31 07:10:22 INFO - PROCESS | 8962 | Values: 3084.7 3120.8 3129.7 3144.6 3171.1 5389.4 5452.4 5453.9 5470.3 5470.8 5541.5 5564.4 5564.4 5566.9 5573.1 5010.6 5027.7 5040.9 5076.9 5139.3 4962.5 5052.8 5110.5 5112.6 5116.4 4937.0 5019.8 5043.4 5094.9 5101.6 5118.5 5129.5 5197.1 5200.3 5225.7 4874.4 5098.8 5119.5 5156.5 5179.5 5422.0 5464.5 5468.5 5512.3 5519.7 5885.9 5886.0 5929.1 5947.6 6004.8 5807.2 5951.9 5961.6 5966.7 5968.8 5473.0 5573.1 5619.1 5633.6 5642.1 6191.5 6199.8 6199.9 6200.9 6200.9 5700.4 5955.2 5965.7 5968.0 5968.9 5830.0 5936.9 5996.3 5996.7 6071.2 6006.4 6013.1 6013.7 6018.8 6019.3 5965.0 6002.7 6024.6 6028.6 6048.2 4460.7 4493.8 4555.6 4577.5 4590.3 4057.8 4072.8 4076.4 4103.0 4103.2 5683.3 5691.7 5691.9 5701.4 5730.6 5861.8 5923.1 5961.5 5971.5 5999.8 5757.2 5775.7 5783.4 5784.5 5814.5 5104.9 5105.7 5116.0 5117.4 5144.8 5887.4 5993.8 6019.3 6248.7 6260.6 5908.7 6000.4 6000.8 6034.6 6035.8 6170.7 6171.0 6191.9 6192.8 6197.9 5651.4 5667.3 5885.1 5899.4 5901.5 5950.0 5984.6 6005.7 6063.7 6094.7 5875.0 5913.3 5927.4 5930.8 5933.9 5601.1 5904.5 5915.7 5916.5 5921.9 5678.8 5759.0 5804.7 5823.4 5895.9 5923.5 5929.6 5934.2 5935.3 5936.3 5441.3 5461.2 5761.9 5785.0 5789.5 07:10:22 INFO - PROCESS | 8962 | 07:10:22 INFO - PROCESS | 8962 | [#1] ext.html Cycles:180 Average:64972.06 Median:41848.48 stddev:125720.73 (300.4%) stddev-sans-first:125980.49 07:10:22 INFO - PROCESS | 8962 | Values: 593.3 603.3 612.2 619.4 632.7 34568.1 45569.8 46567.8 46666.8 46708.5 48730.5 49362.5 49372.5 49406.5 49457.5 8324.1 9142.1 9276.8 9285.2 9287.6 8268.0 10895.9 11145.2 11147.7 11541.8 11334.5 11396.3 11396.6 11404.3 11414.6 10971.6 11016.9 11088.0 11090.6 11106.3 11012.8 11059.2 11080.7 11083.8 11084.5 44232.3 44415.8 44550.3 44600.3 44629.6 3697.5 3801.8 3808.7 4014.7 4375.8 34608.3 34652.1 35142.5 35729.3 35940.6 4729.4 4779.1 4820.5 4845.6 5000.0 341188.0 341971.0 344561.0 345141.0 345885.0 63518.0 64106.4 64303.0 64501.7 64947.0 43501.8 69290.7 69880.3 69880.7 69942.3 18922.8 19446.8 19469.0 19538.0 19545.2 12051.4 12116.9 14472.6 15095.3 15301.8 20362.9 21286.5 21359.7 21373.0 21462.4 7480.8 7726.0 7745.9 7772.7 7809.4 1053.9 1117.8 1121.4 1135.4 1138.4 35161.0 38977.6 38999.4 39528.4 39837.4 1111.0 1143.8 1163.3 1180.0 1209.6 18287.3 18419.9 18594.3 18597.8 18655.0 562532.0 566297.0 567704.0 569067.0 569415.0 62590.1 62995.1 63020.0 63212.4 63255.4 1318.4 1368.4 1386.5 1465.8 1470.8 30743.5 31016.7 33590.8 33864.5 33913.5 61517.7 62289.4 62335.4 62494.0 62566.4 483759.0 485889.0 486021.0 487715.0 489375.0 40552.2 40845.4 44577.8 46290.8 47735.8 51591.0 52073.2 52101.7 52282.2 52581.2 44097.0 44889.3 45344.3 45849.8 46738.0 42851.6 43173.0 44450.6 44973.0 45165.5 44663.6 45234.8 45856.8 45927.8 45998.1 36632.8 39007.0 39214.2 39374.2 39447.4 24294.8 24493.0 24726.6 29576.6 31081.0 07:10:22 INFO - PROCESS | 8962 | 07:10:22 INFO - PROCESS | 8962 | [#2] jquery.html Cycles:180 Average:28873.00 Median:23979.08 stddev:76031.64 (317.1%) stddev-sans-first:76214.94 07:10:22 INFO - PROCESS | 8962 | Values: 432.0 436.7 441.6 442.5 454.6 18792.0 18826.6 20164.5 20282.7 20355.9 19383.4 19724.6 20187.7 20404.0 20502.9 5758.2 6027.8 6030.0 6030.5 6032.1 5803.3 5914.3 5961.2 5965.4 6004.8 5952.0 5963.9 5967.8 5968.0 5975.0 5748.9 5896.3 5954.0 5962.2 5962.4 5353.9 5353.9 5359.3 5367.8 5369.9 23712.8 23725.3 23826.3 23957.0 24001.2 2472.5 2577.7 2598.3 2620.7 3040.4 14875.0 14966.9 15297.8 15336.0 15482.1 1907.7 1934.2 1945.7 1948.5 1994.2 52034.2 58413.4 87614.0 91943.5 93897.5 10819.6 10850.6 11338.0 11667.4 11723.2 14160.6 14175.9 14769.5 15016.0 15095.2 8796.6 8911.6 8976.4 9153.5 9252.4 8837.5 8919.9 9043.7 9053.1 9209.4 6771.7 6832.0 6947.2 6964.4 7014.3 2017.4 2039.6 2049.1 2074.5 2096.5 819.6 924.3 928.8 1021.1 1114.9 20857.9 21025.5 21101.2 21240.4 21387.3 1084.5 1090.7 1097.3 1103.7 1116.6 11014.6 11120.9 11837.1 12127.2 12167.5 364738.0 477162.0 477536.0 481149.0 486252.0 94905.5 95904.0 96555.0 97003.5 97419.5 1053.9 1092.5 1136.3 1158.6 1159.4 18388.3 18678.2 18812.5 18863.7 19512.7 46139.3 46325.5 46485.3 46513.8 46947.3 57928.0 61086.4 61595.7 62024.4 63432.7 8830.6 8837.4 9084.9 9344.6 9441.7 11401.1 14007.2 14073.6 14075.2 14140.0 11566.5 11985.0 12021.7 12144.3 12241.1 12019.9 12076.1 12259.6 12263.2 12838.4 12083.0 12154.6 12302.1 12376.5 12461.6 9033.6 9073.6 9148.7 9198.6 9332.8 11937.9 12002.9 12037.6 12411.0 12578.9 07:10:22 INFO - PROCESS | 8962 | 07:10:22 INFO - PROCESS | 8962 | [#3] mootools.html Cycles:180 Average:5722.14 Median:5027.02 stddev:3092.06 (61.5%) stddev-sans-first:3084.76 07:10:22 INFO - PROCESS | 8962 | Values: 1539.5 1570.2 1732.6 1828.2 1872.9 8096.6 8715.7 8724.6 8739.3 8744.8 7376.1 7688.8 8023.7 8295.3 8303.0 2440.2 2467.2 2467.7 2471.2 2472.7 2042.6 2374.0 2441.4 2443.1 2445.6 2130.5 2321.1 2379.6 2405.0 2409.0 2361.0 2372.4 2373.2 2381.9 2382.3 2310.4 2313.9 2316.2 2317.4 2318.2 8627.2 8704.0 8704.5 8710.5 8722.0 5289.4 5368.1 5428.6 5431.1 5434.0 3314.4 3356.1 3482.6 3483.1 3491.7 1217.5 1225.9 1242.7 1265.2 1271.2 11630.7 11675.8 11684.8 11725.5 11752.2 4717.8 4765.8 4796.1 4883.5 4888.9 9975.7 9987.9 9995.4 10000.4 10020.8 5478.9 5488.8 5490.4 5493.7 5495.6 4840.4 4996.2 5008.2 5033.0 5053.8 4158.3 4168.5 4230.3 4276.9 4290.1 1278.8 1376.3 1427.1 1434.7 1445.4 861.6 1057.5 1059.6 1063.8 1070.7 5836.9 5934.7 6065.2 6086.4 6108.6 1019.6 1039.7 1042.3 1056.3 1062.2 4104.7 4230.7 4236.6 4239.4 4268.9 10285.8 10548.6 10572.2 10583.1 10593.6 10353.0 10422.7 10481.8 10493.4 10505.9 7979.0 8079.5 8092.8 8095.0 8097.6 5784.2 5806.1 5938.4 6096.3 6293.9 9185.6 9490.2 9626.5 9631.9 9636.5 9593.3 9766.9 9782.8 9823.2 9840.8 7343.8 7487.3 7487.4 7505.7 7565.2 8192.4 8228.5 8276.9 8295.9 8299.5 7482.2 7517.5 7561.5 7617.6 7634.8 7267.3 7279.9 7301.6 7302.6 7334.3 6949.1 6992.6 7036.4 7046.0 7072.4 5021.0 5057.8 5175.2 5282.9 5344.0 4989.5 5123.9 5174.4 5224.6 5441.3 07:10:22 INFO - PROCESS | 8962 | 07:10:22 INFO - PROCESS | 8962 | [#4] prototype.html Cycles:180 Average:4860.77 Median:5501.31 stddev:1394.18 (25.3%) stddev-sans-first:1356.53 07:10:22 INFO - PROCESS | 8962 | Values: 359.0 366.7 372.3 377.4 378.2 5421.0 5493.7 5520.2 5535.1 5554.5 5152.8 5226.8 5301.4 5358.0 5465.2 4297.0 4317.3 4324.9 4331.2 4331.4 4316.7 4319.9 4341.7 4342.6 4361.8 4133.6 4243.2 4296.1 4309.2 4317.9 4271.9 4283.7 4290.1 4305.6 4308.5 3813.3 3833.5 3835.9 3842.0 3843.4 5195.7 5263.2 5289.2 5302.3 5326.5 4969.5 4972.1 4976.8 4977.1 4985.9 5682.3 5686.3 5699.6 5700.9 5726.5 4145.5 4231.7 4270.3 4294.4 4301.2 5850.8 5888.8 5907.1 5909.0 5919.4 4388.4 4394.7 4395.6 4410.7 4436.4 4387.5 4454.6 4481.6 4488.4 4489.4 4940.2 4946.2 4965.0 4971.3 5001.4 5700.9 5703.1 5709.4 5711.8 5714.2 1436.6 1462.5 1488.2 1520.4 1541.3 1065.8 1074.5 1097.3 1102.2 1102.5 5450.6 5491.8 5522.2 5522.9 5537.6 5750.3 5771.4 5795.3 5795.7 5799.8 5249.2 5486.3 5508.9 5528.5 5567.5 3058.4 3117.0 3125.2 3131.6 3163.0 6064.7 6073.3 6074.2 6082.6 6099.7 5755.9 6045.7 6084.5 6098.6 6105.0 6121.0 6130.3 6135.0 6137.8 6155.1 5597.6 5823.0 5878.2 5945.3 5956.2 5816.3 5823.6 5837.8 5880.7 5880.7 5798.6 5983.4 6039.2 6100.8 6103.6 4285.6 4305.3 4306.7 4306.8 4326.3 5924.0 5926.9 5930.4 5931.3 5954.3 5558.4 5609.9 5624.2 5745.4 5788.6 5703.6 5728.1 5740.5 5760.7 5764.0 5566.6 5642.5 5675.6 5701.3 5751.9 5787.7 5791.2 5793.0 5797.8 5798.3 5636.7 5641.3 5653.8 5663.4 5666.0 07:10:22 INFO - PROCESS | 8962 | 07:10:22 INFO - PROCESS | 8962 | [#5] yui.html Cycles:180 Average:19360.43 Median:27513.91 stddev:25765.91 (93.6%) stddev-sans-first:25800.45 07:10:22 INFO - PROCESS | 8962 | Values: 789.8 813.5 839.8 902.6 917.6 16393.0 16911.2 17063.2 17075.7 17079.7 13883.2 14292.6 14485.7 14568.6 14587.1 872.6 878.3 879.0 879.1 879.5 842.4 847.5 847.9 848.0 849.0 884.2 885.2 885.2 885.6 890.0 877.7 879.4 879.7 882.4 887.6 644.1 645.0 645.0 645.2 651.2 14231.0 14353.8 14367.3 14432.6 14520.0 13757.0 13919.3 14048.1 14152.7 14244.4 12121.2 12176.0 12234.1 12291.9 12462.5 4026.8 4040.3 4053.6 4087.0 4185.4 53744.7 55559.2 68376.0 68494.7 81823.6 12352.9 12521.7 12542.6 12671.8 12693.3 21742.9 21794.7 21821.1 21828.7 21831.7 8189.2 8763.6 8880.2 8947.6 9023.9 5007.3 5204.3 5270.4 5311.6 5459.3 3555.4 3699.2 3703.7 3710.9 3717.1 642.0 646.9 647.9 648.1 684.5 716.7 721.5 744.4 770.9 808.8 9452.6 10290.3 10352.5 10470.5 10478.5 776.9 795.5 796.5 807.5 819.8 5009.7 5069.2 5137.7 5141.2 5146.5 50020.5 67827.0 67946.3 68217.0 69933.7 69493.7 69680.7 71379.0 102327.5 110933.4 79424.0 94602.0 94882.0 96005.0 97105.0 9782.9 10368.3 10406.6 10428.8 10492.1 54056.0 54287.0 54508.5 54517.7 56474.9 72643.0 73795.0 80152.6 81828.0 82728.6 13299.5 13321.2 13813.8 14054.1 14086.1 15016.2 15129.9 15191.6 15270.7 16190.5 13521.1 14254.3 14257.9 14306.1 14621.0 14132.2 14236.7 14393.6 14412.9 14512.4 13262.7 13565.9 13963.8 14018.9 14320.9 11442.3 11554.4 12008.8 12113.8 12201.9 12123.8 12143.3 12164.6 12421.2 12482.9 07:10:22 INFO - PROCESS | 8962 | -------- Summary: end -------- 07:10:22 INFO - PROCESS | 8962 | 07:10:23 INFO - TEST-INFO | 8962: exit 0 07:10:23 INFO - TEST-OK | dromaeo_css | took 1113076ms 07:10:23 INFO - TEST-START | kraken 07:10:23 INFO - operating with platform_type : linux_ 07:10:23 INFO - Initialising browser for kraken test... 07:10:23 INFO - TEST-INFO | started process 9281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1_gUwp/profile http://localhost:51567/getInfo.html) 07:10:27 INFO - PROCESS | 9281 | __metrics Screen width/height:1600/1200 07:10:27 INFO - PROCESS | 9281 | colorDepth:24 07:10:27 INFO - PROCESS | 9281 | Browser inner width/height: 1024/697 07:10:27 INFO - PROCESS | 9281 | __metrics 07:10:27 INFO - PROCESS | 9281 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:10:27 INFO - PROCESS | 9281 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:10:28 INFO - PROCESS | 9281 | console.error: PushService: 07:10:28 INFO - PROCESS | 9281 | stateChangeProcessEnqueue: Error transitioning state 07:10:28 INFO - PROCESS | 9281 | UnknownError 07:10:28 INFO - TEST-INFO | 9281: exit 0 07:10:28 INFO - Browser initialized. 07:10:28 INFO - Running cycle 1/1 for kraken test... 07:10:28 INFO - TEST-INFO | started process 9373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1_gUwp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:40 INFO - PROCESS | 9373 | RSS: Main: 145395712 07:10:40 INFO - PROCESS | 9373 | 07:10:42 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51567/tests/kraken/driver.html?testName=audio-beat-detection) 07:10:43 INFO - PROCESS | 9373 | RSS: Main: 187174912 07:10:43 INFO - PROCESS | 9373 | 07:10:46 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51567/tests/kraken/driver.html?testName=audio-dft) 07:10:46 INFO - PROCESS | 9373 | RSS: Main: 176758784 07:10:46 INFO - PROCESS | 9373 | 07:10:49 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51567/tests/kraken/driver.html?testName=audio-fft) 07:10:50 INFO - PROCESS | 9373 | RSS: Main: 267759616 07:10:50 INFO - PROCESS | 9373 | 07:10:52 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51567/tests/kraken/driver.html?testName=audio-oscillator) 07:10:52 INFO - PROCESS | 9373 | RSS: Main: 174452736 07:10:52 INFO - PROCESS | 9373 | 07:10:55 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51567/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:10:55 INFO - PROCESS | 9373 | RSS: Main: 176091136 07:10:55 INFO - PROCESS | 9373 | 07:10:58 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51567/tests/kraken/driver.html?testName=imaging-darkroom) 07:10:59 INFO - PROCESS | 9373 | RSS: Main: 211447808 07:10:59 INFO - PROCESS | 9373 | 07:11:02 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51567/tests/kraken/driver.html?testName=imaging-desaturate) 07:11:03 INFO - PROCESS | 9373 | RSS: Main: 209543168 07:11:03 INFO - PROCESS | 9373 | 07:11:05 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51567/tests/kraken/driver.html?testName=json-parse-financial) 07:11:06 INFO - PROCESS | 9373 | RSS: Main: 210624512 07:11:06 INFO - PROCESS | 9373 | 07:11:08 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51567/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:11:08 INFO - PROCESS | 9373 | RSS: Main: 171683840 07:11:08 INFO - PROCESS | 9373 | 07:11:10 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:10 INFO - PROCESS | 9373 | RSS: Main: 180232192 07:11:10 INFO - PROCESS | 9373 | 07:11:12 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:13 INFO - PROCESS | 9373 | RSS: Main: 189538304 07:11:13 INFO - PROCESS | 9373 | 07:11:16 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:11:16 INFO - PROCESS | 9373 | RSS: Main: 190656512 07:11:16 INFO - PROCESS | 9373 | 07:11:19 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:11:19 INFO - PROCESS | 9373 | RSS: Main: 193314816 07:11:19 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51567/tests/kraken/driver.html?testName=ai-astar) 07:11:21 INFO - PROCESS | 9373 | RSS: Main: 243875840 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | __start_tp_report 07:11:21 INFO - PROCESS | 9373 | _x_x_mozilla_page_load 07:11:21 INFO - PROCESS | 9373 | _x_x_mozilla_page_load_details 07:11:21 INFO - PROCESS | 9373 | |i|pagename|runs| 07:11:21 INFO - PROCESS | 9373 | |0;ai-astar;109;112;113;112;112;110;112;113;112;111 07:11:21 INFO - PROCESS | 9373 | |1;audio-beat-detection;153;120;117;147;117;118;118;116;154;117 07:11:21 INFO - PROCESS | 9373 | |2;audio-dft;161;160;160;159;160;162;161;161;160;159 07:11:21 INFO - PROCESS | 9373 | |3;audio-fft;75;76;75;114;75;75;75;76;103;76 07:11:21 INFO - PROCESS | 9373 | |4;audio-oscillator;80;80;112;80;83;80;99;80;81;105 07:11:21 INFO - PROCESS | 9373 | |5;imaging-gaussian-blur;116;117;116;117;116;116;117;116;117;116 07:11:21 INFO - PROCESS | 9373 | |6;imaging-darkroom;147;148;148;147;148;149;147;147;147;147 07:11:21 INFO - PROCESS | 9373 | |7;imaging-desaturate;95;95;95;94;96;95;95;95;97;96 07:11:21 INFO - PROCESS | 9373 | |8;json-parse-financial;49;48;49;48;50;48;51;48;48;48 07:11:21 INFO - PROCESS | 9373 | |9;json-stringify-tinderbox;59;60;59;59;59;59;59;59;60;60 07:11:21 INFO - PROCESS | 9373 | |10;stanford-crypto-aes;77;79;74;74;74;74;79;74;73;74 07:11:21 INFO - PROCESS | 9373 | |11;stanford-crypto-ccm;129;134;124;121;119;120;121;119;154;145 07:11:21 INFO - PROCESS | 9373 | |12;stanford-crypto-pbkdf2;157;161;158;157;159;154;154;157;155;158 07:11:21 INFO - PROCESS | 9373 | |13;stanford-crypto-sha256-iterative;64;61;64;64;63;61;62;60;60;63 07:11:21 INFO - PROCESS | 9373 | __end_tp_report 07:11:21 INFO - PROCESS | 9373 | __start_cc_report 07:11:21 INFO - PROCESS | 9373 | _x_x_mozilla_cycle_collect,1552 07:11:21 INFO - PROCESS | 9373 | __end_cc_report 07:11:21 INFO - PROCESS | 9373 | __startTimestamp1479136281869__endTimestamp 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | ------- Summary: start ------- 07:11:21 INFO - PROCESS | 9373 | Number of tests: 14 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:1.26 (1.1%) stddev-sans-first:0.93 07:11:21 INFO - PROCESS | 9373 | Values: 109.0 112.0 113.0 112.0 112.0 110.0 112.0 113.0 112.0 111.0 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:119.00 stddev:16.44 (13.8%) stddev-sans-first:14.67 07:11:21 INFO - PROCESS | 9373 | Values: 153.0 120.0 117.0 147.0 117.0 118.0 118.0 116.0 154.0 117.0 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 07:11:21 INFO - PROCESS | 9373 | Values: 161.0 160.0 160.0 159.0 160.0 162.0 161.0 161.0 160.0 159.0 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.00 stddev:14.21 (19.0%) stddev-sans-first:14.85 07:11:21 INFO - PROCESS | 9373 | Values: 75.0 76.0 75.0 114.0 75.0 75.0 75.0 76.0 103.0 76.0 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:80.00 stddev:12.38 (15.5%) stddev-sans-first:12.79 07:11:21 INFO - PROCESS | 9373 | Values: 80.0 80.0 112.0 80.0 83.0 80.0 99.0 80.0 81.0 105.0 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:11:21 INFO - PROCESS | 9373 | Values: 116.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:11:21 INFO - PROCESS | 9373 | Values: 147.0 148.0 148.0 147.0 148.0 149.0 147.0 147.0 147.0 147.0 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 07:11:21 INFO - PROCESS | 9373 | Values: 95.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 97.0 96.0 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#8] json-parse-financial Cycles:10 Average:48.70 Median:48.50 stddev:1.06 (2.2%) stddev-sans-first:1.12 07:11:21 INFO - PROCESS | 9373 | Values: 49.0 48.0 49.0 48.0 50.0 48.0 51.0 48.0 48.0 48.0 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 07:11:21 INFO - PROCESS | 9373 | Values: 59.0 60.0 59.0 59.0 59.0 59.0 59.0 59.0 60.0 60.0 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:74.00 stddev:2.25 (3.0%) stddev-sans-first:2.29 07:11:21 INFO - PROCESS | 9373 | Values: 77.0 79.0 74.0 74.0 74.0 74.0 79.0 74.0 73.0 74.0 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:126.50 stddev:12.19 (9.6%) stddev-sans-first:12.93 07:11:21 INFO - PROCESS | 9373 | Values: 129.0 134.0 124.0 121.0 119.0 120.0 121.0 119.0 154.0 145.0 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:157.50 stddev:2.21 (1.4%) stddev-sans-first:2.35 07:11:21 INFO - PROCESS | 9373 | Values: 157.0 161.0 158.0 157.0 159.0 154.0 154.0 157.0 155.0 158.0 07:11:21 INFO - PROCESS | 9373 | 07:11:21 INFO - PROCESS | 9373 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:63.00 stddev:1.62 (2.6%) stddev-sans-first:1.58 07:11:21 INFO - PROCESS | 9373 | Values: 64.0 61.0 64.0 64.0 63.0 61.0 62.0 60.0 60.0 63.0 07:11:21 INFO - PROCESS | 9373 | -------- Summary: end -------- 07:11:21 INFO - PROCESS | 9373 | 07:11:22 INFO - TEST-INFO | 9373: exit 0 07:11:22 INFO - TEST-OK | kraken | took 59340ms 07:11:22 INFO - SUITE-END | took 1172s 07:11:23 INFO - Completed test suite (00:19:32) 07:11:23 INFO - javascript benchmark 07:11:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3084.6761090085542, 3120.812751234926, 3129.7026782455673, 3144.6226452825663, 3171.112088615187, 5389.353277606688, 5452.372977107634, 5453.890922181554, 5470.343558772943, 5470.78116875325, 5541.5289700375415, 5564.387917329091, 5564.443555644433, 5566.888662226763, 5573.08044172712, 5010.574101201402, 5027.698338099707, 5040.949590504103, 5076.898462030757, 5139.306193663863, 4962.528559786814, 5052.772625231855, 5110.514501122388, 5112.616553758465, 5116.386033675964, 4937.037277730826, 5019.824306149286, 5043.36957880265, 5094.923576146361, 5101.566366858803, 5118.513741194581, 5129.461406552296, 5197.116490196638, 5200.29795977542, 5225.712585807779, 4874.366332376769, 5098.796048158069, 5119.513646203604, 5156.535911767959, 5179.507946745053, 5422.0, 5464.535514481274, 5468.48049435303, 5512.283403157604, 5519.69641669708, 5885.911711324334, 5886.028805247129, 5929.110633404981, 5947.583669143161, 6004.819855404345, 5807.2160258365, 5951.940480595182, 5961.552883533709, 5966.671833049224, 5968.791092311748, 5473.042217611902, 5573.052581061229, 5619.100943848965, 5633.57748168889, 5642.069058605366, 6191.535634827406, 6199.783007594712, 6199.876002479925, 6200.906986395207, 6200.906986395207, 5700.429957004267, 5955.166276721263, 5965.6718880461995, 5967.955607768623, 5968.880622387528, 5829.970850145807, 5936.9406305937255, 5996.280446346466, 5996.700164991733, 6071.210742603434, 6006.3693312201585, 6013.098035294741, 6013.669248191304, 6018.759249629966, 6019.307779605314, 5965.045592705146, 6002.729877155539, 6024.608400453956, 6028.608140470856, 6048.183495228176, 4460.7323560586465, 4493.7977790999485, 4555.5899969002285, 4577.519360467103, 4590.265557510782, 4057.8173982170874, 4072.7963601819793, 4076.3885417187657, 4103.0, 4103.2409004334295, 5683.318001839806, 5691.743871525791, 5691.9146212806845, 5701.40135285789, 5730.598858079894, 5861.765529378862, 5923.141144534018, 5961.5230781537375, 5971.462568368867, 5999.760009599567, 5757.193992841006, 5775.711214439261, 5783.421657834183, 5784.508316793035, 5814.476697097197, 5104.923426148611, 5105.693658380509, 5116.0, 5117.41149767774, 5144.819931302462, 5887.411258874078, 5993.820185394445, 6019.307779605314, 6248.656323902138, 6260.593061450991, 5908.734106965111, 6000.429959153874, 6000.759969601341, 6034.577579569388, 6035.78874739382, 6170.7223174958135, 6171.043488259327, 6191.907121393093, 6192.783252586138, 6197.876042479035, 5651.406602306699, 5667.263255776723, 5885.087811389241, 5899.439553242435, 5901.527877769682, 5949.970250148722, 5984.551158663031, 6005.699715014144, 6063.6664983426335, 6094.695265236632, 5875.0, 5913.319968203712, 5927.436893495111, 5930.822075337746, 5933.881322373615, 5601.131824567198, 5904.468597826216, 5915.704214789157, 5916.526677865674, 5921.911171332347, 5678.77284908599, 5759.0209664358, 5804.738786754522, 5823.388544202798, 5895.852603684943, 5923.49650279731, 5929.6145750526075, 5934.19888315072, 5935.347111817783, 5936.317323507852, 5441.319835020622, 5461.208124821958, 5761.884762304647, 5784.971075144597, 5789.478946894799], "value": 5499.691929716652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.3176846626379, 603.303184821531, 612.1857928954491, 619.4455961914084, 632.6804963493435, 34568.1357966051, 45569.77215113928, 46567.76716116423, 46666.833329166744, 46708.53291467085, 48730.51269487304, 49362.50637493624, 49372.50627493724, 49406.50593494064, 49457.50542494574, 8324.125966773492, 9142.131497507742, 9276.768080798, 9285.164335209829, 9287.628494860197, 8267.95866020669, 10895.891041089568, 11145.16411269158, 11147.665570032872, 11541.826872596917, 11334.489947952361, 11396.25924314921, 11396.601118960796, 11404.258723183008, 11414.600488982887, 10971.561137554489, 11016.889831101667, 11088.0, 11090.55637774488, 11106.278091924, 11012.779744405067, 11059.22585419021, 11080.722981925435, 11083.778324433546, 11084.501197446054, 44232.3365149523, 44415.77792111051, 44550.331745023854, 44600.330995034776, 44629.553704463186, 3697.5193224880863, 3801.7909015004166, 3808.6572208501366, 4014.658754005884, 4375.78121093944, 34608.30783384318, 34652.13369665753, 35142.472862907074, 35729.28541429157, 35940.64059359399, 4729.408823897013, 4779.069013824696, 4820.469748327681, 4845.563899249085, 4999.975005123941, 341188.0, 341971.0, 344561.0, 345141.0, 345885.0, 63518.0, 64106.35893641004, 64303.0, 64501.677491612245, 64947.0, 43501.78249108734, 69290.65354673295, 69880.3011969884, 69880.65059674771, 69942.3005769946, 18922.81077189238, 19446.8055319445, 19469.0, 19538.0, 19545.218191272474, 12051.397430128458, 12116.878831211576, 14472.638184045483, 15095.32071056805, 15301.846981530041, 20362.898185508977, 21286.467838304165, 21359.67960480594, 21373.0, 21462.356129316144, 7480.765673663894, 7726.0, 7745.922540774633, 7772.68909243624, 7809.414293927978, 1053.9051485366201, 1117.782032503654, 1121.3608243301403, 1135.40391294571, 1138.408027825526, 35161.0, 38977.610223897966, 38999.41500877489, 39528.40707389391, 39837.402438963436, 1111.0278506306981, 1143.8341440491083, 1163.284579983321, 1179.9646010619695, 1209.564556759566, 18287.268509259746, 18419.907900460414, 18594.349197778014, 18597.81402185961, 18655.0, 562532.0, 566297.0, 567704.0, 569067.0, 569415.0, 62590.0611490828, 62995.05507417392, 63020.0, 63212.367876321565, 63255.367446325865, 1318.3869500682229, 1368.4184221705734, 1386.5424409944492, 1465.8387577366482, 1470.8455612160783, 30743.53884691687, 31016.68983310138, 33590.83204583961, 33864.49203262002, 33913.49129763105, 61517.69241153765, 62289.377106228356, 62335.37664623296, 62494.0, 62566.374336256056, 483759.0, 485889.0, 486021.0, 487715.0, 489375.0, 40552.18895622012, 40845.38731918964, 44577.777111114236, 46290.76854615705, 47735.761321193175, 51591.0, 52073.218901717264, 52101.7394913023, 52282.21576676277, 52581.21128183004, 44097.0, 44889.32666010078, 45344.31983520316, 45849.77075114603, 46738.0, 42851.571484286, 43173.0, 44450.62531663163, 44973.0, 45165.54834451614, 44663.55336446724, 45234.77382613066, 45856.7707161462, 45927.77036114798, 45998.08003839971, 36632.81683591565, 39007.0, 39214.2157156861, 39374.2125157501, 39447.408288876264, 24294.75705242925, 24493.0, 24726.629100563867, 29576.556351655174, 31081.0], "value": 22267.969438498116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.9935200971984, 436.72900915240746, 441.6047637364559, 442.46019855775955, 454.60222305482705, 18792.0, 18826.62346753066, 20164.495887602818, 20282.6957595636, 20355.898220508876, 19383.356070941336, 19724.605507889835, 20187.697184542245, 20404.0, 20502.89748551259, 5758.222639943607, 6027.789027384042, 6030.0, 6030.487408570277, 6032.125341825433, 5803.274590676166, 5914.260717410324, 5961.225040744697, 5965.403459654043, 6004.759809607633, 5952.047672372421, 5963.85090372742, 5967.8209653710455, 5968.0, 5975.0, 5748.856278593027, 5896.321922978848, 5954.017587098124, 5962.224910761595, 5962.433568810956, 5353.866153346158, 5353.946460535384, 5359.276497672803, 5367.81212657559, 5369.892602147975, 23712.7628723714, 23725.288241352613, 23826.285211443683, 23957.0, 24001.15995940134, 2472.5178590174924, 2577.7422257774074, 2598.298459415947, 2620.6986196587445, 3040.3767227718263, 14875.0, 14966.925165374103, 15297.847021529753, 15336.0, 15482.148481833494, 1907.7424547686162, 1934.2263094762209, 1945.6984167454068, 1948.503131701407, 1994.2421879685771, 52034.21948670773, 58413.41586584122, 87614.0, 91943.54028229883, 93897.530512347, 10819.56721731122, 10850.620228291971, 11338.0, 11667.35829529384, 11723.182906649483, 14160.645983850487, 14175.85824141766, 14769.483068092564, 15016.0, 15095.245237738069, 8796.604152813139, 8911.643534258557, 8976.37165398429, 9153.54232288383, 9252.352335336596, 8837.513936733541, 8919.910800892038, 9043.68347107848, 9053.094690530894, 9209.35534512591, 6771.695273712695, 6831.9658401707675, 6947.166340039228, 6964.408025317804, 7014.263502332284, 2017.3746138697052, 2039.6328660840895, 2049.1086377425568, 2074.4917495213767, 2096.465401322653, 819.5574389829426, 924.3021518753299, 928.7817362919709, 1021.1116328793996, 1114.9442527873573, 20857.89571052135, 21025.474363141046, 21101.155953761678, 21240.362789116352, 21387.25144619931, 1084.4902895639036, 1090.7000574841982, 1097.2538673701958, 1103.7185517692938, 1116.5812820192427, 11014.559417623366, 11120.944395278133, 11837.053035757119, 12127.211731237441, 12167.452464639113, 364738.0, 477162.0, 477536.0, 481149.0, 486252.0, 94905.5254723722, 95904.0, 96555.0, 97003.51498242604, 97419.51290243503, 1053.8629978102952, 1092.5356723392526, 1136.2671077155353, 1158.623447379605, 1159.3623507071077, 18388.264469421072, 18678.159482823576, 18812.52968675794, 18863.717044244622, 19512.707309390087, 46139.30791038204, 46325.536744632125, 46485.302720458545, 46513.76743116398, 46947.295790562486, 57928.0, 61086.38913610985, 61595.6920215396, 62024.37975620366, 63432.682836587366, 8830.64677412922, 8837.425567338103, 9084.909150908406, 9344.579493922925, 9441.669541566012, 11401.132358715906, 14007.1595704254, 14073.648158796112, 14075.155490670593, 14140.0, 11566.537338506365, 11985.0, 12021.737717539881, 12144.33206173669, 12241.081918855944, 12019.879801201876, 12076.094292928241, 12259.570915017932, 12263.202891812003, 12838.422270998015, 12083.033357331216, 12154.635360939186, 12302.138850280395, 12376.504939802307, 12461.563845265735, 9033.59348829291, 9073.637054518009, 9148.725538233864, 9198.632054718004, 9332.766680833034, 11937.94031029874, 12002.939985300018, 12037.578684745991, 12411.0, 12578.855286178456], "value": 9836.204750993635, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1539.5304432148193, 1570.2462817847434, 1732.6188238587506, 1828.1864570266237, 1872.9157187926533, 8096.635651395686, 8715.69495067672, 8724.607392667338, 8739.344549158823, 8744.78138046549, 7376.1148662160485, 7688.807779805494, 8023.67905283788, 8295.336373090153, 8303.045149807758, 2440.231327131952, 2467.1734968785477, 2467.6915385576804, 2471.1721573272976, 2472.7032756069207, 2042.60169266993, 2374.005835098517, 2441.438469152096, 2443.1448992852447, 2445.572024895645, 2130.4886827161527, 2321.083172147001, 2379.6311571706415, 2405.0, 2409.0, 2360.976390236093, 2372.3713215997686, 2373.1693907132367, 2381.9047238110456, 2382.29722231942, 2310.353101131686, 2313.9305820825234, 2316.1893337331967, 2317.40906068953, 2318.2233951626226, 8627.180417860292, 8704.0, 8704.521251331174, 8710.520921349324, 8722.04057553675, 5289.365276166846, 5368.087425137736, 5428.61999660024, 5431.131019036975, 5434.0218760623075, 3314.3537010283003, 3356.093854659253, 3482.6343233960324, 3483.111806489329, 3491.6508349165133, 1217.5190799634183, 1225.9387030648431, 1242.6644805902447, 1265.221888538542, 1271.1800888427006, 11630.651080467514, 11675.824862627067, 11684.824727629093, 11725.530978760755, 11752.236104653255, 4717.750252929598, 4765.76171191446, 4796.088743138793, 4883.536064073907, 4888.926666100011, 9975.700728978143, 9987.900120998842, 9995.350302230332, 10000.399976001463, 10020.799584008279, 5478.91781623276, 5488.780448782004, 5490.396056433789, 5493.697846618395, 5495.560355171577, 4840.419149701988, 4996.175631020841, 5008.248762685554, 5033.0437216929395, 5053.84838454847, 4158.293090174617, 4168.468220588816, 4230.344296634026, 4276.914461710749, 4290.141971605692, 1278.7826069568196, 1376.3256004557895, 1427.1437137717287, 1434.734574103794, 1445.3784872504714, 861.5606040919051, 1057.4554104636118, 1059.56557811297, 1063.7766069125416, 1070.743021674808, 5836.9124463133085, 5934.703264836828, 6065.211522502046, 6086.391360863879, 6108.6029408089225, 1019.6482213636284, 1039.6880935719255, 1042.3224903812581, 1056.27645063132, 1062.1715062251455, 4104.733192342488, 4230.70385073042, 4236.597523235288, 4239.448871646666, 4268.850590229389, 10285.794284114276, 10548.630797922036, 10572.15422766177, 10583.100436462986, 10593.576256949636, 10353.0, 10422.739431514272, 10481.790364192826, 10493.370397776158, 10505.894941050645, 7979.0425148982495, 8079.474834135763, 8092.757217283491, 8094.999999999882, 8097.595120243965, 5784.248047753765, 5806.1000544915605, 5938.406159384027, 6096.268447786294, 6293.905591416041, 9185.586648600696, 9490.193333566724, 9626.518674066128, 9631.9036809631, 9636.46999415039, 9593.328467007243, 9766.9023309766, 9782.804343913223, 9823.214142868695, 9840.753981150243, 7343.77968660941, 7487.3261406473675, 7487.363574096263, 7505.66224519887, 7565.205653406533, 8192.426530143071, 8228.50628962264, 8276.875846862422, 8295.917040829756, 8299.502029878227, 7482.176960534228, 7517.473776835569, 7561.508501947355, 7617.619119043915, 7634.770956871303, 7267.345938865316, 7279.927200727925, 7301.561906285639, 7302.598357090411, 7334.266573342837, 6949.061876646791, 6992.580445173306, 7036.437085033287, 7046.0, 7072.434205263464, 5020.99580083992, 5057.797688092435, 5175.223716442564, 5282.867928301823, 5344.011357898801, 4989.476105008922, 5123.948760512347, 5174.353205849269, 5224.58203343724, 5441.29263195782], "value": 4679.76705151257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.99461508077366, 366.7194596133957, 372.31679867443233, 377.4018181182827, 378.2378507307774, 5421.024215641183, 5493.697846618435, 5520.22716819645, 5535.114381698929, 5554.472325129106, 5152.793888244475, 5226.804742008366, 5301.416844147141, 5357.973210133953, 5465.152901300295, 4296.97851510742, 4317.309230523117, 4324.935125973113, 4331.242032644291, 4331.350297455376, 4316.697831151805, 4319.892002699926, 4341.674374421915, 4342.609165175134, 4361.760103194323, 4133.6486398656, 4243.193793179302, 4296.0978194579175, 4309.181255561449, 4317.870463886073, 4271.91456170878, 4283.678724095674, 4290.099079193373, 4305.590968857953, 4308.46144231971, 3813.2564149990762, 3833.5016447861876, 3835.9232815343817, 3841.9615803841884, 3843.385058390672, 5195.740212989335, 5263.210518422267, 5289.153735402318, 5302.2841916341185, 5326.493983071602, 4969.527894849984, 4972.105021096201, 4976.800927962877, 4977.054359671651, 4985.875353116165, 5682.346530149003, 5686.289213848269, 5699.601027928005, 5700.916825803084, 5726.541876649858, 4145.523264824554, 4231.70378073535, 4270.316749320094, 4294.441722576076, 4301.204277208695, 5850.824475265749, 5888.764449422018, 5907.075997381324, 5909.015946946764, 5919.408059194089, 4388.407564978751, 4394.670399720034, 4395.560443955643, 4410.669199810027, 4436.378906953029, 4387.539308372575, 4454.619068088903, 4481.574250446202, 4488.4165058542185, 4489.438820147481, 4940.2342636891335, 4946.233333833262, 4965.013994402196, 4971.328870602495, 5001.44984051754, 5700.857478563069, 5703.116017017369, 5709.429057094258, 5711.829075039607, 5714.228579141763, 1436.6480212348042, 1462.4808193091299, 1488.2261224163374, 1520.3994422203168, 1541.306412114553, 1065.8134826405349, 1074.505727365405, 1097.3415950429678, 1102.1568500097433, 1102.5314241447513, 5450.645708028966, 5491.780328786804, 5522.232885476689, 5522.8678120985105, 5537.612367134262, 5750.30996280449, 5771.365149833515, 5795.304563452329, 5795.710214489343, 5799.797007104731, 5249.2126181073145, 5486.341639003345, 5508.91736623951, 5528.502434780889, 5567.526760225426, 3058.4494790937847, 3116.98441507791, 3125.2186953261685, 3131.6242050954033, 3162.98418507906, 6064.696765161724, 6073.271207455134, 6074.179985701962, 6082.60463069899, 6099.725512351954, 5755.913661295001, 6045.697715114226, 6084.452399284086, 6098.603590766586, 6105.0, 6120.959436895739, 6130.314163605044, 6135.0, 6137.846553836101, 6155.1075094112, 5597.63615365, 5822.970885145547, 5878.2358293421585, 5945.286565612154, 5956.166136740946, 5816.272965879265, 5823.563232757476, 5837.824865254049, 5880.705964701833, 5880.7356418370255, 5798.56510761703, 5983.414395185192, 6039.184710064085, 6100.75596976116, 6103.6032657877095, 4285.5643359474925, 4305.268104422318, 4306.720063195882, 4306.806193721228, 4326.307790753464, 5924.0, 5926.851828704144, 5930.436608522184, 5931.288245410578, 5954.3152537458745, 5558.444155584571, 5609.9158512621525, 5624.212610234488, 5745.396733343106, 5788.565857560784, 5703.602617358773, 5728.140778883034, 5740.536163278337, 5760.732638819453, 5764.0, 5566.610337276352, 5642.486711715117, 5675.602707810413, 5701.315842098975, 5751.9424805751405, 5787.701010424018, 5791.189233507228, 5792.9710351447975, 5797.768089276382, 5798.275215598051, 5636.689982051026, 5641.26663533738, 5653.802116925888, 5663.3770285267765, 5665.971670141787], "value": 4429.5246024152675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.8380831929455, 813.459049731928, 839.8362319347726, 902.5757893789917, 917.6375331743966, 16393.0, 16911.238994245257, 17063.23215455303, 17075.658486830256, 17079.743803842954, 13883.236421996786, 14292.625751265612, 14485.710285794305, 14568.562943111698, 14587.051841630286, 872.6073267029831, 878.2666473494639, 878.9868151977726, 879.0725784297564, 879.4986857491233, 842.4397775479299, 847.4533925617973, 847.9491230526157, 847.9576021198947, 848.9533075680835, 884.2439714044496, 885.1944730295401, 885.2342723544152, 885.6147575804514, 889.9866502002443, 877.6708734224666, 879.3888247667842, 879.7140929198036, 882.4352414454754, 887.6316328723572, 644.0982624325981, 644.9580777249464, 645.0195702532125, 645.2225068792094, 651.2347991110473, 14231.003829731922, 14353.78469322961, 14367.281635918267, 14432.639184020378, 14520.0, 13757.0, 13919.304034798219, 14048.086874353237, 14152.716945661132, 14244.359003844747, 12121.151519393647, 12176.0, 12234.143609947307, 12291.877081229162, 12462.501499939992, 4026.8187931543152, 4040.333344998072, 4053.574374690674, 4087.0, 4185.434966279544, 53744.731276343366, 55559.16661250084, 68376.0, 68494.65752671254, 81823.5908820458, 12352.876471235353, 12521.686957825945, 12542.623721288375, 12671.809922851164, 12693.301868397326, 21742.891285543472, 21794.673079903812, 21821.127154913942, 21828.672569911465, 21831.672524912137, 8189.181081891882, 8763.56182190888, 8880.200781929658, 8947.642094316285, 9023.864642030374, 5007.324011258506, 5204.297419848348, 5270.393904700932, 5311.575073994071, 5459.344878614592, 3555.3955827509385, 3699.186179040607, 3703.7222208334483, 3710.8515659373325, 3717.0893131183034, 641.9967900160469, 646.9256035555877, 647.8930976388938, 648.1185587600859, 684.5037347922716, 716.6560051175464, 721.5129787393488, 744.3672878053719, 770.938324934004, 808.7856717969743, 9452.574634141343, 10290.331128476775, 10352.482375881176, 10470.528826202839, 10478.476076196159, 776.9417293702995, 795.5465384730647, 796.4663675337538, 807.5437377881595, 819.815541503157, 5009.727868477222, 5069.239614057847, 5137.6660517066275, 5141.177411614124, 5146.511081447256, 50020.49979500231, 67827.0, 67946.32053679498, 68217.0, 69933.65033174903, 69493.65253173701, 69680.65159674271, 71379.0, 102327.4883625577, 110933.44533277443, 79424.0, 94602.0, 94882.0, 96005.039949601, 97105.0, 9782.85325720129, 10368.326058806153, 10406.583736650751, 10428.791424171626, 10492.108170805566, 54056.0, 54287.0, 54508.454915451926, 54517.72741136269, 56474.92066026685, 72643.0, 73795.0, 80152.59923700344, 81828.0, 82728.58635707023, 13299.46802127904, 13321.200727956353, 13813.792793108312, 14054.134443783381, 14086.084404513675, 15016.174110423595, 15129.924350378178, 15191.620209494851, 15270.694586107993, 16190.514284571482, 13521.121127126706, 14254.28728563547, 14257.928710356382, 14306.141631501727, 14621.0496317739, 14132.15207087578, 14236.715265694422, 14393.568192954228, 14412.855871441152, 14512.419503219753, 13262.66843328886, 13565.932170339085, 13963.790543141658, 14018.859811401755, 14320.928395357956, 11442.313461192354, 11554.364509952033, 12008.759824803281, 12113.75772484563, 12201.877981220074, 12123.75752484963, 12143.271403715806, 12164.574239901562, 12421.19262247951, 12482.875171248172], "value": 7731.3949005453815, "unit": "score"}], "name": "dromaeo_css", "value": 7602.48265982511, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 113.0, 112.0, 112.0, 110.0, 112.0, 113.0, 112.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 120.0, 117.0, 147.0, 117.0, 118.0, 118.0, 116.0, 154.0, 117.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 159.0, 160.0, 162.0, 161.0, 161.0, 160.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 114.0, 75.0, 75.0, 75.0, 76.0, 103.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 112.0, 80.0, 83.0, 80.0, 99.0, 80.0, 81.0, 105.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 148.0, 149.0, 147.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 97.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 49.0, 48.0, 50.0, 48.0, 51.0, 48.0, 48.0, 48.0], "value": 48.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 74.0, 74.0, 74.0, 74.0, 79.0, 74.0, 73.0, 74.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 134.0, 124.0, 121.0, 119.0, 120.0, 121.0, 119.0, 154.0, 145.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 158.0, 157.0, 159.0, 154.0, 154.0, 157.0, 155.0, 158.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 64.0, 64.0, 63.0, 61.0, 62.0, 60.0, 60.0, 63.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1459.8, "alertThreshold": 2.0}]} 07:11:23 INFO - Return code: 0 07:11:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:11:23 INFO - # TBPL SUCCESS # 07:11:23 INFO - Running post-action listener: _resource_record_post_action 07:11:23 INFO - [mozharness: 2016-11-14 15:11:23.167750Z] Finished run-tests step (success) 07:11:23 INFO - Running post-run listener: _resource_record_post_run 07:11:23 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 359854080; Read time: 0; Write time: 202188 07:11:23 INFO - TinderboxPrint: CPU usage
12.9% 07:11:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:11:23 INFO - TinderboxPrint: I/O write bytes / time
359,854,080 / 202,188 07:11:23 INFO - TinderboxPrint: CPU idle
8,263.7 (87.1%) 07:11:23 INFO - TinderboxPrint: CPU user
1,183.6 (12.5%) 07:11:23 INFO - TinderboxPrint: Swap in / out
0 / 0 07:11:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107425792; Read time: 0; Write time: 76160 07:11:23 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 251297792; Read time: 0; Write time: 126000 07:11:23 INFO - Running post-run listener: _upload_blobber_files 07:11:23 INFO - Blob upload gear active. 07:11:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:11:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:11:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:11:24 INFO - (blobuploader) - INFO - Open directory for files ... 07:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:11:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:24 INFO - (blobuploader) - INFO - Done attempting. 07:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:11:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:28 INFO - (blobuploader) - INFO - Done attempting. 07:11:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:11:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:11:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:29 INFO - (blobuploader) - INFO - Done attempting. 07:11:29 INFO - (blobuploader) - INFO - Iteration through files over. 07:11:29 INFO - Return code: 0 07:11:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:11:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:11:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fbd4a15fdf30b586b70689743f686efb7de204de2b480e3398891ae7e5e6f646ef37de7e397b484bb102be295b4f4049804bb5a6c109e5048f65ae0be9b37ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eedfdd175055b4ca92da4b25723a6d3cac2a76e7e6bfa6e0e75e945cefb385bbd108e5bc4474b73b72f766de9d244acc1a4cb5750ddb5fc7ced774025c53924a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f281e194d4aa82096a3b5f1e7a82be78b25a96972a68c269eec426a09ea5188e67ea99f7395e06704b848daa4f541784f72272a42a1d4b1cb1d730517ca49a55"} 07:11:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:11:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:11:29 INFO - Contents: 07:11:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fbd4a15fdf30b586b70689743f686efb7de204de2b480e3398891ae7e5e6f646ef37de7e397b484bb102be295b4f4049804bb5a6c109e5048f65ae0be9b37ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eedfdd175055b4ca92da4b25723a6d3cac2a76e7e6bfa6e0e75e945cefb385bbd108e5bc4474b73b72f766de9d244acc1a4cb5750ddb5fc7ced774025c53924a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f281e194d4aa82096a3b5f1e7a82be78b25a96972a68c269eec426a09ea5188e67ea99f7395e06704b848daa4f541784f72272a42a1d4b1cb1d730517ca49a55"} 07:11:29 INFO - Running post-run listener: copy_logs_to_upload_dir 07:11:29 INFO - Copying logs to upload dir... 07:11:29 INFO - mkdir: /builds/slave/test/build/upload/logs 07:11:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.292881 ========= master_lag: 1.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-11-14 07:11:29.914557) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:11:29.918615) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695 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-Aurora/sha512/3fbd4a15fdf30b586b70689743f686efb7de204de2b480e3398891ae7e5e6f646ef37de7e397b484bb102be295b4f4049804bb5a6c109e5048f65ae0be9b37ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eedfdd175055b4ca92da4b25723a6d3cac2a76e7e6bfa6e0e75e945cefb385bbd108e5bc4474b73b72f766de9d244acc1a4cb5750ddb5fc7ced774025c53924a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f281e194d4aa82096a3b5f1e7a82be78b25a96972a68c269eec426a09ea5188e67ea99f7395e06704b848daa4f541784f72272a42a1d4b1cb1d730517ca49a55"} build_url:https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fbd4a15fdf30b586b70689743f686efb7de204de2b480e3398891ae7e5e6f646ef37de7e397b484bb102be295b4f4049804bb5a6c109e5048f65ae0be9b37ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eedfdd175055b4ca92da4b25723a6d3cac2a76e7e6bfa6e0e75e945cefb385bbd108e5bc4474b73b72f766de9d244acc1a4cb5750ddb5fc7ced774025c53924a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f281e194d4aa82096a3b5f1e7a82be78b25a96972a68c269eec426a09ea5188e67ea99f7395e06704b848daa4f541784f72272a42a1d4b1cb1d730517ca49a55"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:11:29.951661) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:11:29.952125) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1479134849.376573-786207695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:11:30.001877) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:11:30.003861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:11:30.004159) ========= ========= Total master_lag: 1.35 =========