builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1474908706.4 results: success (0) buildid: 20160926071051 builduid: 3ab86d85e2c84be190194f7a2ebafa47 revision: ee066384095172f059aab32ed55839e66372cce5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:46.395923) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:46.396353) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:46.396641) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:46.411301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:46.411627) ========= 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=17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 09:51:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.9M=0s 2016-09-26 09:51:47 (38.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128037 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:46.553601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:46.553922) ========= 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=17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022531 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:46.604669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:46.605014) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ee066384095172f059aab32ed55839e66372cce5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev ee066384095172f059aab32ed55839e66372cce5 --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=17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 09:51:47,235 truncating revision to first 12 chars 2016-09-26 09:51:47,235 Setting DEBUG logging. 2016-09-26 09:51:47,235 attempt 1/10 2016-09-26 09:51:47,235 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ee0663840951?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 09:51:47,696 unpacking tar archive at: autoland-ee0663840951/testing/mozharness/ program finished with exit code 0 elapsedTime=0.813916 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:47.432731) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:47.433082) ========= script_repo_revision: ee066384095172f059aab32ed55839e66372cce5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:47.433483) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:47.433756) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 09:51:47.444924) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-26 09:51:47.445268) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:51:48 INFO - MultiFileLogger online at 20160926 09:51:48 in /builds/slave/test 09:51:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 09:51:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:51:48 INFO - {'append_to_log': False, 09:51:48 INFO - 'base_work_dir': '/builds/slave/test', 09:51:48 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 09:51:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:51:48 INFO - 'branch': 'Autoland-Non-PGO', 09:51:48 INFO - 'buildbot_json_path': 'buildprops.json', 09:51:48 INFO - 'config_files': ('talos/linux_config.py',), 09:51:48 INFO - 'default_actions': ('clobber', 09:51:48 INFO - 'read-buildbot-config', 09:51:48 INFO - 'download-and-extract', 09:51:48 INFO - 'populate-webroot', 09:51:48 INFO - 'create-virtualenv', 09:51:48 INFO - 'install', 09:51:48 INFO - 'run-tests'), 09:51:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:51:48 INFO - 'download_minidump_stackwalk': True, 09:51:48 INFO - 'download_symbols': 'ondemand', 09:51:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:51:48 INFO - 'tooltool.py': '/tools/tooltool.py', 09:51:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:51:48 INFO - '/tools/misc-python/virtualenv.py')}, 09:51:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:51:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:51:48 INFO - 'installer_path': 'installer.exe', 09:51:48 INFO - 'log_level': 'info', 09:51:48 INFO - 'log_name': 'talos', 09:51:48 INFO - 'log_to_console': True, 09:51:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:51:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:51:48 INFO - 'opt_config_files': (), 09:51:48 INFO - 'pip_index': False, 09:51:48 INFO - 'sps_profile': False, 09:51:48 INFO - 'sps_profile_interval': 0, 09:51:48 INFO - 'suite': 'dromaeojs', 09:51:48 INFO - 'system_bits': '32', 09:51:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:51:48 INFO - 'title': 'talos-linux64-ix-009', 09:51:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:51:48 INFO - 'use_talos_json': True, 09:51:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:51:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:51:48 INFO - 'work_dir': 'build'} 09:51:48 INFO - [mozharness: 2016-09-26 16:51:48.166182Z] Running clobber step. 09:51:48 INFO - Running pre-action listener: _resource_record_pre_action 09:51:48 INFO - Running main action method: clobber 09:51:48 INFO - rmtree: /builds/slave/test/build 09:51:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:51:48 INFO - Running post-action listener: _resource_record_post_action 09:51:48 INFO - [mozharness: 2016-09-26 16:51:48.626487Z] Finished clobber step (success) 09:51:48 INFO - [mozharness: 2016-09-26 16:51:48.626588Z] Running read-buildbot-config step. 09:51:48 INFO - Running pre-action listener: _resource_record_pre_action 09:51:48 INFO - Running main action method: read_buildbot_config 09:51:48 INFO - Using buildbot properties: 09:51:48 INFO - { 09:51:48 INFO - "project": "", 09:51:48 INFO - "product": "firefox", 09:51:48 INFO - "script_repo_revision": "production", 09:51:48 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 09:51:48 INFO - "repository": "", 09:51:48 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 09:51:48 INFO - "buildid": "20160926071051", 09:51:48 INFO - "pgo_build": "False", 09:51:48 INFO - "basedir": "/builds/slave/test", 09:51:48 INFO - "buildnumber": 646, 09:51:48 INFO - "slavename": "talos-linux64-ix-009", 09:51:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:51:48 INFO - "platform": "ubuntu64_hw", 09:51:48 INFO - "scheduler": "tests-autoland-linux64-talos-8-3600", 09:51:48 INFO - "branch": "autoland", 09:51:48 INFO - "repo_path": "integration/autoland", 09:51:48 INFO - "revision": "ee066384095172f059aab32ed55839e66372cce5", 09:51:48 INFO - "stage_platform": "linux64", 09:51:48 INFO - "builduid": "3ab86d85e2c84be190194f7a2ebafa47", 09:51:48 INFO - "slavebuilddir": "test" 09:51:48 INFO - } 09:51:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:51:48 INFO - Running post-action listener: _resource_record_post_action 09:51:48 INFO - [mozharness: 2016-09-26 16:51:48.629034Z] Finished read-buildbot-config step (success) 09:51:48 INFO - [mozharness: 2016-09-26 16:51:48.629122Z] Running download-and-extract step. 09:51:48 INFO - Running pre-action listener: _resource_record_pre_action 09:51:48 INFO - Running main action method: download_and_extract 09:51:48 INFO - mkdir: /builds/slave/test/build/tests 09:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:48 INFO - trying https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:51:48 INFO - Downloading https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:51:49 INFO - Downloaded 1361 bytes. 09:51:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:51:49 INFO - Using the following test package requirements: 09:51:49 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:51:49 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:51:49 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:51:49 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:49 INFO - u'jsshell-linux-x86_64.zip'], 09:51:49 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:51:49 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:51:49 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:51:49 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:51:49 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:51:49 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:51:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:51:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:51:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:51:49 INFO - Fetch https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:51:49 INFO - Expected file size: 20410868 09:51:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:51:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:51:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:51:54 INFO - Fetch https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:51:54 INFO - Expected file size: 20410868 09:51:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:51:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:51:59 INFO - Fetch https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:51:59 INFO - Expected file size: 14414057 09:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:00 INFO - trying https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:52:00 INFO - Downloading https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:52:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:52:01 INFO - Downloaded 55744828 bytes. 09:52:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:52:01 INFO - mkdir: /builds/slave/test/properties 09:52:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:52:01 INFO - Writing to file /builds/slave/test/properties/build_url 09:52:01 INFO - Contents: 09:52:01 INFO - build_url:https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:52:02 INFO - Running post-action listener: _resource_record_post_action 09:52:02 INFO - Running post-action listener: set_extra_try_arguments 09:52:02 INFO - [mozharness: 2016-09-26 16:52:02.203051Z] Finished download-and-extract step (success) 09:52:02 INFO - [mozharness: 2016-09-26 16:52:02.203276Z] Running populate-webroot step. 09:52:02 INFO - Running pre-action listener: _resource_record_pre_action 09:52:02 INFO - Running main action method: populate_webroot 09:52:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:52:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:52:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:52:02 INFO - '--tppagecycles', 09:52:02 INFO - '7'], 09:52:02 INFO - 'tests': ['tsvgm']}}, 09:52:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:52:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:52:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:52:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:52:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:52:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:52:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:02 INFO - 'talos_options': ['--disable-e10s'], 09:52:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:02 INFO - 'talos_options': ['--disable-e10s'], 09:52:02 INFO - 'tests': ['damp', 'tps']}, 09:52:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:02 INFO - 'tests': ['damp', 'tps']}, 09:52:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:52:02 INFO - 'tests': ['dromaeo_dom']}, 09:52:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:52:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:52:02 INFO - 'tests': ['basic_compositor_video']}, 09:52:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:52:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:52:02 INFO - 'tests': ['a11yr', 09:52:02 INFO - 'ts_paint', 09:52:02 INFO - 'tpaint', 09:52:02 INFO - 'sessionrestore', 09:52:02 INFO - 'sessionrestore_no_auto_restore', 09:52:02 INFO - 'tabpaint']}, 09:52:02 INFO - 'other-e10s': {'tests': ['a11yr', 09:52:02 INFO - 'ts_paint', 09:52:02 INFO - 'tpaint', 09:52:02 INFO - 'sessionrestore', 09:52:02 INFO - 'sessionrestore_no_auto_restore', 09:52:02 INFO - 'tabpaint']}, 09:52:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:52:02 INFO - 'ts_paint', 09:52:02 INFO - 'tpaint', 09:52:02 INFO - 'sessionrestore', 09:52:02 INFO - 'sessionrestore_no_auto_restore', 09:52:02 INFO - 'tabpaint']}, 09:52:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:52:02 INFO - 'ts_paint', 09:52:02 INFO - 'tpaint', 09:52:02 INFO - 'sessionrestore', 09:52:02 INFO - 'sessionrestore_no_auto_restore', 09:52:02 INFO - 'tabpaint']}, 09:52:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:52:02 INFO - 'tests': ['a11yr', 09:52:02 INFO - 'ts_paint', 09:52:02 INFO - 'tpaint', 09:52:02 INFO - 'sessionrestore', 09:52:02 INFO - 'sessionrestore_no_auto_restore', 09:52:02 INFO - 'tabpaint']}, 09:52:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:52:02 INFO - 'tests': ['a11yr', 09:52:02 INFO - 'ts_paint', 09:52:02 INFO - 'tpaint', 09:52:02 INFO - 'sessionrestore', 09:52:02 INFO - 'sessionrestore_no_auto_restore', 09:52:02 INFO - 'tabpaint']}, 09:52:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:52:02 INFO - 'tests': ['tsvgx', 09:52:02 INFO - 'tsvgr_opacity', 09:52:02 INFO - 'tart', 09:52:02 INFO - 'tscrollx', 09:52:02 INFO - 'cart']}, 09:52:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:52:02 INFO - 'tsvgr_opacity', 09:52:02 INFO - 'tart', 09:52:02 INFO - 'tscrollx', 09:52:02 INFO - 'cart']}, 09:52:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:02 INFO - 'talos_options': ['--disable-e10s'], 09:52:02 INFO - 'tests': ['tp5o']}, 09:52:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:02 INFO - 'tests': ['tp5o']}, 09:52:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:02 INFO - 'talos_options': ['--disable-e10s', 09:52:02 INFO - '--xperf_path', 09:52:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:02 INFO - 'tests': ['tp5n']}, 09:52:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:02 INFO - 'talos_options': ['--xperf_path', 09:52:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:02 INFO - 'tests': ['tp5n']}}, 09:52:02 INFO - 'talos.zip': {'path': '', 09:52:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:52:02 INFO - Running post-action listener: _resource_record_post_action 09:52:02 INFO - [mozharness: 2016-09-26 16:52:02.223578Z] Finished populate-webroot step (success) 09:52:02 INFO - [mozharness: 2016-09-26 16:52:02.223667Z] Running create-virtualenv step. 09:52:02 INFO - Running pre-action listener: _resource_record_pre_action 09:52:02 INFO - Running main action method: create_virtualenv 09:52:02 INFO - Creating virtualenv /builds/slave/test/build/venv 09:52:02 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 09:52:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:52:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:52:02 INFO - Using real prefix '/usr' 09:52:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:52:02 INFO - Installing distribute.............................................................................................................................................................................................done. 09:52:04 INFO - Installing pip.................done. 09:52:04 INFO - Return code: 0 09:52:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:52:05 INFO - Reading from file tmpfile_stdout 09:52:05 INFO - Output received: 09:52:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:52:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:52:05 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')]} 09:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:05 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')]} 09:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:05 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 0x7f942a9b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc8f60>, '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 0xdc9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdca1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', '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 09:52:05 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 09:52:05 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 09:52:05 INFO - Using env: {'DISPLAY': ':0', 09:52:05 INFO - 'HOME': '/home/cltbld', 09:52:05 INFO - 'LANG': 'en_US.UTF-8', 09:52:05 INFO - 'LANGUAGE': 'en_US:en', 09:52:05 INFO - 'LOGNAME': 'cltbld', 09:52:05 INFO - 'MAIL': '/var/mail/cltbld', 09:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:05 INFO - 'MOZ_NO_REMOTE': '1', 09:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:05 INFO - 'NO_EM_RESTART': '1', 09:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:05 INFO - 'PWD': '/builds/slave/test', 09:52:05 INFO - 'SHELL': '/bin/bash', 09:52:05 INFO - 'SHLVL': '1', 09:52:05 INFO - 'TERM': 'linux', 09:52:05 INFO - 'TMOUT': '86400', 09:52:05 INFO - 'USER': 'cltbld', 09:52:05 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', 09:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:05 INFO - '_': '/tools/buildbot/bin/python'} 09:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:05 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 09:52:05 INFO - Cleaning up... 09:52:05 INFO - Return code: 0 09:52:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:52:05 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')]} 09:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:05 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')]} 09:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:05 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 0x7f942a9b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc8f60>, '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 0xdc9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdca1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', '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 09:52:05 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 09:52:05 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 09:52:05 INFO - Using env: {'DISPLAY': ':0', 09:52:05 INFO - 'HOME': '/home/cltbld', 09:52:05 INFO - 'LANG': 'en_US.UTF-8', 09:52:05 INFO - 'LANGUAGE': 'en_US:en', 09:52:05 INFO - 'LOGNAME': 'cltbld', 09:52:05 INFO - 'MAIL': '/var/mail/cltbld', 09:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:05 INFO - 'MOZ_NO_REMOTE': '1', 09:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:05 INFO - 'NO_EM_RESTART': '1', 09:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:05 INFO - 'PWD': '/builds/slave/test', 09:52:05 INFO - 'SHELL': '/bin/bash', 09:52:05 INFO - 'SHLVL': '1', 09:52:05 INFO - 'TERM': 'linux', 09:52:05 INFO - 'TMOUT': '86400', 09:52:05 INFO - 'USER': 'cltbld', 09:52:05 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', 09:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:05 INFO - '_': '/tools/buildbot/bin/python'} 09:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:05 INFO - Downloading/unpacking psutil>=3.1.1 09:52:05 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 09:52:05 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 09:52:05 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 09:52:05 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 09:52:05 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 09:52:05 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 09:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:52:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:07 INFO - Installing collected packages: psutil 09:52:07 INFO - Running setup.py install for psutil 09:52:07 INFO - building 'psutil._psutil_linux' extension 09:52:07 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 09:52:07 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 09:52:07 INFO - building 'psutil._psutil_posix' extension 09:52:07 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 09:52:07 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 09:52:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:07 INFO - Successfully installed psutil 09:52:07 INFO - Cleaning up... 09:52:07 INFO - Return code: 0 09:52:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:52:07 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')]} 09:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:07 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')]} 09:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:07 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 0x7f942a9b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc8f60>, '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 0xdc9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdca1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', '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 09:52:07 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 09:52:07 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 09:52:07 INFO - Using env: {'DISPLAY': ':0', 09:52:07 INFO - 'HOME': '/home/cltbld', 09:52:07 INFO - 'LANG': 'en_US.UTF-8', 09:52:07 INFO - 'LANGUAGE': 'en_US:en', 09:52:07 INFO - 'LOGNAME': 'cltbld', 09:52:07 INFO - 'MAIL': '/var/mail/cltbld', 09:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:07 INFO - 'MOZ_NO_REMOTE': '1', 09:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:07 INFO - 'NO_EM_RESTART': '1', 09:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:07 INFO - 'PWD': '/builds/slave/test', 09:52:07 INFO - 'SHELL': '/bin/bash', 09:52:07 INFO - 'SHLVL': '1', 09:52:07 INFO - 'TERM': 'linux', 09:52:07 INFO - 'TMOUT': '86400', 09:52:07 INFO - 'USER': 'cltbld', 09:52:07 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', 09:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:07 INFO - '_': '/tools/buildbot/bin/python'} 09:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:52:10 INFO - Installing collected packages: mozsystemmonitor 09:52:10 INFO - Running setup.py install for mozsystemmonitor 09:52:10 INFO - Successfully installed mozsystemmonitor 09:52:10 INFO - Cleaning up... 09:52:10 INFO - Return code: 0 09:52:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:10 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 0x7f942a9b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc8f60>, '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 0xdc9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdca1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', '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 09:52:10 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 09:52:10 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 09:52:10 INFO - Using env: {'DISPLAY': ':0', 09:52:10 INFO - 'HOME': '/home/cltbld', 09:52:10 INFO - 'LANG': 'en_US.UTF-8', 09:52:10 INFO - 'LANGUAGE': 'en_US:en', 09:52:10 INFO - 'LOGNAME': 'cltbld', 09:52:10 INFO - 'MAIL': '/var/mail/cltbld', 09:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:10 INFO - 'MOZ_NO_REMOTE': '1', 09:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:10 INFO - 'NO_EM_RESTART': '1', 09:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:10 INFO - 'PWD': '/builds/slave/test', 09:52:10 INFO - 'SHELL': '/bin/bash', 09:52:10 INFO - 'SHLVL': '1', 09:52:10 INFO - 'TERM': 'linux', 09:52:10 INFO - 'TMOUT': '86400', 09:52:10 INFO - 'USER': 'cltbld', 09:52:10 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', 09:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:10 INFO - '_': '/tools/buildbot/bin/python'} 09:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:10 INFO - Downloading/unpacking jsonschema==2.5.1 09:52:10 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 09:52:10 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 09:52:10 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 09:52:10 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 09:52:10 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 09:52:10 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 09:52:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:52:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:52:12 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 09:52:12 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 09:52:12 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 09:52:12 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 09:52:12 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 09:52:12 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 09:52:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:52:12 INFO - warning: no files found matching '*.txt' 09:52:12 INFO - no previously-included directories found matching 'build' 09:52:12 INFO - no previously-included directories found matching 'dist' 09:52:12 INFO - no previously-included directories found matching '.git*' 09:52:12 INFO - Installing collected packages: jsonschema, functools32 09:52:12 INFO - Running setup.py install for functools32 09:52:12 INFO - warning: no files found matching '*.txt' 09:52:12 INFO - no previously-included directories found matching 'build' 09:52:12 INFO - no previously-included directories found matching 'dist' 09:52:12 INFO - no previously-included directories found matching '.git*' 09:52:12 INFO - Successfully installed jsonschema functools32 09:52:12 INFO - Cleaning up... 09:52:12 INFO - Return code: 0 09:52:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:52:12 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')]} 09:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:12 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')]} 09:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:12 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 0x7f942a9b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc8f60>, '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 0xdc9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdca1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', '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 09:52:12 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 09:52:12 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 09:52:12 INFO - Using env: {'DISPLAY': ':0', 09:52:12 INFO - 'HOME': '/home/cltbld', 09:52:12 INFO - 'LANG': 'en_US.UTF-8', 09:52:12 INFO - 'LANGUAGE': 'en_US:en', 09:52:12 INFO - 'LOGNAME': 'cltbld', 09:52:12 INFO - 'MAIL': '/var/mail/cltbld', 09:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:12 INFO - 'MOZ_NO_REMOTE': '1', 09:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:12 INFO - 'NO_EM_RESTART': '1', 09:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:12 INFO - 'PWD': '/builds/slave/test', 09:52:12 INFO - 'SHELL': '/bin/bash', 09:52:12 INFO - 'SHLVL': '1', 09:52:12 INFO - 'TERM': 'linux', 09:52:12 INFO - 'TMOUT': '86400', 09:52:12 INFO - 'USER': 'cltbld', 09:52:12 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', 09:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:12 INFO - '_': '/tools/buildbot/bin/python'} 09:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:52:13 INFO - Cleaning up... 09:52:13 INFO - Return code: 0 09:52:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:13 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 0x7f942a9b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc8f60>, '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 0xdc9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdca1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', '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 09:52:13 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 09:52:13 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 09:52:13 INFO - Using env: {'DISPLAY': ':0', 09:52:13 INFO - 'HOME': '/home/cltbld', 09:52:13 INFO - 'LANG': 'en_US.UTF-8', 09:52:13 INFO - 'LANGUAGE': 'en_US:en', 09:52:13 INFO - 'LOGNAME': 'cltbld', 09:52:13 INFO - 'MAIL': '/var/mail/cltbld', 09:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:13 INFO - 'MOZ_NO_REMOTE': '1', 09:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:13 INFO - 'NO_EM_RESTART': '1', 09:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:13 INFO - 'PWD': '/builds/slave/test', 09:52:13 INFO - 'SHELL': '/bin/bash', 09:52:13 INFO - 'SHLVL': '1', 09:52:13 INFO - 'TERM': 'linux', 09:52:13 INFO - 'TMOUT': '86400', 09:52:13 INFO - 'USER': 'cltbld', 09:52:13 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', 09:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:13 INFO - '_': '/tools/buildbot/bin/python'} 09:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:15 INFO - Downloading blobuploader-1.2.4.tar.gz 09:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:52:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:52:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:15 INFO - Downloading docopt-0.6.1.tar.gz 09:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:52:15 INFO - Installing collected packages: blobuploader, requests, docopt 09:52:15 INFO - Running setup.py install for blobuploader 09:52:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:52:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:52:16 INFO - Running setup.py install for requests 09:52:16 INFO - Running setup.py install for docopt 09:52:16 INFO - Successfully installed blobuploader requests docopt 09:52:16 INFO - Cleaning up... 09:52:16 INFO - Return code: 0 09:52:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:16 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 0x7f942a9b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc8f60>, '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 0xdc9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdca1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', '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 09:52:16 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 09:52:16 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 09:52:16 INFO - Using env: {'DISPLAY': ':0', 09:52:16 INFO - 'HOME': '/home/cltbld', 09:52:16 INFO - 'LANG': 'en_US.UTF-8', 09:52:16 INFO - 'LANGUAGE': 'en_US:en', 09:52:16 INFO - 'LOGNAME': 'cltbld', 09:52:16 INFO - 'MAIL': '/var/mail/cltbld', 09:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:16 INFO - 'MOZ_NO_REMOTE': '1', 09:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:16 INFO - 'NO_EM_RESTART': '1', 09:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:16 INFO - 'PWD': '/builds/slave/test', 09:52:16 INFO - 'SHELL': '/bin/bash', 09:52:16 INFO - 'SHLVL': '1', 09:52:16 INFO - 'TERM': 'linux', 09:52:16 INFO - 'TMOUT': '86400', 09:52:16 INFO - 'USER': 'cltbld', 09:52:16 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', 09:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:16 INFO - '_': '/tools/buildbot/bin/python'} 09:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:52:16 INFO - Running setup.py (path:/tmp/pip-cTpCWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:52:16 INFO - Running setup.py (path:/tmp/pip-lO7ExH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:52:16 INFO - Running setup.py (path:/tmp/pip-Zo7pQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:52:16 INFO - Running setup.py (path:/tmp/pip-1QIE7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:52:17 INFO - Running setup.py (path:/tmp/pip-VbNrGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:52:17 INFO - Running setup.py (path:/tmp/pip-B3x1TT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:52:17 INFO - Running setup.py (path:/tmp/pip-5Lru39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:52:17 INFO - Running setup.py (path:/tmp/pip-XZ8fVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:52:17 INFO - Running setup.py (path:/tmp/pip-Rqt5Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:52:17 INFO - Running setup.py (path:/tmp/pip-Q1GPp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:52:17 INFO - Running setup.py (path:/tmp/pip-I09HOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:52:17 INFO - Running setup.py (path:/tmp/pip-E43vhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:52:17 INFO - Running setup.py (path:/tmp/pip-bqPUdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:52:17 INFO - Running setup.py (path:/tmp/pip-KRB_Ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:17 INFO - Running setup.py (path:/tmp/pip-BXBlET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:52:17 INFO - Running setup.py (path:/tmp/pip-wLzZg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:52:17 INFO - Running setup.py (path:/tmp/pip-IhB58h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:52:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:52:18 INFO - Running setup.py install for manifestparser 09:52:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:52:18 INFO - Running setup.py install for mozcrash 09:52:18 INFO - Running setup.py install for mozdebug 09:52:18 INFO - Running setup.py install for mozdevice 09:52:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:52:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:52:18 INFO - Running setup.py install for mozfile 09:52:18 INFO - Running setup.py install for mozhttpd 09:52:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:52:18 INFO - Running setup.py install for mozinfo 09:52:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:52:18 INFO - Running setup.py install for mozInstall 09:52:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:52:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:52:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:52:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:52:18 INFO - Running setup.py install for mozleak 09:52:18 INFO - Running setup.py install for mozlog 09:52:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:52:19 INFO - Running setup.py install for moznetwork 09:52:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:52:19 INFO - Running setup.py install for mozprocess 09:52:19 INFO - Running setup.py install for mozprofile 09:52:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:52:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:52:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:52:19 INFO - Running setup.py install for mozrunner 09:52:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:52:19 INFO - Running setup.py install for mozscreenshot 09:52:19 INFO - Running setup.py install for moztest 09:52:19 INFO - Running setup.py install for mozversion 09:52:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:52:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:52:19 INFO - Cleaning up... 09:52:19 INFO - Return code: 0 09:52:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:19 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 0x7f942a9b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc8f60>, '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 0xdc9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdca1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', '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 09:52:19 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 09:52:19 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 09:52:19 INFO - Using env: {'DISPLAY': ':0', 09:52:19 INFO - 'HOME': '/home/cltbld', 09:52:19 INFO - 'LANG': 'en_US.UTF-8', 09:52:19 INFO - 'LANGUAGE': 'en_US:en', 09:52:19 INFO - 'LOGNAME': 'cltbld', 09:52:19 INFO - 'MAIL': '/var/mail/cltbld', 09:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:19 INFO - 'MOZ_NO_REMOTE': '1', 09:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:19 INFO - 'NO_EM_RESTART': '1', 09:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:19 INFO - 'PWD': '/builds/slave/test', 09:52:19 INFO - 'SHELL': '/bin/bash', 09:52:19 INFO - 'SHLVL': '1', 09:52:19 INFO - 'TERM': 'linux', 09:52:19 INFO - 'TMOUT': '86400', 09:52:19 INFO - 'USER': 'cltbld', 09:52:19 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', 09:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:19 INFO - '_': '/tools/buildbot/bin/python'} 09:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:52:20 INFO - Running setup.py (path:/tmp/pip-UpA3UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:52:20 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)) 09:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:52:20 INFO - Running setup.py (path:/tmp/pip-XJ6dsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:52:20 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)) 09:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:52:20 INFO - Running setup.py (path:/tmp/pip-qRV7a5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:52:20 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)) 09:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:52:20 INFO - Running setup.py (path:/tmp/pip-qJbgNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:52:20 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)) 09:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:52:20 INFO - Running setup.py (path:/tmp/pip-pUjyJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:52:20 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)) 09:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:52:20 INFO - Running setup.py (path:/tmp/pip-idLFIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:52:20 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)) 09:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:52:20 INFO - Running setup.py (path:/tmp/pip-5J24Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:52:20 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)) 09:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:52:20 INFO - Running setup.py (path:/tmp/pip-uVOS6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:52:20 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)) 09:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:52:20 INFO - Running setup.py (path:/tmp/pip-Hhsrgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:52:20 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)) 09:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:52:20 INFO - Running setup.py (path:/tmp/pip-xNKuWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:52:20 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)) 09:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:52:20 INFO - Running setup.py (path:/tmp/pip-FXHWb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:52:20 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)) 09:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:52:20 INFO - Running setup.py (path:/tmp/pip-kHYspj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:52:20 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)) 09:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:52:20 INFO - Running setup.py (path:/tmp/pip-YKlQhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:52:20 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)) 09:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:52:20 INFO - Running setup.py (path:/tmp/pip-T5QxSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:52:21 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)) 09:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:21 INFO - Running setup.py (path:/tmp/pip-vl78CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:21 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)) 09:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:52:21 INFO - Running setup.py (path:/tmp/pip-iuM2rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:52:21 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)) 09:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:52:21 INFO - Running setup.py (path:/tmp/pip-RJ6lV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:52:21 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)) 09:52:21 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)) 09:52:21 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)) 09:52:21 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)) 09:52:21 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)) 09:52:21 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)) 09:52:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:23 INFO - Downloading blessings-1.6.tar.gz 09:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:52:23 INFO - Installing collected packages: blessings 09:52:23 INFO - Running setup.py install for blessings 09:52:23 INFO - Successfully installed blessings 09:52:23 INFO - Cleaning up... 09:52:23 INFO - Return code: 0 09:52:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:52:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:52:23 INFO - Reading from file tmpfile_stdout 09:52:23 INFO - Current package versions: 09:52:23 INFO - argparse == 1.2.1 09:52:23 INFO - blessings == 1.6 09:52:23 INFO - blobuploader == 1.2.4 09:52:23 INFO - docopt == 0.6.1 09:52:23 INFO - functools32 == 3.2.3-2 09:52:23 INFO - jsonschema == 2.5.1 09:52:23 INFO - manifestparser == 1.1 09:52:23 INFO - mozInstall == 1.12 09:52:23 INFO - mozcrash == 0.17 09:52:23 INFO - mozdebug == 0.1 09:52:23 INFO - mozdevice == 0.48 09:52:23 INFO - mozfile == 1.2 09:52:23 INFO - mozhttpd == 0.7 09:52:23 INFO - mozinfo == 0.9 09:52:23 INFO - mozleak == 0.1 09:52:23 INFO - mozlog == 3.4 09:52:23 INFO - moznetwork == 0.27 09:52:23 INFO - mozprocess == 0.23 09:52:23 INFO - mozprofile == 0.28 09:52:23 INFO - mozrunner == 6.12 09:52:23 INFO - mozscreenshot == 0.1 09:52:23 INFO - mozsystemmonitor == 0.3 09:52:23 INFO - moztest == 0.7 09:52:23 INFO - mozversion == 1.4 09:52:23 INFO - psutil == 3.1.1 09:52:23 INFO - requests == 1.2.3 09:52:23 INFO - wsgiref == 0.1.2 09:52:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:23 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 0x7f942a9b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc8f60>, '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 0xdc9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdca1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', '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 09:52:23 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 09:52:23 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 09:52:23 INFO - Using env: {'DISPLAY': ':0', 09:52:23 INFO - 'HOME': '/home/cltbld', 09:52:23 INFO - 'LANG': 'en_US.UTF-8', 09:52:23 INFO - 'LANGUAGE': 'en_US:en', 09:52:23 INFO - 'LOGNAME': 'cltbld', 09:52:23 INFO - 'MAIL': '/var/mail/cltbld', 09:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:23 INFO - 'MOZ_NO_REMOTE': '1', 09:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:23 INFO - 'NO_EM_RESTART': '1', 09:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:23 INFO - 'PWD': '/builds/slave/test', 09:52:23 INFO - 'SHELL': '/bin/bash', 09:52:23 INFO - 'SHLVL': '1', 09:52:23 INFO - 'TERM': 'linux', 09:52:23 INFO - 'TMOUT': '86400', 09:52:23 INFO - 'USER': 'cltbld', 09:52:23 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', 09:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:23 INFO - '_': '/tools/buildbot/bin/python'} 09:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:23 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)) 09:52:23 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)) 09:52:23 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)) 09:52:23 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)) 09:52:23 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)) 09:52:23 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)) 09:52:23 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)) 09:52:23 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)) 09:52:23 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)) 09:52:23 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)) 09:52:23 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)) 09:52:23 INFO - Cleaning up... 09:52:23 INFO - Return code: 0 09:52:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:23 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 0x7f942a9b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc8f60>, '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 0xdc9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdca1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', '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 09:52:23 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 09:52:23 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 09:52:23 INFO - Using env: {'DISPLAY': ':0', 09:52:23 INFO - 'HOME': '/home/cltbld', 09:52:23 INFO - 'LANG': 'en_US.UTF-8', 09:52:23 INFO - 'LANGUAGE': 'en_US:en', 09:52:23 INFO - 'LOGNAME': 'cltbld', 09:52:23 INFO - 'MAIL': '/var/mail/cltbld', 09:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:23 INFO - 'MOZ_NO_REMOTE': '1', 09:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:23 INFO - 'NO_EM_RESTART': '1', 09:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:23 INFO - 'PWD': '/builds/slave/test', 09:52:23 INFO - 'SHELL': '/bin/bash', 09:52:23 INFO - 'SHLVL': '1', 09:52:23 INFO - 'TERM': 'linux', 09:52:23 INFO - 'TMOUT': '86400', 09:52:23 INFO - 'USER': 'cltbld', 09:52:23 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', 09:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:23 INFO - '_': '/tools/buildbot/bin/python'} 09:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:52:24 INFO - Cleaning up... 09:52:24 INFO - Return code: 0 09:52:24 INFO - Running post-action listener: _resource_record_post_action 09:52:24 INFO - Running post-action listener: _start_resource_monitoring 09:52:24 INFO - Starting resource monitoring. 09:52:24 INFO - [mozharness: 2016-09-26 16:52:24.091714Z] Finished create-virtualenv step (success) 09:52:24 INFO - [mozharness: 2016-09-26 16:52:24.092215Z] Running install step. 09:52:24 INFO - Running pre-action listener: _resource_record_pre_action 09:52:24 INFO - Running main action method: install 09:52:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:52:24 INFO - Reading from file tmpfile_stdout 09:52:24 INFO - Detecting whether we're running mozinstall >=1.0... 09:52:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:52:24 INFO - Reading from file tmpfile_stdout 09:52:24 INFO - Output received: 09:52:24 INFO - Usage: mozinstall [options] installer 09:52:24 INFO - Options: 09:52:24 INFO - -h, --help show this help message and exit 09:52:24 INFO - -d DEST, --destination=DEST 09:52:24 INFO - Directory to install application into. [default: 09:52:24 INFO - "/builds/slave/test"] 09:52:24 INFO - --app=APP Application being installed. [default: firefox] 09:52:24 INFO - mkdir: /builds/slave/test/build/application 09:52:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:52:41 INFO - Reading from file tmpfile_stdout 09:52:41 INFO - Output received: 09:52:41 INFO - /builds/slave/test/build/application/firefox/firefox 09:52:41 INFO - Running post-action listener: _resource_record_post_action 09:52:41 INFO - [mozharness: 2016-09-26 16:52:41.089608Z] Finished install step (success) 09:52:41 INFO - [mozharness: 2016-09-26 16:52:41.089853Z] Running run-tests step. 09:52:41 INFO - Running pre-action listener: _resource_record_pre_action 09:52:41 INFO - Running main action method: run_tests 09:52:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:52:41 INFO - Python 2.7.3 09:52:41 INFO - Return code: 0 09:52:41 INFO - grabbing minidump binary from tooltool 09:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:41 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 0xdc8f60>, '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 0xdc9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdca1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:52:41 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 09:52:41 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 09:52:41 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 09:52:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:52:41 INFO - Return code: 0 09:52:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:52:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:52:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:52:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:52:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:52:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 09:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 09:52:41 INFO - Using env: {'DISPLAY': ':0', 09:52:41 INFO - 'HOME': '/home/cltbld', 09:52:41 INFO - 'LANG': 'en_US.UTF-8', 09:52:41 INFO - 'LANGUAGE': 'en_US:en', 09:52:41 INFO - 'LOGNAME': 'cltbld', 09:52:41 INFO - 'MAIL': '/var/mail/cltbld', 09:52:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:52:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:41 INFO - 'MOZ_NO_REMOTE': '1', 09:52:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:41 INFO - 'NO_EM_RESTART': '1', 09:52:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:41 INFO - 'PWD': '/builds/slave/test', 09:52:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:52:41 INFO - 'SHELL': '/bin/bash', 09:52:41 INFO - 'SHLVL': '1', 09:52:41 INFO - 'TERM': 'linux', 09:52:41 INFO - 'TMOUT': '86400', 09:52:41 INFO - 'USER': 'cltbld', 09:52:41 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445', 09:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:41 INFO - '_': '/tools/buildbot/bin/python'} 09:52:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 09:52:41 INFO - mozversion application_buildid: 20160926071051 09:52:41 INFO - mozversion application_changeset: ee066384095172f059aab32ed55839e66372cce5 09:52:41 INFO - mozversion application_display_name: Nightly 09:52:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:52:41 INFO - mozversion application_name: Firefox 09:52:41 INFO - mozversion application_remotingname: firefox 09:52:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:52:41 INFO - mozversion application_vendor: Mozilla 09:52:41 INFO - mozversion application_version: 52.0a1 09:52:41 INFO - mozversion platform_buildid: 20160926071051 09:52:41 INFO - mozversion platform_changeset: ee066384095172f059aab32ed55839e66372cce5 09:52:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:52:41 INFO - mozversion platform_version: 52.0a1 09:52:41 INFO - using testdate: 1474908761 09:52:41 INFO - actual date: 1474908761 09:52:41 INFO - starting webserver on 'localhost:43676' 09:52:41 INFO - SUITE-START | Running 2 tests 09:52:41 INFO - TEST-START | dromaeo_css 09:52:41 INFO - operating with platform_type : linux_ 09:52:41 INFO - Initialising browser for dromaeo_css test... 09:52:41 INFO - TEST-INFO | started process 10473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVZ6VXw/profile http://localhost:43676/getInfo.html) 09:52:46 INFO - PROCESS | 10473 | __metrics Screen width/height:1600/1200 09:52:46 INFO - PROCESS | 10473 | colorDepth:24 09:52:46 INFO - PROCESS | 10473 | Browser inner width/height: 1024/697 09:52:46 INFO - PROCESS | 10473 | __metrics 09:52:46 INFO - PROCESS | 10473 | 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" 09:52:46 INFO - PROCESS | 10473 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:47 INFO - PROCESS | 10473 | console.error: PushService: 09:52:47 INFO - PROCESS | 10473 | stateChangeProcessEnqueue: Error transitioning state 09:52:47 INFO - PROCESS | 10473 | UnknownError 09:52:47 INFO - TEST-INFO | 10473: exit 0 09:52:47 INFO - Browser initialized. 09:52:47 INFO - Running cycle 1/1 for dromaeo_css test... 09:52:47 INFO - TEST-INFO | started process 10558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVZ6VXw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:00 INFO - PROCESS | 10558 | RSS: Main: 174858240 09:53:00 INFO - PROCESS | 10558 | 09:53:51 INFO - PROCESS | 10558 | 1474908831834 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] 09:56:04 INFO - PROCESS | 10558 | Cycle 1(1): loaded http://localhost:43676/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43676/tests/dromaeo/cssquery-ext.html) 09:56:05 INFO - PROCESS | 10558 | RSS: Main: 279126016 09:56:05 INFO - PROCESS | 10558 | 09:59:07 INFO - PROCESS | 10558 | Cycle 1(1): loaded http://localhost:43676/tests/dromaeo/cssquery-ext.html (next: http://localhost:43676/tests/dromaeo/cssquery-jquery.html) 09:59:08 INFO - PROCESS | 10558 | RSS: Main: 271962112 09:59:08 INFO - PROCESS | 10558 | 10:02:10 INFO - PROCESS | 10558 | Cycle 1(1): loaded http://localhost:43676/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43676/tests/dromaeo/cssquery-mootools.html) 10:02:11 INFO - PROCESS | 10558 | RSS: Main: 263454720 10:02:11 INFO - PROCESS | 10558 | 10:05:13 INFO - PROCESS | 10558 | Cycle 1(1): loaded http://localhost:43676/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43676/tests/dromaeo/cssquery-prototype.html) 10:05:14 INFO - PROCESS | 10558 | RSS: Main: 220581888 10:05:14 INFO - PROCESS | 10558 | 10:08:17 INFO - PROCESS | 10558 | Cycle 1(1): loaded http://localhost:43676/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43676/tests/dromaeo/cssquery-yui.html) 10:08:17 INFO - PROCESS | 10558 | RSS: Main: 218828800 10:08:17 INFO - PROCESS | 10558 | 10:11:20 INFO - PROCESS | 10558 | Cycle 1(1): loaded http://localhost:43676/tests/dromaeo/cssquery-yui.html (next: http://localhost:43676/tests/dromaeo/cssquery-dojo.html) 10:11:20 INFO - PROCESS | 10558 | RSS: Main: 307482624 10:11:20 INFO - PROCESS | 10558 | 10:11:20 INFO - PROCESS | 10558 | __start_tp_report 10:11:20 INFO - PROCESS | 10558 | _x_x_mozilla_page_load 10:11:20 INFO - PROCESS | 10558 | _x_x_mozilla_page_load_details 10:11:20 INFO - PROCESS | 10558 | |i|pagename|runs| 10:11:20 INFO - PROCESS | 10558 | |0;dojo.html;2564.487102579484;2576.6006269028308;2611.6082587611854;2613.3727905302726;2628.894844206232;4501.279795232764;4570.085982803436;4597.724136551805;4608.562186592277;4651.8604441866755;4597.931031034537;4604.6776725629215;4626.7455289959125;4652.255639097745;4713.410823647044;4008.5390180129366;4209.473815773028;4273.615374616284;4301.698881078326;4415.425994620695;4345.869623911272;4373.540778218289;4378.868633940987;4409.823607055714;4436.800343984512;4149.730267532601;4331.285337919239;4334.653227741773;4347.369631403445;4439.533848945863;4196.916061678779;4227.260229459832;4256.765877876715;4262.46719160105;4266.679999000056;4158.147579746144;4174.686898482596;4189.162167566499;4193.559676234013;4249.490061192646;4609.400777898885;4688.437387513521;4701.78841952113;4703.553162449562;4714.622830173578;4760.09558183944;4816.338363264668;4849.418069831608;4867.342908707315;4978.850634480935;4933.629977751647;4935.827246046407;4942.382202224722;4944.629152813517;5005.274235235906;4576.450825900846;4597.609203217764;4598.977005114953;4623.144718227105;4663.860084197479;4904.141775189399;4937.481564435754;4958.305837182797;5011.248312753043;5033.094043072282;4879.170541007966;4879.731614761222;4883.633727470454;4922.163232250526;4924.162892308316;4951.158164201831;4953.90092198154;4956.182229932093;4959.82640607577;5015.949840501548;4669.486356500782;4715.74063426508;4716.88207794801;4907.950920490821;4976.701397916137;4772.331873537708;4774.641901857374;4781.617470602343;4782.019685964369;4783.306420569068;4079.449274347925;4156.376543518436;4194.958050419517;4201.789910504463;4256.3189889617515;3673.430618254175;3682.963170368316;3691.243295124493;3735.5143831301757;3737.831797569116;4255.127698821734;4258.1696569169335;4262.318029115327;4268.295731204378;4318.222719910446;4782.689125206851;4823.758812059383;4830.4444988826735;4857.125717370836;4902.656814023056;4214.220369231702;4216.683748718859;4262.509811371732;4277.657787377065;4288.871333859989;4379.364992076131;4408.096340250241;4410.0738844842945;4410.382546443437;4471.217536931024;4544.341070544819;4596.88507787308;4598.195315819651;4630.791614377294;4690.695104818176;4895.853124406273;4942.5304596063315;4957.801687932442;5011.148104822116;5016.172331565251;4662.65030122749;4670.276107203389;4671.11248862715;4674.088552732184;4732.384789977281;4819.204831202812;4823.927641085316;4837.806487740451;4844.709317440965;4883.658143929891;4758.785854636619;4800.1119792838435;4816.710997340171;4822.42130944289;4833.419989601271;4759.690620109682;4763.166445872028;4764.380630518011;4812.109759694467;4823.469418363907;4742.596879265163;4748.8575342738395;4749.145153872336;4758.64310176745;4808.975955120202;4622.098690755271;4661.533846615312;4697.295405689174;4719.38647975761;4764.30917516965;4876.536729010738;4880.072786170616;4880.902381952412;4920.507949205051;4927.802887884444;4746.596539294061;4758.04839032188;4767.642426818072;4804.42346918372;4826.32431459603 10:11:20 INFO - PROCESS | 10558 | |1;ext.html;569.703754047895;570.7574280930603;583.6410607476404;584.2900875436345;595.5414330965157;27912.441751164966;37894.242115157715;39262.2147557049;39379.606203937954;43012;39297.21405571887;39797;39837.60162398375;39837.60162398375;39876.401853972144;7626.694932202719;7775.688972441124;7782.455228134033;7783.844323113534;7786.3381612563;7533.284337987882;7618;7624.313811756941;7625.237476252386;7631.198724133969;7614.771556853303;7658.65536050879;7662.885056724153;7665.080190377134;7673.194314596943;7601.277878601524;7636.847263054708;7649.808754781119;7649.885251721201;7656.157822639505;7600.315971562531;7663.080430348394;7663.386929045663;7663.6168191590195;7666.846663066707;37356.43965340522;37543.62456375456;37563.812180939196;37598.624013759785;37697.24605507902;2884.769218462518;2988.716071973181;3053.129857990484;3132.232603012254;3257.0733040216514;27015;27263.86368068167;27381;27937.301567460774;27950.44099118006;3437.364087643794;3474.0793689672255;3476.3394954958476;3492.1269682579355;3632.418812989909;237331;238355;238459;239360;239408.8916217989;30455.238619034702;31613.20966975798;50276.49723502791;50606.74696626493;50622.493775061776;32757.18107047295;33011.3397732044;33059.669403305656;33191.66808331934;33204.66795332064;11591.594294199662;11822.704432389259;11831.349275789742;11835.526578936746;11848.585299514476;9284.72145835626;9424.43453392785;9445;9449.76375590602;9457.668981585612;7647.732329368446;7760.18518055596;7763.055958364016;7820.491668041559;7829.530228186327;3065.9693403065685;3070.984645076805;3092.9072127836203;3102.37952409519;3131.3560380800263;845.7378212754066;871.2083540527101;875.6409871952469;886.2289807867197;955.159459675495;26707.465850683267;27243.86378068097;27394.5890811638;27611;27676.723232767414;788.3299195683624;911.3984770051734;914.4193437167446;946.7017889364828;981.3768257156614;13682.794758078637;14727.190004549853;14741.41034358635;14922.179280139697;14928.70142597142;360569;361596;361905;362212;363418;48025.75987120112;48111.75944120257;48126.75936620295;48128.759356202994;48285;1052.310736467615;1090.9672709818717;1092.9398883061508;1132.2979752553306;1166.4109624639502;25603.87198063998;28708.569371459027;29101.888603393523;29163.125106245996;29383.412331753672;40470.392944106454;41039.17921641491;41074.58925410708;41075.383869241385;41077;289524;291179;291831;292029;292125;22081.227157049427;22830.42923926915;22887.07927795532;22950.19674311391;25107.49785004253;40447.79776101101;40719.796401017804;40951.7952410236;42513.78743106265;42736.572634274504;35013;35395.469067964514;35696.28607427889;35880;35894.64105358913;35060.474092888115;35316.646833532366;35351.64648353484;35380.46929296011;35763.64236357603;35246.47130292996;35422.64577354193;35603.465948010286;35789.28421431505;36397.818010909774;30268.54597181;32409.67590324161;32417.675823241465;32433.513497297088;32511;24637.260882173563;25280;25327.36681582975;25512.362190945376;25541.361465962756 10:11:20 INFO - PROCESS | 10558 | |2;jquery.html;347.7583079759568;366.13409287036166;366.99266014679705;367.4616686554198;389.54812417595576;12595.181313214645;12981.15622484539;13200.867991320096;13425.261610611413;16765.580860478494;14198.14811111334;16243.431479898207;16397.18014099296;16413.671726565462;16545.66908661826;4904.779284932169;4990.87522811929;5041.798328066873;5081.872953176163;5131.974340128294;5070.594352451795;5122.334096567441;5129.9230511542355;5141.948580514184;5146.150885103953;3674.540682414698;3873.3996230584303;5571.164325351189;5792.247007888968;5821.18503409523;5034.370703662043;5909.320428150775;5909.409059094078;5910.143029260733;5920.052791553331;5099.184130539133;5225.163973764217;5231.633785635007;5233.136532472137;5233.293505376763;11863.347515886622;12037.638870833889;17277.91361043199;19816.40550783479;19880.409567234732;1689.2567270401107;1797.0565453137076;1798.199801088516;1949.3761996161234;2179.56408718257;8724.476531408136;8818.823623527494;8882.245009174163;11385.032272256869;11483.311001339946;1606.6144125409935;1677.9748303775332;1692.593777493405;1698.2782317515007;1718.407149533409;63241;65665;68087;68352.658236709;71136.28863711348;9134.908650913405;9259.120383563552;9428.811423771624;9714.319997600242;9906.55420506079;13367.997400195025;13382.330883455788;13391.464341426428;13391.933040334736;13418.329083545783;6201.472874805692;6460.095586617877;6548.246951600627;6587.868242635121;6600.306967768315;5867;5882.058870580687;6012.338642749294;6015.54883383748;6037.245344331958;3955.931898387419;3999.9400008999887;4076.144009757925;4129.545749967561;4305.677074219446;1715.133857402029;1723.8103808581045;1763.8853474524115;1769.5576105973507;1801.2794882047285;847.9781862855244;890.9688160914467;915.1854849184232;938.2587755673078;943.3632298198688;15685.921570392074;15741;15766;16015.119168445613;16338.264778084776;843.7806170395619;863.2476073570662;883.0066175552504;884.6151923913119;885.4996926736374;8742.956285218661;8865.468071915706;9243.260539156985;9406.05939406054;9475.715728528156;336767;338189;339805;339930;340558;73803.63098184475;74064;74399;75706;75865.6206718963;848.1815048478248;881.3433991676114;884.7124684477699;885.1900511032462;887.4586502233632;14061.507847225297;14127.858721412655;14287.142771433748;14565.708685826436;14917.62705932317;36996.815015924745;37361.81319093387;37771;38095;40006.1998760029;50526.494735052176;50938.74530627323;51547.48452515577;51843.48156518537;51983.48016519786;7178.3898368637165;7475.154618245235;7505.624718764149;7644.312011918954;7859.646315915912;10816.783664326827;10949.343039417661;10973.59899878823;11390.37352945596;11473.598424055119;9776.804463910825;9854.408735475894;10068.24488163376;10100.393976361442;10585.89414105849;10042.297039207186;10139.239557033105;10229.74425639365;10283.125934295369;10636.84044739345;9554.665586704432;9866.358686685342;10153.136983356497;10289.43408112561;10884.238103333008;7370;7468;7576.469647124648;7592.202818703957;7618.8095297618;8672.653093876426;9711.271654626073;10115.241356898116;10139.239557033105;10169.491525423848 10:11:20 INFO - PROCESS | 10558 | |3;mootools.html;1237.5173682263924;1359.8980076494258;1381.6960268740877;1427.2078996157136;1673.4226691791334;6675.532712710106;7195.604241766708;7536.0579927508925;7554.24457554245;7759.883601745978;7633.923660763391;7695.499792513483;7711.652975616097;7715.996920400354;7718.961405192967;2147.355793262023;2163.79443952825;2165.664322030088;2166.8266538676867;2167.913283468667;2066.4214020074405;2112.3134981131116;2154.978450215501;2161.513659426624;2164.39396968849;2105.357865850915;2112.588045331161;2118.184498967893;2129.861558998668;2168.1327469012363;2101.1700378350542;2101.7057611934342;2105.663093904968;2110.52513184533;2110.6833974903734;2053.117159621362;2116.8200702940267;2121.045529511726;2122.2466024561213;2125.744910610721;7324.304191101837;7368;7452.701891924316;7460.626968651546;7556.811079723051;4391.824327026915;4599.954000460019;4608.216603177468;4609.308603709437;4619.099275641252;2721.4965231432247;2792.9720702792915;2856.8000239983207;2859.3137646964788;2866.6846646868826;934.1219253901379;937.1331518345503;953.8569214617794;958.3531116496337;970.5341436110706;10030.59877604895;10219.642312519101;10226.284160108795;10229.590816367336;10234.846477302846;3926.8821935341984;4062.370332598452;4066.9186616267507;4074.7351422157467;4305.504866940342;8055.194480552015;8171.673133074611;8179.631916563769;8203.138670439637;8212.34301255898;4530.343100250445;4538.228501154812;4545.659075569345;4556.589906908394;4583.449986001701;3711.0722319420147;3841.692664586826;4024.1348110155873;4283;4287.871363859089;3134.51110722405;3168.2396224905856;3264.9552143313913;3286.293446908878;3294.8682052718104;928.7260258223705;939.0797018921359;954.1508057828538;966.1497881864055;966.6665000574791;664.3655309179721;789.940754443419;799.9000124984377;804.8873157757919;811.7575841776718;4715.292706094045;4889.364382630307;4949.331840201527;4999.10016197088;5270.4202537721585;394.35522920025966;397.9064919743858;400.16565461014113;402.10932783883254;405.42429749755416;3172.413103575846;3393.813340266309;3591.9102022449124;3687.2809802088336;3729.68297694699;9474.952625236967;9576.808463830685;9675.03249675041;9700;9700.466474343979;9560.521973901277;9561.760955976157;9571.37786043905;9574.377665451724;9581.473018983883;7120.430365570845;7308.2691730827555;7308.780736577911;7308.817279568053;7316.524425912298;5137.409197942135;5178.922316165336;5186.222066690027;5229.50319719626;5301.761420735999;8389.664413423394;8456.492610443393;8861.512616806138;8972.596233169654;8997;8655.394122411371;8933.731988040368;9033.277337813091;9080.818383632422;9094.954525227331;6549.508786841101;7202.747903823341;7424.406047516078;7447.776566703008;7459.142198647225;6886.793396198122;7100.076989991268;7112.0754301940415;7117.074780278531;7239.746608868664;6383.074454204021;6466.902996455151;6679.666016699242;6749.966250168718;6861.519693621399;6205.565610407228;6376.808695739135;6536.705848236936;6666.799996000128;6744.932550674431;6034.2155519782145;6154;6159.168512250789;6161.784337548164;6176.752929882934;4351.282038463618;4435.334699795057;4439.311906654474;4528.524504927067;4578.45058592971;4345.695801293879;4356.28121359972;4421.712588681726;4434.800433980414;4475.888102797456 10:11:20 INFO - PROCESS | 10558 | |4;prototype.html;295.83285443724293;303.93617340358526;305.995410068849;310.3792415169661;310.8585593554933;4730.337752714614;4741.857744267669;4749.501302363254;4756.2865570164495;4770.880727981802;4703.342611424551;4715.646326525507;4724.4094488188975;4725.0077483728455;4733.526647335265;3570.232400033986;3677.889663310105;3693.9630603694022;3750.5311836020496;3786.185970016446;3776.603456637055;3779.3764028935193;3781.394976803712;3786.280606684721;3793.9810300948457;3751.343514884898;3753.8926016825103;3758.68051215647;3760.1539653578;3767.4913886625227;3536.8585256589704;3637.890863274106;3661.176235347052;3692.5015122958325;3726.9068273293115;3303.5540202072652;3306.4955445272344;3307.5534802801553;3307.58655168104;3320.5185248138882;4611.30830375443;4619.6073333766335;4622.375979242793;4625.398698169217;4639.280911458729;4146.875593732163;4170.0285348814505;4191.7694526801015;4246.171996460692;4249.87250382489;4865.586425153866;4884.926726099111;4890.339804126433;4903.681260718077;4905.8773530661665;3599.4780756790383;3601.513795637608;3603.7297202709638;3607.549056367954;3615.692666123383;4933.753312334369;5145.202493613496;5146.8198613048735;5154.4072431670465;5164.9856555943215;3662.1577037281572;3668.853245870189;3674.8346324415465;3678.3746763050344;3688.66801987817;3718.4794128821986;3720.586177252627;3724.944125838115;3726.8136593170234;3740.270647223765;4223.556526564728;4224.767637779952;4231.809568569422;4233.343831706091;4239.724417912826;4786.2581299898575;4880.609026427451;4929.9014019720125;4939.3084968104495;4942.777575009133;1284.0113112903011;1303.1073714505405;1303.3418123847396;1307.7253776706998;1309.3453273363318;800.9679612815538;841.4404421060049;846.9703560375357;852.5609311204735;856.4689892266834;4215.57844215576;4237.194932962727;4349.847755328548;4369.650427965755;4370.8907277317685;5056.216286475602;5059.165237735806;5065;5084.872878178001;5087.847364579068;4319.611234988866;4326.502452218036;4361.454818147731;4384.69307148503;4420.889477763081;2572.945092512061;2703.72962703732;2721.8704237741513;2722.8094033417865;2729.4541091781725;4856.490068542823;4856.940127719585;4860.3195552622665;4871.853844384674;4875.804967801319;4965.379327584052;5243.134882744381;5267.209918512177;5271.235670827708;5277.155655095166;4808.735519546459;4808.831690890802;4813.927791083207;4825.638077144228;4845;5078.390593128848;5079.339685840817;5086.7710953007945;5096.413912400121;5098.694078355311;4779.808807647794;5007.097303024827;5015.949840501548;5027.84916452507;5029.044481548494;4829.2997515359375;4846.345743324606;4852.902941941212;4866.610671146229;4868.196747536616;3599.190182208982;3620.692241159531;3624.818759062089;3632.8001959891403;3633.455781292993;5046.394432668103;5107.646473684402;5141.28022076902;5144.845654630367;5172.379314482287;4956.677815941952;5010.248462730619;5016.347874776256;5027.787773379701;5035.773390197523;4967.751612419437;4991.450940396481;4999.125153098266;5004.074246264453;5036.320096786887;4722.622190224843;4928.6057115431395;4934.654574179916;4949.455559888482;4954.826581069645;4802.855914322576;4888.535589119028;4913.680610760289;5008.974955125201;5016.1221786188;4903.16646170159;4903.8528844134735;4933.851984440473;4934.753262336797;4946.901061978669 10:11:20 INFO - PROCESS | 10558 | |5;yui.html;542.1813062275963;564;569.8518385219844;598.9371116032817;627.7520379450115;11971.64085077448;12527.686807829808;12535.31055791931;12558.99528037757;12582.05634577407;12217.877821221786;12236;12254.264744115359;12354.444050017748;12363.196392234498;746.9215732348107;751.2487512487526;782.788647065292;785.9921400786005;787.1695361393728;780.6877249100348;783.2832957843566;783.298947442039;783.3733013589134;783.4829012851519;822.3092602214139;822.4243029879109;822.9670813167467;823.9340852731767;824.2252282854128;818.3412353055787;818.5048045932185;818.5170749257936;818.7830224990412;819.1767273889733;594.8483136800131;599.0206013168457;599.0564860344974;601.9638821670713;603.0381541441437;11559.711007224803;11572.132090093277;11633.47649355781;11650.592229271935;11670.71622121566;12209;12712.618621441372;12968.935155324258;13023.28371939543;13097.345132743325;10216.13162881156;10299.948500257526;10365.481725913674;10398.68803935883;10450.581976720921;3106.502959526465;3106.7048630380077;3110.1494610706595;3132.3578666373337;3203.823789691566;50885.23672144921;51894.74052629751;64636.3536364635;64918.67540662314;65589.67205163944;9724.805503889882;9777.608895644094;9785.804283914282;9995.550645156556;10143.137833284105;18094.638107238046;18111.818881811014;18117.18472668733;18128.365507207447;18131.909340453214;6631.33686631333;6666.600003999775;6701.363370479797;6778.356056174655;7029.613371264527;3420.555327807369;3432.485127230935;3439.7420193485586;3458.4293591557616;3666;2923.1961210667237;3049.5120780674984;3054.0685091047444;3056.740177084973;3058.571799948009;502.88433660258346;506.4125614287409;512.0578136229356;515.6004096824915;520.0872468817201;405.797962102431;522.3705434950875;527.759869259486;533.7304661146096;558.7988324203284;7144.785656430316;7401.59291238987;7429.145648250413;7736;7781.105172905189;446.0387864152756;453.8774530876645;479.28586406255124;522.2740390856712;558.6954461332753;3347.196672798511;3368.6294507604143;3506.63180366063;3544.521489598923;3595.496630471736;82659.58670206611;84079;86089;90092.54953725189;92733.5363323179;76536.46246627493;77970.22029779744;78283;78680.60659696665;79660;66592.34188068338;66963;68393;68946.31053689499;69714.65142674254;6528.21661400635;6762.6280554568;6797.218319893078;6964.756233531802;7349.30181632744;39399.606003939596;40475.39286910758;41283.7935810319;41446.1710765789;43743.12513749771;59142.40857591369;59393.70303148457;59499.70250148721;60451.395486046335;61952;8911.420757650732;8992.595333210153;9107.08929107084;9128.406653567497;9138.771530711785;9959.850602240827;10037.74905627336;10136.391816491034;10149.543270552991;10204.642837500653;9042.412243204171;9056.501892395981;9061.02913431178;9100.22648074921;9119.544022798966;9415.905840941503;9452.763680908032;9721;9843.507824608598;9905.801883962424;8856;8894.86657700148;9375.765605859908;9379.624815007322;9389.10803473669;8044.758657240292;8096.5546894921345;8335.95832020836;8346.62440190205;8520.957395212985;7818.687252509836;8032.919670803217;8136.1863813618165;8171.713990010321;8300.460470069425 10:11:20 INFO - PROCESS | 10558 | __end_tp_report 10:11:20 INFO - PROCESS | 10558 | __start_cc_report 10:11:20 INFO - PROCESS | 10558 | _x_x_mozilla_cycle_collect,918 10:11:20 INFO - PROCESS | 10558 | __end_cc_report 10:11:20 INFO - PROCESS | 10558 | __startTimestamp1474909880763__endTimestamp 10:11:20 INFO - PROCESS | 10558 | 10:11:20 INFO - PROCESS | 10558 | ------- Summary: start ------- 10:11:20 INFO - PROCESS | 10558 | Number of tests: 6 10:11:20 INFO - PROCESS | 10558 | 10:11:20 INFO - PROCESS | 10558 | [#0] dojo.html Cycles:165 Average:4551.77 Median:4690.70 stddev:459.04 (9.8%) stddev-sans-first:433.17 10:11:20 INFO - PROCESS | 10558 | Values: 2564.5 2576.6 2611.6 2613.4 2628.9 4501.3 4570.1 4597.7 4608.6 4651.9 4597.9 4604.7 4626.7 4652.3 4713.4 4008.5 4209.5 4273.6 4301.7 4415.4 4345.9 4373.5 4378.9 4409.8 4436.8 4149.7 4331.3 4334.7 4347.4 4439.5 4196.9 4227.3 4256.8 4262.5 4266.7 4158.1 4174.7 4189.2 4193.6 4249.5 4609.4 4688.4 4701.8 4703.6 4714.6 4760.1 4816.3 4849.4 4867.3 4978.9 4933.6 4935.8 4942.4 4944.6 5005.3 4576.5 4597.6 4599.0 4623.1 4663.9 4904.1 4937.5 4958.3 5011.2 5033.1 4879.2 4879.7 4883.6 4922.2 4924.2 4951.2 4953.9 4956.2 4959.8 5015.9 4669.5 4715.7 4716.9 4908.0 4976.7 4772.3 4774.6 4781.6 4782.0 4783.3 4079.4 4156.4 4195.0 4201.8 4256.3 3673.4 3683.0 3691.2 3735.5 3737.8 4255.1 4258.2 4262.3 4268.3 4318.2 4782.7 4823.8 4830.4 4857.1 4902.7 4214.2 4216.7 4262.5 4277.7 4288.9 4379.4 4408.1 4410.1 4410.4 4471.2 4544.3 4596.9 4598.2 4630.8 4690.7 4895.9 4942.5 4957.8 5011.1 5016.2 4662.7 4670.3 4671.1 4674.1 4732.4 4819.2 4823.9 4837.8 4844.7 4883.7 4758.8 4800.1 4816.7 4822.4 4833.4 4759.7 4763.2 4764.4 4812.1 4823.5 4742.6 4748.9 4749.1 4758.6 4809.0 4622.1 4661.5 4697.3 4719.4 4764.3 4876.5 4880.1 4880.9 4920.5 4927.8 4746.6 4758.0 4767.6 4804.4 4826.3 10:11:20 INFO - PROCESS | 10558 | 10:11:20 INFO - PROCESS | 10558 | [#1] ext.html Cycles:180 Average:43840.75 Median:198231.82 stddev:79433.39 (40.1%) stddev-sans-first:79589.78 10:11:20 INFO - PROCESS | 10558 | Values: 569.7 570.8 583.6 584.3 595.5 27912.4 37894.2 39262.2 39379.6 43012.0 39297.2 39797.0 39837.6 39837.6 39876.4 7626.7 7775.7 7782.5 7783.8 7786.3 7533.3 7618.0 7624.3 7625.2 7631.2 7614.8 7658.7 7662.9 7665.1 7673.2 7601.3 7636.8 7649.8 7649.9 7656.2 7600.3 7663.1 7663.4 7663.6 7666.8 37356.4 37543.6 37563.8 37598.6 37697.2 2884.8 2988.7 3053.1 3132.2 3257.1 27015.0 27263.9 27381.0 27937.3 27950.4 3437.4 3474.1 3476.3 3492.1 3632.4 237331.0 238355.0 238459.0 239360.0 239408.9 30455.2 31613.2 50276.5 50606.7 50622.5 32757.2 33011.3 33059.7 33191.7 33204.7 11591.6 11822.7 11831.3 11835.5 11848.6 9284.7 9424.4 9445.0 9449.8 9457.7 7647.7 7760.2 7763.1 7820.5 7829.5 3066.0 3071.0 3092.9 3102.4 3131.4 845.7 871.2 875.6 886.2 955.2 26707.5 27243.9 27394.6 27611.0 27676.7 788.3 911.4 914.4 946.7 981.4 13682.8 14727.2 14741.4 14922.2 14928.7 360569.0 361596.0 361905.0 362212.0 363418.0 48025.8 48111.8 48126.8 48128.8 48285.0 1052.3 1091.0 1092.9 1132.3 1166.4 25603.9 28708.6 29101.9 29163.1 29383.4 40470.4 41039.2 41074.6 41075.4 41077.0 289524.0 291179.0 291831.0 292029.0 292125.0 22081.2 22830.4 22887.1 22950.2 25107.5 40447.8 40719.8 40951.8 42513.8 42736.6 35013.0 35395.5 35696.3 35880.0 35894.6 35060.5 35316.6 35351.6 35380.5 35763.6 35246.5 35422.6 35603.5 35789.3 36397.8 30268.5 32409.7 32417.7 32433.5 32511.0 24637.3 25280.0 25327.4 25512.4 25541.4 10:11:20 INFO - PROCESS | 10558 | 10:11:20 INFO - PROCESS | 10558 | [#2] jquery.html Cycles:180 Average:22388.65 Median:5038.08 stddev:56342.76 (1118.3%) stddev-sans-first:56476.51 10:11:20 INFO - PROCESS | 10558 | Values: 347.8 366.1 367.0 367.5 389.5 12595.2 12981.2 13200.9 13425.3 16765.6 14198.1 16243.4 16397.2 16413.7 16545.7 4904.8 4990.9 5041.8 5081.9 5132.0 5070.6 5122.3 5129.9 5141.9 5146.2 3674.5 3873.4 5571.2 5792.2 5821.2 5034.4 5909.3 5909.4 5910.1 5920.1 5099.2 5225.2 5231.6 5233.1 5233.3 11863.3 12037.6 17277.9 19816.4 19880.4 1689.3 1797.1 1798.2 1949.4 2179.6 8724.5 8818.8 8882.2 11385.0 11483.3 1606.6 1678.0 1692.6 1698.3 1718.4 63241.0 65665.0 68087.0 68352.7 71136.3 9134.9 9259.1 9428.8 9714.3 9906.6 13368.0 13382.3 13391.5 13391.9 13418.3 6201.5 6460.1 6548.2 6587.9 6600.3 5867.0 5882.1 6012.3 6015.5 6037.2 3955.9 3999.9 4076.1 4129.5 4305.7 1715.1 1723.8 1763.9 1769.6 1801.3 848.0 891.0 915.2 938.3 943.4 15685.9 15741.0 15766.0 16015.1 16338.3 843.8 863.2 883.0 884.6 885.5 8743.0 8865.5 9243.3 9406.1 9475.7 336767.0 338189.0 339805.0 339930.0 340558.0 73803.6 74064.0 74399.0 75706.0 75865.6 848.2 881.3 884.7 885.2 887.5 14061.5 14127.9 14287.1 14565.7 14917.6 36996.8 37361.8 37771.0 38095.0 40006.2 50526.5 50938.7 51547.5 51843.5 51983.5 7178.4 7475.2 7505.6 7644.3 7859.6 10816.8 10949.3 10973.6 11390.4 11473.6 9776.8 9854.4 10068.2 10100.4 10585.9 10042.3 10139.2 10229.7 10283.1 10636.8 9554.7 9866.4 10153.1 10289.4 10884.2 7370.0 7468.0 7576.5 7592.2 7618.8 8672.7 9711.3 10115.2 10139.2 10169.5 10:11:20 INFO - PROCESS | 10558 | 10:11:20 INFO - PROCESS | 10558 | [#3] mootools.html Cycles:180 Average:4987.12 Median:5182.57 stddev:2834.92 (54.7%) stddev-sans-first:2828.87 10:11:20 INFO - PROCESS | 10558 | Values: 1237.5 1359.9 1381.7 1427.2 1673.4 6675.5 7195.6 7536.1 7554.2 7759.9 7633.9 7695.5 7711.7 7716.0 7719.0 2147.4 2163.8 2165.7 2166.8 2167.9 2066.4 2112.3 2155.0 2161.5 2164.4 2105.4 2112.6 2118.2 2129.9 2168.1 2101.2 2101.7 2105.7 2110.5 2110.7 2053.1 2116.8 2121.0 2122.2 2125.7 7324.3 7368.0 7452.7 7460.6 7556.8 4391.8 4600.0 4608.2 4609.3 4619.1 2721.5 2793.0 2856.8 2859.3 2866.7 934.1 937.1 953.9 958.4 970.5 10030.6 10219.6 10226.3 10229.6 10234.8 3926.9 4062.4 4066.9 4074.7 4305.5 8055.2 8171.7 8179.6 8203.1 8212.3 4530.3 4538.2 4545.7 4556.6 4583.4 3711.1 3841.7 4024.1 4283.0 4287.9 3134.5 3168.2 3265.0 3286.3 3294.9 928.7 939.1 954.2 966.1 966.7 664.4 789.9 799.9 804.9 811.8 4715.3 4889.4 4949.3 4999.1 5270.4 394.4 397.9 400.2 402.1 405.4 3172.4 3393.8 3591.9 3687.3 3729.7 9475.0 9576.8 9675.0 9700.0 9700.5 9560.5 9561.8 9571.4 9574.4 9581.5 7120.4 7308.3 7308.8 7308.8 7316.5 5137.4 5178.9 5186.2 5229.5 5301.8 8389.7 8456.5 8861.5 8972.6 8997.0 8655.4 8933.7 9033.3 9080.8 9095.0 6549.5 7202.7 7424.4 7447.8 7459.1 6886.8 7100.1 7112.1 7117.1 7239.7 6383.1 6466.9 6679.7 6750.0 6861.5 6205.6 6376.8 6536.7 6666.8 6744.9 6034.2 6154.0 6159.2 6161.8 6176.8 4351.3 4435.3 4439.3 4528.5 4578.5 4345.7 4356.3 4421.7 4434.8 4475.9 10:11:20 INFO - PROCESS | 10558 | 10:11:20 INFO - PROCESS | 10558 | [#4] prototype.html Cycles:180 Average:4133.54 Median:4731.93 stddev:1189.22 (25.1%) stddev-sans-first:1157.15 10:11:20 INFO - PROCESS | 10558 | Values: 295.8 303.9 306.0 310.4 310.9 4730.3 4741.9 4749.5 4756.3 4770.9 4703.3 4715.6 4724.4 4725.0 4733.5 3570.2 3677.9 3694.0 3750.5 3786.2 3776.6 3779.4 3781.4 3786.3 3794.0 3751.3 3753.9 3758.7 3760.2 3767.5 3536.9 3637.9 3661.2 3692.5 3726.9 3303.6 3306.5 3307.6 3307.6 3320.5 4611.3 4619.6 4622.4 4625.4 4639.3 4146.9 4170.0 4191.8 4246.2 4249.9 4865.6 4884.9 4890.3 4903.7 4905.9 3599.5 3601.5 3603.7 3607.5 3615.7 4933.8 5145.2 5146.8 5154.4 5165.0 3662.2 3668.9 3674.8 3678.4 3688.7 3718.5 3720.6 3724.9 3726.8 3740.3 4223.6 4224.8 4231.8 4233.3 4239.7 4786.3 4880.6 4929.9 4939.3 4942.8 1284.0 1303.1 1303.3 1307.7 1309.3 801.0 841.4 847.0 852.6 856.5 4215.6 4237.2 4349.8 4369.7 4370.9 5056.2 5059.2 5065.0 5084.9 5087.8 4319.6 4326.5 4361.5 4384.7 4420.9 2572.9 2703.7 2721.9 2722.8 2729.5 4856.5 4856.9 4860.3 4871.9 4875.8 4965.4 5243.1 5267.2 5271.2 5277.2 4808.7 4808.8 4813.9 4825.6 4845.0 5078.4 5079.3 5086.8 5096.4 5098.7 4779.8 5007.1 5015.9 5027.8 5029.0 4829.3 4846.3 4852.9 4866.6 4868.2 3599.2 3620.7 3624.8 3632.8 3633.5 5046.4 5107.6 5141.3 5144.8 5172.4 4956.7 5010.2 5016.3 5027.8 5035.8 4967.8 4991.5 4999.1 5004.1 5036.3 4722.6 4928.6 4934.7 4949.5 4954.8 4802.9 4888.5 4913.7 5009.0 5016.1 4903.2 4903.9 4933.9 4934.8 4946.9 10:11:20 INFO - PROCESS | 10558 | 10:11:20 INFO - PROCESS | 10558 | [#5] yui.html Cycles:180 Average:16263.66 Median:31289.88 stddev:23440.46 (74.9%) stddev-sans-first:23476.49 10:11:20 INFO - PROCESS | 10558 | Values: 542.2 564.0 569.9 598.9 627.8 11971.6 12527.7 12535.3 12559.0 12582.1 12217.9 12236.0 12254.3 12354.4 12363.2 746.9 751.2 782.8 786.0 787.2 780.7 783.3 783.3 783.4 783.5 822.3 822.4 823.0 823.9 824.2 818.3 818.5 818.5 818.8 819.2 594.8 599.0 599.1 602.0 603.0 11559.7 11572.1 11633.5 11650.6 11670.7 12209.0 12712.6 12968.9 13023.3 13097.3 10216.1 10299.9 10365.5 10398.7 10450.6 3106.5 3106.7 3110.1 3132.4 3203.8 50885.2 51894.7 64636.4 64918.7 65589.7 9724.8 9777.6 9785.8 9995.6 10143.1 18094.6 18111.8 18117.2 18128.4 18131.9 6631.3 6666.6 6701.4 6778.4 7029.6 3420.6 3432.5 3439.7 3458.4 3666.0 2923.2 3049.5 3054.1 3056.7 3058.6 502.9 506.4 512.1 515.6 520.1 405.8 522.4 527.8 533.7 558.8 7144.8 7401.6 7429.1 7736.0 7781.1 446.0 453.9 479.3 522.3 558.7 3347.2 3368.6 3506.6 3544.5 3595.5 82659.6 84079.0 86089.0 90092.5 92733.5 76536.5 77970.2 78283.0 78680.6 79660.0 66592.3 66963.0 68393.0 68946.3 69714.7 6528.2 6762.6 6797.2 6964.8 7349.3 39399.6 40475.4 41283.8 41446.2 43743.1 59142.4 59393.7 59499.7 60451.4 61952.0 8911.4 8992.6 9107.1 9128.4 9138.8 9959.9 10037.7 10136.4 10149.5 10204.6 9042.4 9056.5 9061.0 9100.2 9119.5 9415.9 9452.8 9721.0 9843.5 9905.8 8856.0 8894.9 9375.8 9379.6 9389.1 8044.8 8096.6 8336.0 8346.6 8521.0 7818.7 8032.9 8136.2 8171.7 8300.5 10:11:20 INFO - PROCESS | 10558 | -------- Summary: end -------- 10:11:20 INFO - PROCESS | 10558 | 10:11:21 INFO - TEST-INFO | 10558: exit 0 10:11:21 INFO - TEST-OK | dromaeo_css | took 1120337ms 10:11:21 INFO - TEST-START | kraken 10:11:21 INFO - operating with platform_type : linux_ 10:11:21 INFO - Initialising browser for kraken test... 10:11:21 INFO - TEST-INFO | started process 10861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptiTqxJ/profile http://localhost:43676/getInfo.html) 10:11:26 INFO - PROCESS | 10861 | __metrics Screen width/height:1600/1200 10:11:26 INFO - PROCESS | 10861 | colorDepth:24 10:11:26 INFO - PROCESS | 10861 | Browser inner width/height: 1024/697 10:11:26 INFO - PROCESS | 10861 | __metrics 10:11:26 INFO - PROCESS | 10861 | 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" 10:11:26 INFO - PROCESS | 10861 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:11:27 INFO - PROCESS | 10861 | console.error: PushService: 10:11:27 INFO - PROCESS | 10861 | stateChangeProcessEnqueue: Error transitioning state 10:11:27 INFO - PROCESS | 10861 | UnknownError 10:11:27 INFO - TEST-INFO | 10861: exit 0 10:11:27 INFO - Browser initialized. 10:11:27 INFO - Running cycle 1/1 for kraken test... 10:11:27 INFO - TEST-INFO | started process 10942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptiTqxJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:11:40 INFO - PROCESS | 10942 | RSS: Main: 174477312 10:11:40 INFO - PROCESS | 10942 | 10:11:42 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43676/tests/kraken/driver.html?testName=audio-beat-detection) 10:11:43 INFO - PROCESS | 10942 | RSS: Main: 233603072 10:11:43 INFO - PROCESS | 10942 | 10:11:46 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43676/tests/kraken/driver.html?testName=audio-dft) 10:11:47 INFO - PROCESS | 10942 | RSS: Main: 218701824 10:11:47 INFO - PROCESS | 10942 | 10:11:50 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43676/tests/kraken/driver.html?testName=audio-fft) 10:11:51 INFO - PROCESS | 10942 | RSS: Main: 300617728 10:11:51 INFO - PROCESS | 10942 | 10:11:53 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43676/tests/kraken/driver.html?testName=audio-oscillator) 10:11:53 INFO - PROCESS | 10942 | RSS: Main: 210538496 10:11:53 INFO - PROCESS | 10942 | 10:11:56 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43676/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:11:56 INFO - PROCESS | 10942 | RSS: Main: 214425600 10:11:56 INFO - PROCESS | 10942 | 10:12:00 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43676/tests/kraken/driver.html?testName=imaging-darkroom) 10:12:00 INFO - PROCESS | 10942 | RSS: Main: 250576896 10:12:00 INFO - PROCESS | 10942 | 10:12:04 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43676/tests/kraken/driver.html?testName=imaging-desaturate) 10:12:04 INFO - PROCESS | 10942 | RSS: Main: 249688064 10:12:04 INFO - PROCESS | 10942 | 10:12:07 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43676/tests/kraken/driver.html?testName=json-parse-financial) 10:12:08 INFO - PROCESS | 10942 | RSS: Main: 249634816 10:12:08 INFO - PROCESS | 10942 | 10:12:09 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43676/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:12:10 INFO - PROCESS | 10942 | RSS: Main: 212082688 10:12:10 INFO - PROCESS | 10942 | 10:12:12 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43676/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:12:13 INFO - PROCESS | 10942 | RSS: Main: 220160000 10:12:13 INFO - PROCESS | 10942 | 10:12:15 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43676/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:12:15 INFO - PROCESS | 10942 | RSS: Main: 224587776 10:12:15 INFO - PROCESS | 10942 | 10:12:18 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:12:19 INFO - PROCESS | 10942 | RSS: Main: 218509312 10:12:19 INFO - PROCESS | 10942 | 10:12:22 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:12:23 INFO - PROCESS | 10942 | RSS: Main: 222212096 10:12:23 INFO - PROCESS | 10942 | 10:12:24 INFO - PROCESS | 10942 | Cycle 1(1): loaded http://localhost:43676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43676/tests/kraken/driver.html?testName=ai-astar) 10:12:25 INFO - PROCESS | 10942 | RSS: Main: 273530880 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | __start_tp_report 10:12:25 INFO - PROCESS | 10942 | _x_x_mozilla_page_load 10:12:25 INFO - PROCESS | 10942 | _x_x_mozilla_page_load_details 10:12:25 INFO - PROCESS | 10942 | |i|pagename|runs| 10:12:25 INFO - PROCESS | 10942 | |0;ai-astar;112;115;114;116;117;117;117;116;116;116 10:12:25 INFO - PROCESS | 10942 | |1;audio-beat-detection;155;127;129;175;124;124;128;128;175;125 10:12:25 INFO - PROCESS | 10942 | |2;audio-dft;162;160;162;162;163;160;162;160;161;161 10:12:25 INFO - PROCESS | 10942 | |3;audio-fft;76;76;75;111;77;77;78;76;104;77 10:12:25 INFO - PROCESS | 10942 | |4;audio-oscillator;84;82;132;83;83;83;113;84;83;119 10:12:25 INFO - PROCESS | 10942 | |5;imaging-gaussian-blur;117;117;117;118;117;116;117;116;117;117 10:12:25 INFO - PROCESS | 10942 | |6;imaging-darkroom;146;146;147;147;147;145;146;147;146;146 10:12:25 INFO - PROCESS | 10942 | |7;imaging-desaturate;96;95;95;94;95;95;95;95;95;95 10:12:25 INFO - PROCESS | 10942 | |8;json-parse-financial;66;67;63;64;64;65;65;64;65;64 10:12:25 INFO - PROCESS | 10942 | |9;json-stringify-tinderbox;65;66;66;66;67;66;66;67;68;67 10:12:25 INFO - PROCESS | 10942 | |10;stanford-crypto-aes;91;82;82;90;82;83;83;85;82;87 10:12:25 INFO - PROCESS | 10942 | |11;stanford-crypto-ccm;160;136;133;142;131;132;145;136;167;147 10:12:25 INFO - PROCESS | 10942 | |12;stanford-crypto-pbkdf2;176;175;176;179;176;174;172;176;174;171 10:12:25 INFO - PROCESS | 10942 | |13;stanford-crypto-sha256-iterative;73;70;69;71;70;68;71;70;68;74 10:12:25 INFO - PROCESS | 10942 | __end_tp_report 10:12:25 INFO - PROCESS | 10942 | __start_cc_report 10:12:25 INFO - PROCESS | 10942 | _x_x_mozilla_cycle_collect,1920 10:12:25 INFO - PROCESS | 10942 | __end_cc_report 10:12:25 INFO - PROCESS | 10942 | __startTimestamp1474909945068__endTimestamp 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | ------- Summary: start ------- 10:12:25 INFO - PROCESS | 10942 | Number of tests: 14 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#0] ai-astar Cycles:10 Average:115.60 Median:116.00 stddev:1.58 (1.4%) stddev-sans-first:1.00 10:12:25 INFO - PROCESS | 10942 | Values: 112.0 115.0 114.0 116.0 117.0 117.0 117.0 116.0 116.0 116.0 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:128.50 stddev:21.03 (16.4%) stddev-sans-first:21.49 10:12:25 INFO - PROCESS | 10942 | Values: 155.0 127.0 129.0 175.0 124.0 124.0 128.0 128.0 175.0 125.0 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 10:12:25 INFO - PROCESS | 10942 | Values: 162.0 160.0 162.0 162.0 163.0 160.0 162.0 160.0 161.0 161.0 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.50 stddev:13.20 (17.3%) stddev-sans-first:13.78 10:12:25 INFO - PROCESS | 10942 | Values: 76.0 76.0 75.0 111.0 77.0 77.0 78.0 76.0 104.0 77.0 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:83.00 stddev:19.02 (22.9%) stddev-sans-first:19.78 10:12:25 INFO - PROCESS | 10942 | Values: 84.0 82.0 132.0 83.0 83.0 83.0 113.0 84.0 83.0 119.0 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:12:25 INFO - PROCESS | 10942 | Values: 117.0 117.0 117.0 118.0 117.0 116.0 117.0 116.0 117.0 117.0 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:12:25 INFO - PROCESS | 10942 | Values: 146.0 146.0 147.0 147.0 147.0 145.0 146.0 147.0 146.0 146.0 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 10:12:25 INFO - PROCESS | 10942 | Values: 96.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.13 10:12:25 INFO - PROCESS | 10942 | Values: 66.0 67.0 63.0 64.0 64.0 65.0 65.0 64.0 65.0 64.0 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 10:12:25 INFO - PROCESS | 10942 | Values: 65.0 66.0 66.0 66.0 67.0 66.0 66.0 67.0 68.0 67.0 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:3.47 (4.1%) stddev-sans-first:2.83 10:12:25 INFO - PROCESS | 10942 | Values: 91.0 82.0 82.0 90.0 82.0 83.0 83.0 85.0 82.0 87.0 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:143.50 stddev:12.24 (8.5%) stddev-sans-first:11.31 10:12:25 INFO - PROCESS | 10942 | Values: 160.0 136.0 133.0 142.0 131.0 132.0 145.0 136.0 167.0 147.0 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:176.00 stddev:2.28 (1.3%) stddev-sans-first:2.39 10:12:25 INFO - PROCESS | 10942 | Values: 176.0 175.0 176.0 179.0 176.0 174.0 172.0 176.0 174.0 171.0 10:12:25 INFO - PROCESS | 10942 | 10:12:25 INFO - PROCESS | 10942 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.96 (2.8%) stddev-sans-first:1.83 10:12:25 INFO - PROCESS | 10942 | Values: 73.0 70.0 69.0 71.0 70.0 68.0 71.0 70.0 68.0 74.0 10:12:25 INFO - PROCESS | 10942 | -------- Summary: end -------- 10:12:25 INFO - PROCESS | 10942 | 10:12:26 INFO - TEST-INFO | 10942: exit 0 10:12:26 INFO - TEST-OK | kraken | took 65075ms 10:12:26 INFO - SUITE-END | took 1185s 10:12:27 INFO - Completed test suite (00:19:45) 10:12:27 INFO - javascript benchmark 10:12:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2564.487102579484, 2576.6006269028308, 2611.6082587611854, 2613.3727905302726, 2628.894844206232, 4501.279795232764, 4570.085982803436, 4597.724136551805, 4608.562186592277, 4651.8604441866755, 4597.931031034537, 4604.6776725629215, 4626.7455289959125, 4652.255639097745, 4713.410823647044, 4008.5390180129366, 4209.473815773028, 4273.615374616284, 4301.698881078326, 4415.425994620695, 4345.869623911272, 4373.540778218289, 4378.868633940987, 4409.823607055714, 4436.800343984512, 4149.730267532601, 4331.285337919239, 4334.653227741773, 4347.369631403445, 4439.533848945863, 4196.916061678779, 4227.260229459832, 4256.765877876715, 4262.46719160105, 4266.679999000056, 4158.147579746144, 4174.686898482596, 4189.162167566499, 4193.559676234013, 4249.490061192646, 4609.400777898885, 4688.437387513521, 4701.78841952113, 4703.553162449562, 4714.622830173578, 4760.09558183944, 4816.338363264668, 4849.418069831608, 4867.342908707315, 4978.850634480935, 4933.629977751647, 4935.827246046407, 4942.382202224722, 4944.629152813517, 5005.274235235906, 4576.450825900846, 4597.609203217764, 4598.977005114953, 4623.144718227105, 4663.860084197479, 4904.141775189399, 4937.481564435754, 4958.305837182797, 5011.248312753043, 5033.094043072282, 4879.170541007966, 4879.731614761222, 4883.633727470454, 4922.163232250526, 4924.162892308316, 4951.158164201831, 4953.90092198154, 4956.182229932093, 4959.82640607577, 5015.949840501548, 4669.486356500782, 4715.74063426508, 4716.88207794801, 4907.950920490821, 4976.701397916137, 4772.331873537708, 4774.641901857374, 4781.617470602343, 4782.019685964369, 4783.306420569068, 4079.449274347925, 4156.376543518436, 4194.958050419517, 4201.789910504463, 4256.3189889617515, 3673.430618254175, 3682.963170368316, 3691.243295124493, 3735.5143831301757, 3737.831797569116, 4255.127698821734, 4258.1696569169335, 4262.318029115327, 4268.295731204378, 4318.222719910446, 4782.689125206851, 4823.758812059383, 4830.4444988826735, 4857.125717370836, 4902.656814023056, 4214.220369231702, 4216.683748718859, 4262.509811371732, 4277.657787377065, 4288.871333859989, 4379.364992076131, 4408.096340250241, 4410.0738844842945, 4410.382546443437, 4471.217536931024, 4544.341070544819, 4596.88507787308, 4598.195315819651, 4630.791614377294, 4690.695104818176, 4895.853124406273, 4942.5304596063315, 4957.801687932442, 5011.148104822116, 5016.172331565251, 4662.65030122749, 4670.276107203389, 4671.11248862715, 4674.088552732184, 4732.384789977281, 4819.204831202812, 4823.927641085316, 4837.806487740451, 4844.709317440965, 4883.658143929891, 4758.785854636619, 4800.1119792838435, 4816.710997340171, 4822.42130944289, 4833.419989601271, 4759.690620109682, 4763.166445872028, 4764.380630518011, 4812.109759694467, 4823.469418363907, 4742.596879265163, 4748.8575342738395, 4749.145153872336, 4758.64310176745, 4808.975955120202, 4622.098690755271, 4661.533846615312, 4697.295405689174, 4719.38647975761, 4764.30917516965, 4876.536729010738, 4880.072786170616, 4880.902381952412, 4920.507949205051, 4927.802887884444, 4746.596539294061, 4758.04839032188, 4767.642426818072, 4804.42346918372, 4826.32431459603], "value": 4523.47327047919, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.703754047895, 570.7574280930603, 583.6410607476404, 584.2900875436345, 595.5414330965157, 27912.441751164966, 37894.242115157715, 39262.2147557049, 39379.606203937954, 43012.0, 39297.21405571887, 39797.0, 39837.60162398375, 39837.60162398375, 39876.401853972144, 7626.694932202719, 7775.688972441124, 7782.455228134033, 7783.844323113534, 7786.3381612563, 7533.284337987882, 7618.0, 7624.313811756941, 7625.237476252386, 7631.198724133969, 7614.771556853303, 7658.65536050879, 7662.885056724153, 7665.080190377134, 7673.194314596943, 7601.277878601524, 7636.847263054708, 7649.808754781119, 7649.885251721201, 7656.157822639505, 7600.315971562531, 7663.080430348394, 7663.386929045663, 7663.6168191590195, 7666.846663066707, 37356.43965340522, 37543.62456375456, 37563.812180939196, 37598.624013759785, 37697.24605507902, 2884.769218462518, 2988.716071973181, 3053.129857990484, 3132.232603012254, 3257.0733040216514, 27015.0, 27263.86368068167, 27381.0, 27937.301567460774, 27950.44099118006, 3437.364087643794, 3474.0793689672255, 3476.3394954958476, 3492.1269682579355, 3632.418812989909, 237331.0, 238355.0, 238459.0, 239360.0, 239408.8916217989, 30455.238619034702, 31613.20966975798, 50276.49723502791, 50606.74696626493, 50622.493775061776, 32757.18107047295, 33011.3397732044, 33059.669403305656, 33191.66808331934, 33204.66795332064, 11591.594294199662, 11822.704432389259, 11831.349275789742, 11835.526578936746, 11848.585299514476, 9284.72145835626, 9424.43453392785, 9445.0, 9449.76375590602, 9457.668981585612, 7647.732329368446, 7760.18518055596, 7763.055958364016, 7820.491668041559, 7829.530228186327, 3065.9693403065685, 3070.984645076805, 3092.9072127836203, 3102.37952409519, 3131.3560380800263, 845.7378212754066, 871.2083540527101, 875.6409871952469, 886.2289807867197, 955.159459675495, 26707.465850683267, 27243.86378068097, 27394.5890811638, 27611.0, 27676.723232767414, 788.3299195683624, 911.3984770051734, 914.4193437167446, 946.7017889364828, 981.3768257156614, 13682.794758078637, 14727.190004549853, 14741.41034358635, 14922.179280139697, 14928.70142597142, 360569.0, 361596.0, 361905.0, 362212.0, 363418.0, 48025.75987120112, 48111.75944120257, 48126.75936620295, 48128.759356202994, 48285.0, 1052.310736467615, 1090.9672709818717, 1092.9398883061508, 1132.2979752553306, 1166.4109624639502, 25603.87198063998, 28708.569371459027, 29101.888603393523, 29163.125106245996, 29383.412331753672, 40470.392944106454, 41039.17921641491, 41074.58925410708, 41075.383869241385, 41077.0, 289524.0, 291179.0, 291831.0, 292029.0, 292125.0, 22081.227157049427, 22830.42923926915, 22887.07927795532, 22950.19674311391, 25107.49785004253, 40447.79776101101, 40719.796401017804, 40951.7952410236, 42513.78743106265, 42736.572634274504, 35013.0, 35395.469067964514, 35696.28607427889, 35880.0, 35894.64105358913, 35060.474092888115, 35316.646833532366, 35351.64648353484, 35380.46929296011, 35763.64236357603, 35246.47130292996, 35422.64577354193, 35603.465948010286, 35789.28421431505, 36397.818010909774, 30268.54597181, 32409.67590324161, 32417.675823241465, 32433.513497297088, 32511.0, 24637.260882173563, 25280.0, 25327.36681582975, 25512.362190945376, 25541.361465962756], "value": 15872.236145797875, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.7583079759568, 366.13409287036166, 366.99266014679705, 367.4616686554198, 389.54812417595576, 12595.181313214645, 12981.15622484539, 13200.867991320096, 13425.261610611413, 16765.580860478494, 14198.14811111334, 16243.431479898207, 16397.18014099296, 16413.671726565462, 16545.66908661826, 4904.779284932169, 4990.87522811929, 5041.798328066873, 5081.872953176163, 5131.974340128294, 5070.594352451795, 5122.334096567441, 5129.9230511542355, 5141.948580514184, 5146.150885103953, 3674.540682414698, 3873.3996230584303, 5571.164325351189, 5792.247007888968, 5821.18503409523, 5034.370703662043, 5909.320428150775, 5909.409059094078, 5910.143029260733, 5920.052791553331, 5099.184130539133, 5225.163973764217, 5231.633785635007, 5233.136532472137, 5233.293505376763, 11863.347515886622, 12037.638870833889, 17277.91361043199, 19816.40550783479, 19880.409567234732, 1689.2567270401107, 1797.0565453137076, 1798.199801088516, 1949.3761996161234, 2179.56408718257, 8724.476531408136, 8818.823623527494, 8882.245009174163, 11385.032272256869, 11483.311001339946, 1606.6144125409935, 1677.9748303775332, 1692.593777493405, 1698.2782317515007, 1718.407149533409, 63241.0, 65665.0, 68087.0, 68352.658236709, 71136.28863711348, 9134.908650913405, 9259.120383563552, 9428.811423771624, 9714.319997600242, 9906.55420506079, 13367.997400195025, 13382.330883455788, 13391.464341426428, 13391.933040334736, 13418.329083545783, 6201.472874805692, 6460.095586617877, 6548.246951600627, 6587.868242635121, 6600.306967768315, 5867.0, 5882.058870580687, 6012.338642749294, 6015.54883383748, 6037.245344331958, 3955.931898387419, 3999.9400008999887, 4076.144009757925, 4129.545749967561, 4305.677074219446, 1715.133857402029, 1723.8103808581045, 1763.8853474524115, 1769.5576105973507, 1801.2794882047285, 847.9781862855244, 890.9688160914467, 915.1854849184232, 938.2587755673078, 943.3632298198688, 15685.921570392074, 15741.0, 15766.0, 16015.119168445613, 16338.264778084776, 843.7806170395619, 863.2476073570662, 883.0066175552504, 884.6151923913119, 885.4996926736374, 8742.956285218661, 8865.468071915706, 9243.260539156985, 9406.05939406054, 9475.715728528156, 336767.0, 338189.0, 339805.0, 339930.0, 340558.0, 73803.63098184475, 74064.0, 74399.0, 75706.0, 75865.6206718963, 848.1815048478248, 881.3433991676114, 884.7124684477699, 885.1900511032462, 887.4586502233632, 14061.507847225297, 14127.858721412655, 14287.142771433748, 14565.708685826436, 14917.62705932317, 36996.815015924745, 37361.81319093387, 37771.0, 38095.0, 40006.1998760029, 50526.494735052176, 50938.74530627323, 51547.48452515577, 51843.48156518537, 51983.48016519786, 7178.3898368637165, 7475.154618245235, 7505.624718764149, 7644.312011918954, 7859.646315915912, 10816.783664326827, 10949.343039417661, 10973.59899878823, 11390.37352945596, 11473.598424055119, 9776.804463910825, 9854.408735475894, 10068.24488163376, 10100.393976361442, 10585.89414105849, 10042.297039207186, 10139.239557033105, 10229.74425639365, 10283.125934295369, 10636.84044739345, 9554.665586704432, 9866.358686685342, 10153.136983356497, 10289.43408112561, 10884.238103333008, 7370.0, 7468.0, 7576.469647124648, 7592.202818703957, 7618.8095297618, 8672.653093876426, 9711.271654626073, 10115.241356898116, 10139.239557033105, 10169.491525423848], "value": 7860.711855556812, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1237.5173682263924, 1359.8980076494258, 1381.6960268740877, 1427.2078996157136, 1673.4226691791334, 6675.532712710106, 7195.604241766708, 7536.0579927508925, 7554.24457554245, 7759.883601745978, 7633.923660763391, 7695.499792513483, 7711.652975616097, 7715.996920400354, 7718.961405192967, 2147.355793262023, 2163.79443952825, 2165.664322030088, 2166.8266538676867, 2167.913283468667, 2066.4214020074405, 2112.3134981131116, 2154.978450215501, 2161.513659426624, 2164.39396968849, 2105.357865850915, 2112.588045331161, 2118.184498967893, 2129.861558998668, 2168.1327469012363, 2101.1700378350542, 2101.7057611934342, 2105.663093904968, 2110.52513184533, 2110.6833974903734, 2053.117159621362, 2116.8200702940267, 2121.045529511726, 2122.2466024561213, 2125.744910610721, 7324.304191101837, 7368.0, 7452.701891924316, 7460.626968651546, 7556.811079723051, 4391.824327026915, 4599.954000460019, 4608.216603177468, 4609.308603709437, 4619.099275641252, 2721.4965231432247, 2792.9720702792915, 2856.8000239983207, 2859.3137646964788, 2866.6846646868826, 934.1219253901379, 937.1331518345503, 953.8569214617794, 958.3531116496337, 970.5341436110706, 10030.59877604895, 10219.642312519101, 10226.284160108795, 10229.590816367336, 10234.846477302846, 3926.8821935341984, 4062.370332598452, 4066.9186616267507, 4074.7351422157467, 4305.504866940342, 8055.194480552015, 8171.673133074611, 8179.631916563769, 8203.138670439637, 8212.34301255898, 4530.343100250445, 4538.228501154812, 4545.659075569345, 4556.589906908394, 4583.449986001701, 3711.0722319420147, 3841.692664586826, 4024.1348110155873, 4283.0, 4287.871363859089, 3134.51110722405, 3168.2396224905856, 3264.9552143313913, 3286.293446908878, 3294.8682052718104, 928.7260258223705, 939.0797018921359, 954.1508057828538, 966.1497881864055, 966.6665000574791, 664.3655309179721, 789.940754443419, 799.9000124984377, 804.8873157757919, 811.7575841776718, 4715.292706094045, 4889.364382630307, 4949.331840201527, 4999.10016197088, 5270.4202537721585, 394.35522920025966, 397.9064919743858, 400.16565461014113, 402.10932783883254, 405.42429749755416, 3172.413103575846, 3393.813340266309, 3591.9102022449124, 3687.2809802088336, 3729.68297694699, 9474.952625236967, 9576.808463830685, 9675.03249675041, 9700.0, 9700.466474343979, 9560.521973901277, 9561.760955976157, 9571.37786043905, 9574.377665451724, 9581.473018983883, 7120.430365570845, 7308.2691730827555, 7308.780736577911, 7308.817279568053, 7316.524425912298, 5137.409197942135, 5178.922316165336, 5186.222066690027, 5229.50319719626, 5301.761420735999, 8389.664413423394, 8456.492610443393, 8861.512616806138, 8972.596233169654, 8997.0, 8655.394122411371, 8933.731988040368, 9033.277337813091, 9080.818383632422, 9094.954525227331, 6549.508786841101, 7202.747903823341, 7424.406047516078, 7447.776566703008, 7459.142198647225, 6886.793396198122, 7100.076989991268, 7112.0754301940415, 7117.074780278531, 7239.746608868664, 6383.074454204021, 6466.902996455151, 6679.666016699242, 6749.966250168718, 6861.519693621399, 6205.565610407228, 6376.808695739135, 6536.705848236936, 6666.799996000128, 6744.932550674431, 6034.2155519782145, 6154.0, 6159.168512250789, 6161.784337548164, 6176.752929882934, 4351.282038463618, 4435.334699795057, 4439.311906654474, 4528.524504927067, 4578.45058592971, 4345.695801293879, 4356.28121359972, 4421.712588681726, 4434.800433980414, 4475.888102797456], "value": 3925.3436949741595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.83285443724293, 303.93617340358526, 305.995410068849, 310.3792415169661, 310.8585593554933, 4730.337752714614, 4741.857744267669, 4749.501302363254, 4756.2865570164495, 4770.880727981802, 4703.342611424551, 4715.646326525507, 4724.4094488188975, 4725.0077483728455, 4733.526647335265, 3570.232400033986, 3677.889663310105, 3693.9630603694022, 3750.5311836020496, 3786.185970016446, 3776.603456637055, 3779.3764028935193, 3781.394976803712, 3786.280606684721, 3793.9810300948457, 3751.343514884898, 3753.8926016825103, 3758.68051215647, 3760.1539653578, 3767.4913886625227, 3536.8585256589704, 3637.890863274106, 3661.176235347052, 3692.5015122958325, 3726.9068273293115, 3303.5540202072652, 3306.4955445272344, 3307.5534802801553, 3307.58655168104, 3320.5185248138882, 4611.30830375443, 4619.6073333766335, 4622.375979242793, 4625.398698169217, 4639.280911458729, 4146.875593732163, 4170.0285348814505, 4191.7694526801015, 4246.171996460692, 4249.87250382489, 4865.586425153866, 4884.926726099111, 4890.339804126433, 4903.681260718077, 4905.8773530661665, 3599.4780756790383, 3601.513795637608, 3603.7297202709638, 3607.549056367954, 3615.692666123383, 4933.753312334369, 5145.202493613496, 5146.8198613048735, 5154.4072431670465, 5164.9856555943215, 3662.1577037281572, 3668.853245870189, 3674.8346324415465, 3678.3746763050344, 3688.66801987817, 3718.4794128821986, 3720.586177252627, 3724.944125838115, 3726.8136593170234, 3740.270647223765, 4223.556526564728, 4224.767637779952, 4231.809568569422, 4233.343831706091, 4239.724417912826, 4786.2581299898575, 4880.609026427451, 4929.9014019720125, 4939.3084968104495, 4942.777575009133, 1284.0113112903011, 1303.1073714505405, 1303.3418123847396, 1307.7253776706998, 1309.3453273363318, 800.9679612815538, 841.4404421060049, 846.9703560375357, 852.5609311204735, 856.4689892266834, 4215.57844215576, 4237.194932962727, 4349.847755328548, 4369.650427965755, 4370.8907277317685, 5056.216286475602, 5059.165237735806, 5065.0, 5084.872878178001, 5087.847364579068, 4319.611234988866, 4326.502452218036, 4361.454818147731, 4384.69307148503, 4420.889477763081, 2572.945092512061, 2703.72962703732, 2721.8704237741513, 2722.8094033417865, 2729.4541091781725, 4856.490068542823, 4856.940127719585, 4860.3195552622665, 4871.853844384674, 4875.804967801319, 4965.379327584052, 5243.134882744381, 5267.209918512177, 5271.235670827708, 5277.155655095166, 4808.735519546459, 4808.831690890802, 4813.927791083207, 4825.638077144228, 4845.0, 5078.390593128848, 5079.339685840817, 5086.7710953007945, 5096.413912400121, 5098.694078355311, 4779.808807647794, 5007.097303024827, 5015.949840501548, 5027.84916452507, 5029.044481548494, 4829.2997515359375, 4846.345743324606, 4852.902941941212, 4866.610671146229, 4868.196747536616, 3599.190182208982, 3620.692241159531, 3624.818759062089, 3632.8001959891403, 3633.455781292993, 5046.394432668103, 5107.646473684402, 5141.28022076902, 5144.845654630367, 5172.379314482287, 4956.677815941952, 5010.248462730619, 5016.347874776256, 5027.787773379701, 5035.773390197523, 4967.751612419437, 4991.450940396481, 4999.125153098266, 5004.074246264453, 5036.320096786887, 4722.622190224843, 4928.6057115431395, 4934.654574179916, 4949.455559888482, 4954.826581069645, 4802.855914322576, 4888.535589119028, 4913.680610760289, 5008.974955125201, 5016.1221786188, 4903.16646170159, 4903.8528844134735, 4933.851984440473, 4934.753262336797, 4946.901061978669], "value": 3758.4818161900785, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.1813062275963, 564.0, 569.8518385219844, 598.9371116032817, 627.7520379450115, 11971.64085077448, 12527.686807829808, 12535.31055791931, 12558.99528037757, 12582.05634577407, 12217.877821221786, 12236.0, 12254.264744115359, 12354.444050017748, 12363.196392234498, 746.9215732348107, 751.2487512487526, 782.788647065292, 785.9921400786005, 787.1695361393728, 780.6877249100348, 783.2832957843566, 783.298947442039, 783.3733013589134, 783.4829012851519, 822.3092602214139, 822.4243029879109, 822.9670813167467, 823.9340852731767, 824.2252282854128, 818.3412353055787, 818.5048045932185, 818.5170749257936, 818.7830224990412, 819.1767273889733, 594.8483136800131, 599.0206013168457, 599.0564860344974, 601.9638821670713, 603.0381541441437, 11559.711007224803, 11572.132090093277, 11633.47649355781, 11650.592229271935, 11670.71622121566, 12209.0, 12712.618621441372, 12968.935155324258, 13023.28371939543, 13097.345132743325, 10216.13162881156, 10299.948500257526, 10365.481725913674, 10398.68803935883, 10450.581976720921, 3106.502959526465, 3106.7048630380077, 3110.1494610706595, 3132.3578666373337, 3203.823789691566, 50885.23672144921, 51894.74052629751, 64636.3536364635, 64918.67540662314, 65589.67205163944, 9724.805503889882, 9777.608895644094, 9785.804283914282, 9995.550645156556, 10143.137833284105, 18094.638107238046, 18111.818881811014, 18117.18472668733, 18128.365507207447, 18131.909340453214, 6631.33686631333, 6666.600003999775, 6701.363370479797, 6778.356056174655, 7029.613371264527, 3420.555327807369, 3432.485127230935, 3439.7420193485586, 3458.4293591557616, 3666.0, 2923.1961210667237, 3049.5120780674984, 3054.0685091047444, 3056.740177084973, 3058.571799948009, 502.88433660258346, 506.4125614287409, 512.0578136229356, 515.6004096824915, 520.0872468817201, 405.797962102431, 522.3705434950875, 527.759869259486, 533.7304661146096, 558.7988324203284, 7144.785656430316, 7401.59291238987, 7429.145648250413, 7736.0, 7781.105172905189, 446.0387864152756, 453.8774530876645, 479.28586406255124, 522.2740390856712, 558.6954461332753, 3347.196672798511, 3368.6294507604143, 3506.63180366063, 3544.521489598923, 3595.496630471736, 82659.58670206611, 84079.0, 86089.0, 90092.54953725189, 92733.5363323179, 76536.46246627493, 77970.22029779744, 78283.0, 78680.60659696665, 79660.0, 66592.34188068338, 66963.0, 68393.0, 68946.31053689499, 69714.65142674254, 6528.21661400635, 6762.6280554568, 6797.218319893078, 6964.756233531802, 7349.30181632744, 39399.606003939596, 40475.39286910758, 41283.7935810319, 41446.1710765789, 43743.12513749771, 59142.40857591369, 59393.70303148457, 59499.70250148721, 60451.395486046335, 61952.0, 8911.420757650732, 8992.595333210153, 9107.08929107084, 9128.406653567497, 9138.771530711785, 9959.850602240827, 10037.74905627336, 10136.391816491034, 10149.543270552991, 10204.642837500653, 9042.412243204171, 9056.501892395981, 9061.02913431178, 9100.22648074921, 9119.544022798966, 9415.905840941503, 9452.763680908032, 9721.0, 9843.507824608598, 9905.801883962424, 8856.0, 8894.86657700148, 9375.765605859908, 9379.624815007322, 9389.10803473669, 8044.758657240292, 8096.5546894921345, 8335.95832020836, 8346.62440190205, 8520.957395212985, 7818.687252509836, 8032.919670803217, 8136.1863813618165, 8171.713990010321, 8300.460470069425], "value": 6002.3454849842, "unit": "score"}], "name": "dromaeo_css", "value": 6069.298453470971, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 114.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 129.0, 175.0, 124.0, 124.0, 128.0, 128.0, 175.0, 125.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 162.0, 163.0, 160.0, 162.0, 160.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 111.0, 77.0, 77.0, 78.0, 76.0, 104.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 132.0, 83.0, 83.0, 83.0, 113.0, 84.0, 83.0, 119.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 145.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 63.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 68.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 82.0, 82.0, 90.0, 82.0, 83.0, 83.0, 85.0, 82.0, 87.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 136.0, 133.0, 142.0, 131.0, 132.0, 145.0, 136.0, 167.0, 147.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 176.0, 179.0, 176.0, 174.0, 172.0, 176.0, 174.0, 171.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 69.0, 71.0, 70.0, 68.0, 71.0, 70.0, 68.0, 74.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1555.4000000000003, "alertThreshold": 2.0}]} 10:12:27 INFO - Return code: 0 10:12:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:12:27 INFO - # TBPL SUCCESS # 10:12:27 INFO - Running post-action listener: _resource_record_post_action 10:12:27 INFO - [mozharness: 2016-09-26 17:12:27.385645Z] Finished run-tests step (success) 10:12:27 INFO - Running post-run listener: _resource_record_post_run 10:12:27 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394625024; Read time: 12; Write time: 332976 10:12:27 INFO - TinderboxPrint: CPU usage
13.0% 10:12:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:12:27 INFO - TinderboxPrint: I/O write bytes / time
394,625,024 / 332,976 10:12:27 INFO - TinderboxPrint: CPU idle
8,351.8 (87.0%) 10:12:27 INFO - TinderboxPrint: CPU user
1,198.2 (12.5%) 10:12:27 INFO - TinderboxPrint: Swap in / out
0 / 0 10:12:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102391808; Read time: 0; Write time: 110032 10:12:27 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291328000; Read time: 12; Write time: 222904 10:12:28 INFO - Running post-run listener: _upload_blobber_files 10:12:28 INFO - Blob upload gear active. 10:12:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:12:28 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 10:12:28 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:12:28 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:12:28 INFO - (blobuploader) - INFO - Open directory for files ... 10:12:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:12:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:12:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:12:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:12:29 INFO - (blobuploader) - INFO - Done attempting. 10:12:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:12:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:12:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:12:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:12:30 INFO - (blobuploader) - INFO - Done attempting. 10:12:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:12:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:12:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:12:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:12:33 INFO - (blobuploader) - INFO - Done attempting. 10:12:33 INFO - (blobuploader) - INFO - Iteration through files over. 10:12:33 INFO - Return code: 0 10:12:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:12:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:12:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/614643731ed7a494534061966d98075d7ab72dfdc3c3fd79847eb7768bbb59a39694dbbf507e69c214afa7f2e04c281fc2af0152bcc25abdefdaf38b7bedff9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cf69872d2c82f9d4218377f7532ac3794856bf71633542ca78275a203dfdb6e2007d9026ac4d092441afbf9193b61ad17f278eb61f3d66571640c7de6a1efa16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eba0f736bd8fecd355b3dcab15bd00af959573faafe1c4423c27ec45316d501f8795ac5c9f88087fa56d7486fb4b5b04ddb31fe59915da293daeddafd9d0e7e5"} 10:12:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:12:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:12:33 INFO - Contents: 10:12:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/614643731ed7a494534061966d98075d7ab72dfdc3c3fd79847eb7768bbb59a39694dbbf507e69c214afa7f2e04c281fc2af0152bcc25abdefdaf38b7bedff9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cf69872d2c82f9d4218377f7532ac3794856bf71633542ca78275a203dfdb6e2007d9026ac4d092441afbf9193b61ad17f278eb61f3d66571640c7de6a1efa16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eba0f736bd8fecd355b3dcab15bd00af959573faafe1c4423c27ec45316d501f8795ac5c9f88087fa56d7486fb4b5b04ddb31fe59915da293daeddafd9d0e7e5"} 10:12:33 INFO - Running post-run listener: copy_logs_to_upload_dir 10:12:33 INFO - Copying logs to upload dir... 10:12:33 INFO - mkdir: /builds/slave/test/build/upload/logs 10:12:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.566735 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-26 10:12:33.030583) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 10:12:33.034092) ========= 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=17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/614643731ed7a494534061966d98075d7ab72dfdc3c3fd79847eb7768bbb59a39694dbbf507e69c214afa7f2e04c281fc2af0152bcc25abdefdaf38b7bedff9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cf69872d2c82f9d4218377f7532ac3794856bf71633542ca78275a203dfdb6e2007d9026ac4d092441afbf9193b61ad17f278eb61f3d66571640c7de6a1efa16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eba0f736bd8fecd355b3dcab15bd00af959573faafe1c4423c27ec45316d501f8795ac5c9f88087fa56d7486fb4b5b04ddb31fe59915da293daeddafd9d0e7e5"} build_url:https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/NT9Zk1xoT9m7p0zjhudB7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/614643731ed7a494534061966d98075d7ab72dfdc3c3fd79847eb7768bbb59a39694dbbf507e69c214afa7f2e04c281fc2af0152bcc25abdefdaf38b7bedff9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cf69872d2c82f9d4218377f7532ac3794856bf71633542ca78275a203dfdb6e2007d9026ac4d092441afbf9193b61ad17f278eb61f3d66571640c7de6a1efa16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eba0f736bd8fecd355b3dcab15bd00af959573faafe1c4423c27ec45316d501f8795ac5c9f88087fa56d7486fb4b5b04ddb31fe59915da293daeddafd9d0e7e5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 10:12:33.059838) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 10:12:33.060208) ========= 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=17051fcd5208b27b50bedfeb000001dd-1474908706.303235-1983083445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 10:12:33.145971) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 10:12:33.146337) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 10:12:33.146672) ========= ========= Total master_lag: 0.17 =========