builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1474724643.93 results: success (0) buildid: 20160924033004 builduid: 56e54ee2d4de46f08a5db0cad9bbd105 revision: d04a39c7195687061f2f0e0a8c2b6c7885fc7f4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-24 06:44:03.932464) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-24 06:44:03.933223) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-24 06:44:03.933738) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-24 06:44:04.075627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 06:44:04.076008) ========= 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=db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-24 06:44:04-- 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% 81.9M=0s 2016-09-24 06:44:04 (81.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123301 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 06:44:04.231200) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 06:44:04.231569) ========= 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=db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.176869 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 06:44:04.421815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-24 06:44:04.422282) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d04a39c7195687061f2f0e0a8c2b6c7885fc7f4c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d04a39c7195687061f2f0e0a8c2b6c7885fc7f4c --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=db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-24 06:44:04,519 truncating revision to first 12 chars 2016-09-24 06:44:04,519 Setting DEBUG logging. 2016-09-24 06:44:04,519 attempt 1/10 2016-09-24 06:44:04,519 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d04a39c71956?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-24 06:44:05,637 unpacking tar archive at: mozilla-inbound-d04a39c71956/testing/mozharness/ program finished with exit code 0 elapsedTime=1.522957 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-24 06:44:05.962505) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-24 06:44:05.962871) ========= script_repo_revision: d04a39c7195687061f2f0e0a8c2b6c7885fc7f4c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-24 06:44:05.963335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-24 06:44:05.963649) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-24 06:44:05.974596) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 33 secs) (at 2016-09-24 06:44:05.975117) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:44:06 INFO - MultiFileLogger online at 20160924 06:44:06 in /builds/slave/test 06:44:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 06:44:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:44:06 INFO - {'append_to_log': False, 06:44:06 INFO - 'base_work_dir': '/builds/slave/test', 06:44:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:44:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:44:06 INFO - 'branch': 'Mozilla-Inbound', 06:44:06 INFO - 'buildbot_json_path': 'buildprops.json', 06:44:06 INFO - 'config_files': ('talos/linux_config.py',), 06:44:06 INFO - 'default_actions': ('clobber', 06:44:06 INFO - 'read-buildbot-config', 06:44:06 INFO - 'download-and-extract', 06:44:06 INFO - 'populate-webroot', 06:44:06 INFO - 'create-virtualenv', 06:44:06 INFO - 'install', 06:44:06 INFO - 'run-tests'), 06:44:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:44:06 INFO - 'download_minidump_stackwalk': True, 06:44:06 INFO - 'download_symbols': 'ondemand', 06:44:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:44:06 INFO - 'tooltool.py': '/tools/tooltool.py', 06:44:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:44:06 INFO - '/tools/misc-python/virtualenv.py')}, 06:44:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:44:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:44:06 INFO - 'installer_path': 'installer.exe', 06:44:06 INFO - 'log_level': 'info', 06:44:06 INFO - 'log_name': 'talos', 06:44:06 INFO - 'log_to_console': True, 06:44:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:44:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:44:06 INFO - 'opt_config_files': (), 06:44:06 INFO - 'pip_index': False, 06:44:06 INFO - 'sps_profile': False, 06:44:06 INFO - 'sps_profile_interval': 0, 06:44:06 INFO - 'suite': 'dromaeojs', 06:44:06 INFO - 'system_bits': '32', 06:44:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:44:06 INFO - 'title': 'talos-linux64-ix-031', 06:44:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:44:06 INFO - 'use_talos_json': True, 06:44:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:44:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:44:06 INFO - 'work_dir': 'build'} 06:44:06 INFO - [mozharness: 2016-09-24 13:44:06.268981Z] Running clobber step. 06:44:06 INFO - Running pre-action listener: _resource_record_pre_action 06:44:06 INFO - Running main action method: clobber 06:44:06 INFO - rmtree: /builds/slave/test/build 06:44:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:44:07 INFO - Running post-action listener: _resource_record_post_action 06:44:07 INFO - [mozharness: 2016-09-24 13:44:07.427927Z] Finished clobber step (success) 06:44:07 INFO - [mozharness: 2016-09-24 13:44:07.428055Z] Running read-buildbot-config step. 06:44:07 INFO - Running pre-action listener: _resource_record_pre_action 06:44:07 INFO - Running main action method: read_buildbot_config 06:44:07 INFO - Using buildbot properties: 06:44:07 INFO - { 06:44:07 INFO - "project": "", 06:44:07 INFO - "product": "firefox", 06:44:07 INFO - "script_repo_revision": "production", 06:44:07 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 06:44:07 INFO - "repository": "", 06:44:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 06:44:07 INFO - "buildid": "20160924033004", 06:44:07 INFO - "pgo_build": "True", 06:44:07 INFO - "basedir": "/builds/slave/test", 06:44:07 INFO - "buildnumber": 1744, 06:44:07 INFO - "slavename": "talos-linux64-ix-031", 06:44:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:44:07 INFO - "platform": "ubuntu64_hw", 06:44:07 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 06:44:07 INFO - "branch": "mozilla-inbound", 06:44:07 INFO - "repo_path": "integration/mozilla-inbound", 06:44:07 INFO - "revision": "d04a39c7195687061f2f0e0a8c2b6c7885fc7f4c", 06:44:07 INFO - "stage_platform": "linux64-pgo", 06:44:07 INFO - "builduid": "56e54ee2d4de46f08a5db0cad9bbd105", 06:44:07 INFO - "slavebuilddir": "test" 06:44:07 INFO - } 06:44:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:44:07 INFO - Running post-action listener: _resource_record_post_action 06:44:07 INFO - [mozharness: 2016-09-24 13:44:07.430480Z] Finished read-buildbot-config step (success) 06:44:07 INFO - [mozharness: 2016-09-24 13:44:07.430580Z] Running download-and-extract step. 06:44:07 INFO - Running pre-action listener: _resource_record_pre_action 06:44:07 INFO - Running main action method: download_and_extract 06:44:07 INFO - mkdir: /builds/slave/test/build/tests 06:44: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')]} 06:44:07 INFO - trying https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:44:07 INFO - Downloading https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/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 06:44:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/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 06:44:08 INFO - Downloaded 1361 bytes. 06:44:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:44:08 INFO - Using the following test package requirements: 06:44:08 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:44:08 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:44:08 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:44:08 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:08 INFO - u'jsshell-linux-x86_64.zip'], 06:44:08 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:44:08 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:44:08 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:44:08 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:44:08 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:44:08 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:44:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:44:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:44:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:44:08 INFO - Fetch https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:44:08 INFO - Expected file size: 21981576 06:44:13 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 06:44:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:44:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:44:13 INFO - Fetch https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:44:13 INFO - Expected file size: 21981576 06:44:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:44:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:44:19 INFO - Fetch https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:44:19 INFO - Expected file size: 14414057 06:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:20 INFO - trying https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:44:20 INFO - Downloading https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/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 06:44:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/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 06:44:22 INFO - Downloaded 59706201 bytes. 06:44:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:44:22 INFO - mkdir: /builds/slave/test/properties 06:44:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:44:22 INFO - Writing to file /builds/slave/test/properties/build_url 06:44:22 INFO - Contents: 06:44:22 INFO - build_url:https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:44:23 INFO - Running post-action listener: _resource_record_post_action 06:44:23 INFO - Running post-action listener: set_extra_try_arguments 06:44:23 INFO - [mozharness: 2016-09-24 13:44:23.554580Z] Finished download-and-extract step (success) 06:44:23 INFO - [mozharness: 2016-09-24 13:44:23.554811Z] Running populate-webroot step. 06:44:23 INFO - Running pre-action listener: _resource_record_pre_action 06:44:23 INFO - Running main action method: populate_webroot 06:44:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:44:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:44:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:44:23 INFO - '--tppagecycles', 06:44:23 INFO - '7'], 06:44:23 INFO - 'tests': ['tsvgm']}}, 06:44:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:44:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:44:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:44:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:44:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:44:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:44:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:23 INFO - 'talos_options': ['--disable-e10s'], 06:44:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:23 INFO - 'talos_options': ['--disable-e10s'], 06:44:23 INFO - 'tests': ['damp', 'tps']}, 06:44:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:23 INFO - 'tests': ['damp', 'tps']}, 06:44:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:44:23 INFO - 'tests': ['dromaeo_dom']}, 06:44:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:44:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:44:23 INFO - 'tests': ['basic_compositor_video']}, 06:44:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:44:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:44:23 INFO - 'tests': ['a11yr', 06:44:23 INFO - 'ts_paint', 06:44:23 INFO - 'tpaint', 06:44:23 INFO - 'sessionrestore', 06:44:23 INFO - 'sessionrestore_no_auto_restore', 06:44:23 INFO - 'tabpaint']}, 06:44:23 INFO - 'other-e10s': {'tests': ['a11yr', 06:44:23 INFO - 'ts_paint', 06:44:23 INFO - 'tpaint', 06:44:23 INFO - 'sessionrestore', 06:44:23 INFO - 'sessionrestore_no_auto_restore', 06:44:23 INFO - 'tabpaint']}, 06:44:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:44:23 INFO - 'ts_paint', 06:44:23 INFO - 'tpaint', 06:44:23 INFO - 'sessionrestore', 06:44:23 INFO - 'sessionrestore_no_auto_restore', 06:44:23 INFO - 'tabpaint']}, 06:44:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:44:23 INFO - 'ts_paint', 06:44:23 INFO - 'tpaint', 06:44:23 INFO - 'sessionrestore', 06:44:23 INFO - 'sessionrestore_no_auto_restore', 06:44:23 INFO - 'tabpaint']}, 06:44:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:44:23 INFO - 'tests': ['a11yr', 06:44:23 INFO - 'ts_paint', 06:44:23 INFO - 'tpaint', 06:44:23 INFO - 'sessionrestore', 06:44:23 INFO - 'sessionrestore_no_auto_restore', 06:44:23 INFO - 'tabpaint']}, 06:44:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:44:23 INFO - 'tests': ['a11yr', 06:44:23 INFO - 'ts_paint', 06:44:23 INFO - 'tpaint', 06:44:23 INFO - 'sessionrestore', 06:44:23 INFO - 'sessionrestore_no_auto_restore', 06:44:23 INFO - 'tabpaint']}, 06:44:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:44:23 INFO - 'tests': ['tsvgx', 06:44:23 INFO - 'tsvgr_opacity', 06:44:23 INFO - 'tart', 06:44:23 INFO - 'tscrollx', 06:44:23 INFO - 'cart']}, 06:44:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:44:23 INFO - 'tsvgr_opacity', 06:44:23 INFO - 'tart', 06:44:23 INFO - 'tscrollx', 06:44:23 INFO - 'cart']}, 06:44:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:23 INFO - 'talos_options': ['--disable-e10s'], 06:44:23 INFO - 'tests': ['tp5o']}, 06:44:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:23 INFO - 'tests': ['tp5o']}, 06:44:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:23 INFO - 'talos_options': ['--disable-e10s', 06:44:23 INFO - '--xperf_path', 06:44:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:23 INFO - 'tests': ['tp5n']}, 06:44:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:23 INFO - 'talos_options': ['--xperf_path', 06:44:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:23 INFO - 'tests': ['tp5n']}}, 06:44:23 INFO - 'talos.zip': {'path': '', 06:44:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:44:23 INFO - Running post-action listener: _resource_record_post_action 06:44:23 INFO - [mozharness: 2016-09-24 13:44:23.575665Z] Finished populate-webroot step (success) 06:44:23 INFO - [mozharness: 2016-09-24 13:44:23.575754Z] Running create-virtualenv step. 06:44:23 INFO - Running pre-action listener: _resource_record_pre_action 06:44:23 INFO - Running main action method: create_virtualenv 06:44:23 INFO - Creating virtualenv /builds/slave/test/build/venv 06:44:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:44:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:44:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:44:23 INFO - Using real prefix '/usr' 06:44:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:44:24 INFO - Installing distribute.............................................................................................................................................................................................done. 06:44:26 INFO - Installing pip.................done. 06:44:26 INFO - Return code: 0 06:44:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:26 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 0x7fa7fe999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6ef60>, '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 0x2a6fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a701d0>, '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': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:44:26 INFO - Using env: {'DISPLAY': ':0', 06:44:26 INFO - 'HOME': '/home/cltbld', 06:44:26 INFO - 'LANG': 'en_US.UTF-8', 06:44:26 INFO - 'LANGUAGE': 'en_US:en', 06:44:26 INFO - 'LOGNAME': 'cltbld', 06:44:26 INFO - 'MAIL': '/var/mail/cltbld', 06:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:26 INFO - 'MOZ_NO_REMOTE': '1', 06:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:26 INFO - 'NO_EM_RESTART': '1', 06:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:26 INFO - 'PWD': '/builds/slave/test', 06:44:26 INFO - 'SHELL': '/bin/bash', 06:44:26 INFO - 'SHLVL': '1', 06:44:26 INFO - 'TERM': 'linux', 06:44:26 INFO - 'TMOUT': '86400', 06:44:26 INFO - 'USER': 'cltbld', 06:44:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 06:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:26 INFO - '_': '/tools/buildbot/bin/python'} 06:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:44:26 INFO - Cleaning up... 06:44:26 INFO - Return code: 0 06:44:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:26 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 0x7fa7fe999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6ef60>, '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 0x2a6fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a701d0>, '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': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:44:26 INFO - Using env: {'DISPLAY': ':0', 06:44:26 INFO - 'HOME': '/home/cltbld', 06:44:26 INFO - 'LANG': 'en_US.UTF-8', 06:44:26 INFO - 'LANGUAGE': 'en_US:en', 06:44:26 INFO - 'LOGNAME': 'cltbld', 06:44:26 INFO - 'MAIL': '/var/mail/cltbld', 06:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:26 INFO - 'MOZ_NO_REMOTE': '1', 06:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:26 INFO - 'NO_EM_RESTART': '1', 06:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:26 INFO - 'PWD': '/builds/slave/test', 06:44:26 INFO - 'SHELL': '/bin/bash', 06:44:26 INFO - 'SHLVL': '1', 06:44:26 INFO - 'TERM': 'linux', 06:44:26 INFO - 'TMOUT': '86400', 06:44:26 INFO - 'USER': 'cltbld', 06:44:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 06:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:26 INFO - '_': '/tools/buildbot/bin/python'} 06:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:27 INFO - Downloading/unpacking psutil>=3.1.1 06:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:44:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:29 INFO - Installing collected packages: psutil 06:44:29 INFO - Running setup.py install for psutil 06:44:29 INFO - building 'psutil._psutil_linux' extension 06:44:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:44:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:44:30 INFO - building 'psutil._psutil_posix' extension 06:44:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:44:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:44:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:30 INFO - Successfully installed psutil 06:44:30 INFO - Cleaning up... 06:44:30 INFO - Return code: 0 06:44:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:30 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 0x7fa7fe999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6ef60>, '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 0x2a6fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a701d0>, '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': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:44:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:44:30 INFO - Using env: {'DISPLAY': ':0', 06:44:30 INFO - 'HOME': '/home/cltbld', 06:44:30 INFO - 'LANG': 'en_US.UTF-8', 06:44:30 INFO - 'LANGUAGE': 'en_US:en', 06:44:30 INFO - 'LOGNAME': 'cltbld', 06:44:30 INFO - 'MAIL': '/var/mail/cltbld', 06:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:30 INFO - 'MOZ_NO_REMOTE': '1', 06:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:30 INFO - 'NO_EM_RESTART': '1', 06:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:30 INFO - 'PWD': '/builds/slave/test', 06:44:30 INFO - 'SHELL': '/bin/bash', 06:44:30 INFO - 'SHLVL': '1', 06:44:30 INFO - 'TERM': 'linux', 06:44:30 INFO - 'TMOUT': '86400', 06:44:30 INFO - 'USER': 'cltbld', 06:44:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 06:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:30 INFO - '_': '/tools/buildbot/bin/python'} 06:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:44:32 INFO - Installing collected packages: mozsystemmonitor 06:44:32 INFO - Running setup.py install for mozsystemmonitor 06:44:32 INFO - Successfully installed mozsystemmonitor 06:44:32 INFO - Cleaning up... 06:44:32 INFO - Return code: 0 06:44:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:32 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 0x7fa7fe999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6ef60>, '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 0x2a6fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a701d0>, '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': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:44:32 INFO - Using env: {'DISPLAY': ':0', 06:44:32 INFO - 'HOME': '/home/cltbld', 06:44:32 INFO - 'LANG': 'en_US.UTF-8', 06:44:32 INFO - 'LANGUAGE': 'en_US:en', 06:44:32 INFO - 'LOGNAME': 'cltbld', 06:44:32 INFO - 'MAIL': '/var/mail/cltbld', 06:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:32 INFO - 'MOZ_NO_REMOTE': '1', 06:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:32 INFO - 'NO_EM_RESTART': '1', 06:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:32 INFO - 'PWD': '/builds/slave/test', 06:44:32 INFO - 'SHELL': '/bin/bash', 06:44:32 INFO - 'SHLVL': '1', 06:44:32 INFO - 'TERM': 'linux', 06:44:32 INFO - 'TMOUT': '86400', 06:44:32 INFO - 'USER': 'cltbld', 06:44:32 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 06:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:32 INFO - '_': '/tools/buildbot/bin/python'} 06:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:33 INFO - Downloading/unpacking jsonschema==2.5.1 06:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:44:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:35 INFO - Downloading functools32-3.2.3-2.tar.gz 06:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:44:35 INFO - warning: no files found matching '*.txt' 06:44:35 INFO - no previously-included directories found matching 'build' 06:44:35 INFO - no previously-included directories found matching 'dist' 06:44:35 INFO - no previously-included directories found matching '.git*' 06:44:35 INFO - Installing collected packages: jsonschema, functools32 06:44:35 INFO - Running setup.py install for functools32 06:44:35 INFO - warning: no files found matching '*.txt' 06:44:35 INFO - no previously-included directories found matching 'build' 06:44:35 INFO - no previously-included directories found matching 'dist' 06:44:35 INFO - no previously-included directories found matching '.git*' 06:44:35 INFO - Successfully installed jsonschema functools32 06:44:35 INFO - Cleaning up... 06:44:35 INFO - Return code: 0 06:44:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:35 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 0x7fa7fe999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6ef60>, '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 0x2a6fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a701d0>, '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': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:44:35 INFO - Using env: {'DISPLAY': ':0', 06:44:35 INFO - 'HOME': '/home/cltbld', 06:44:35 INFO - 'LANG': 'en_US.UTF-8', 06:44:35 INFO - 'LANGUAGE': 'en_US:en', 06:44:35 INFO - 'LOGNAME': 'cltbld', 06:44:35 INFO - 'MAIL': '/var/mail/cltbld', 06:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:35 INFO - 'MOZ_NO_REMOTE': '1', 06:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:35 INFO - 'NO_EM_RESTART': '1', 06:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:35 INFO - 'PWD': '/builds/slave/test', 06:44:35 INFO - 'SHELL': '/bin/bash', 06:44:35 INFO - 'SHLVL': '1', 06:44:35 INFO - 'TERM': 'linux', 06:44:35 INFO - 'TMOUT': '86400', 06:44:35 INFO - 'USER': 'cltbld', 06:44:35 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 06:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:35 INFO - '_': '/tools/buildbot/bin/python'} 06:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:44:35 INFO - Cleaning up... 06:44:35 INFO - Return code: 0 06:44:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:35 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 0x7fa7fe999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6ef60>, '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 0x2a6fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a701d0>, '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': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:44:35 INFO - Using env: {'DISPLAY': ':0', 06:44:35 INFO - 'HOME': '/home/cltbld', 06:44:35 INFO - 'LANG': 'en_US.UTF-8', 06:44:35 INFO - 'LANGUAGE': 'en_US:en', 06:44:35 INFO - 'LOGNAME': 'cltbld', 06:44:35 INFO - 'MAIL': '/var/mail/cltbld', 06:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:35 INFO - 'MOZ_NO_REMOTE': '1', 06:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:35 INFO - 'NO_EM_RESTART': '1', 06:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:35 INFO - 'PWD': '/builds/slave/test', 06:44:35 INFO - 'SHELL': '/bin/bash', 06:44:35 INFO - 'SHLVL': '1', 06:44:35 INFO - 'TERM': 'linux', 06:44:35 INFO - 'TMOUT': '86400', 06:44:35 INFO - 'USER': 'cltbld', 06:44:35 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 06:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:35 INFO - '_': '/tools/buildbot/bin/python'} 06:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:35 INFO - Downloading/unpacking blobuploader==1.2.4 06:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:37 INFO - Downloading blobuploader-1.2.4.tar.gz 06:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:44:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:44:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:38 INFO - Downloading docopt-0.6.1.tar.gz 06:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:44:38 INFO - Installing collected packages: blobuploader, requests, docopt 06:44:38 INFO - Running setup.py install for blobuploader 06:44:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:44:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:44:38 INFO - Running setup.py install for requests 06:44:39 INFO - Running setup.py install for docopt 06:44:39 INFO - Successfully installed blobuploader requests docopt 06:44:39 INFO - Cleaning up... 06:44:39 INFO - Return code: 0 06:44:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:39 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 0x7fa7fe999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6ef60>, '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 0x2a6fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a701d0>, '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': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:44:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:44:39 INFO - Using env: {'DISPLAY': ':0', 06:44:39 INFO - 'HOME': '/home/cltbld', 06:44:39 INFO - 'LANG': 'en_US.UTF-8', 06:44:39 INFO - 'LANGUAGE': 'en_US:en', 06:44:39 INFO - 'LOGNAME': 'cltbld', 06:44:39 INFO - 'MAIL': '/var/mail/cltbld', 06:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:39 INFO - 'MOZ_NO_REMOTE': '1', 06:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:39 INFO - 'NO_EM_RESTART': '1', 06:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:39 INFO - 'PWD': '/builds/slave/test', 06:44:39 INFO - 'SHELL': '/bin/bash', 06:44:39 INFO - 'SHLVL': '1', 06:44:39 INFO - 'TERM': 'linux', 06:44:39 INFO - 'TMOUT': '86400', 06:44:39 INFO - 'USER': 'cltbld', 06:44:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 06:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:39 INFO - '_': '/tools/buildbot/bin/python'} 06:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:44:39 INFO - Running setup.py (path:/tmp/pip-jq1Bs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:44:39 INFO - Running setup.py (path:/tmp/pip-HiKj1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:44:39 INFO - Running setup.py (path:/tmp/pip-mKhNKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:44:39 INFO - Running setup.py (path:/tmp/pip-g3YIBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:44:39 INFO - Running setup.py (path:/tmp/pip-b9CIEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:44:39 INFO - Running setup.py (path:/tmp/pip-h5cH__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:44:39 INFO - Running setup.py (path:/tmp/pip-IqFN8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:44:40 INFO - Running setup.py (path:/tmp/pip-1AzZqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:44:40 INFO - Running setup.py (path:/tmp/pip-ImZU6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:44:40 INFO - Running setup.py (path:/tmp/pip-edwQ79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:44:40 INFO - Running setup.py (path:/tmp/pip-Vg6Rbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:44:40 INFO - Running setup.py (path:/tmp/pip-_lK_4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:44:40 INFO - Running setup.py (path:/tmp/pip-eQuqTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:44:40 INFO - Running setup.py (path:/tmp/pip-4TC9hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:40 INFO - Running setup.py (path:/tmp/pip-HBStxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:44:40 INFO - Running setup.py (path:/tmp/pip-AFLzKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:44:40 INFO - Running setup.py (path:/tmp/pip-Q0XUkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:44:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:44:40 INFO - Running setup.py install for manifestparser 06:44:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:44:40 INFO - Running setup.py install for mozcrash 06:44:40 INFO - Running setup.py install for mozdebug 06:44:41 INFO - Running setup.py install for mozdevice 06:44:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:44:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:44:41 INFO - Running setup.py install for mozfile 06:44:41 INFO - Running setup.py install for mozhttpd 06:44:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:44:41 INFO - Running setup.py install for mozinfo 06:44:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:44:41 INFO - Running setup.py install for mozInstall 06:44:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:44:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:44:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:44:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:44:41 INFO - Running setup.py install for mozleak 06:44:41 INFO - Running setup.py install for mozlog 06:44:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:44:41 INFO - Running setup.py install for moznetwork 06:44:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:44:41 INFO - Running setup.py install for mozprocess 06:44:41 INFO - Running setup.py install for mozprofile 06:44:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:44:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:44:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:44:42 INFO - Running setup.py install for mozrunner 06:44:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:44:42 INFO - Running setup.py install for mozscreenshot 06:44:42 INFO - Running setup.py install for moztest 06:44:42 INFO - Running setup.py install for mozversion 06:44:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:44:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:44:42 INFO - Cleaning up... 06:44:42 INFO - Return code: 0 06:44:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:42 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 0x7fa7fe999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6ef60>, '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 0x2a6fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a701d0>, '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': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:44:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:44:42 INFO - Using env: {'DISPLAY': ':0', 06:44:42 INFO - 'HOME': '/home/cltbld', 06:44:42 INFO - 'LANG': 'en_US.UTF-8', 06:44:42 INFO - 'LANGUAGE': 'en_US:en', 06:44:42 INFO - 'LOGNAME': 'cltbld', 06:44:42 INFO - 'MAIL': '/var/mail/cltbld', 06:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:42 INFO - 'MOZ_NO_REMOTE': '1', 06:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:42 INFO - 'NO_EM_RESTART': '1', 06:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:42 INFO - 'PWD': '/builds/slave/test', 06:44:42 INFO - 'SHELL': '/bin/bash', 06:44:42 INFO - 'SHLVL': '1', 06:44:42 INFO - 'TERM': 'linux', 06:44:42 INFO - 'TMOUT': '86400', 06:44:42 INFO - 'USER': 'cltbld', 06:44:42 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 06:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:42 INFO - '_': '/tools/buildbot/bin/python'} 06:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:44:42 INFO - Running setup.py (path:/tmp/pip-DYWbFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:44:42 INFO - Running setup.py (path:/tmp/pip-n9cwNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:44:42 INFO - Running setup.py (path:/tmp/pip-YOKsCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:44:42 INFO - Running setup.py (path:/tmp/pip-FSQL4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:44:43 INFO - Running setup.py (path:/tmp/pip-IggZ9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:44:43 INFO - Running setup.py (path:/tmp/pip-bXgfuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:44:43 INFO - Running setup.py (path:/tmp/pip-Ax5Mxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:44:43 INFO - Running setup.py (path:/tmp/pip-RqzxO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:44:43 INFO - Running setup.py (path:/tmp/pip-jZ9_FX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:44:43 INFO - Running setup.py (path:/tmp/pip-Ydvhci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:44:43 INFO - Running setup.py (path:/tmp/pip-Uf_FJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:44:43 INFO - Running setup.py (path:/tmp/pip-EJXI0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:44:43 INFO - Running setup.py (path:/tmp/pip-dWRfP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:44:43 INFO - Running setup.py (path:/tmp/pip-kqjDR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:43 INFO - Running setup.py (path:/tmp/pip-SUsjJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:44:43 INFO - Running setup.py (path:/tmp/pip-5A6hlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:44:43 INFO - Running setup.py (path:/tmp/pip-XCcfcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:44:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:45 INFO - Downloading blessings-1.6.tar.gz 06:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:44:45 INFO - Installing collected packages: blessings 06:44:45 INFO - Running setup.py install for blessings 06:44:46 INFO - Successfully installed blessings 06:44:46 INFO - Cleaning up... 06:44:46 INFO - Return code: 0 06:44:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:44:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:44:46 INFO - Reading from file tmpfile_stdout 06:44:46 INFO - Current package versions: 06:44:46 INFO - argparse == 1.2.1 06:44:46 INFO - blessings == 1.6 06:44:46 INFO - blobuploader == 1.2.4 06:44:46 INFO - docopt == 0.6.1 06:44:46 INFO - functools32 == 3.2.3-2 06:44:46 INFO - jsonschema == 2.5.1 06:44:46 INFO - manifestparser == 1.1 06:44:46 INFO - mozInstall == 1.12 06:44:46 INFO - mozcrash == 0.17 06:44:46 INFO - mozdebug == 0.1 06:44:46 INFO - mozdevice == 0.48 06:44:46 INFO - mozfile == 1.2 06:44:46 INFO - mozhttpd == 0.7 06:44:46 INFO - mozinfo == 0.9 06:44:46 INFO - mozleak == 0.1 06:44:46 INFO - mozlog == 3.4 06:44:46 INFO - moznetwork == 0.27 06:44:46 INFO - mozprocess == 0.23 06:44:46 INFO - mozprofile == 0.28 06:44:46 INFO - mozrunner == 6.12 06:44:46 INFO - mozscreenshot == 0.1 06:44:46 INFO - mozsystemmonitor == 0.3 06:44:46 INFO - moztest == 0.7 06:44:46 INFO - mozversion == 1.4 06:44:46 INFO - psutil == 3.1.1 06:44:46 INFO - requests == 1.2.3 06:44:46 INFO - wsgiref == 0.1.2 06:44:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:46 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 0x7fa7fe999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6ef60>, '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 0x2a6fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a701d0>, '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': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:44:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:44:46 INFO - Using env: {'DISPLAY': ':0', 06:44:46 INFO - 'HOME': '/home/cltbld', 06:44:46 INFO - 'LANG': 'en_US.UTF-8', 06:44:46 INFO - 'LANGUAGE': 'en_US:en', 06:44:46 INFO - 'LOGNAME': 'cltbld', 06:44:46 INFO - 'MAIL': '/var/mail/cltbld', 06:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:46 INFO - 'MOZ_NO_REMOTE': '1', 06:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:46 INFO - 'NO_EM_RESTART': '1', 06:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:46 INFO - 'PWD': '/builds/slave/test', 06:44:46 INFO - 'SHELL': '/bin/bash', 06:44:46 INFO - 'SHLVL': '1', 06:44:46 INFO - 'TERM': 'linux', 06:44:46 INFO - 'TMOUT': '86400', 06:44:46 INFO - 'USER': 'cltbld', 06:44:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 06:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:46 INFO - '_': '/tools/buildbot/bin/python'} 06:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:44:46 INFO - Cleaning up... 06:44:46 INFO - Return code: 0 06:44:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:46 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 0x7fa7fe999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6ef60>, '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 0x2a6fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a701d0>, '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': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:44:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:44:46 INFO - Using env: {'DISPLAY': ':0', 06:44:46 INFO - 'HOME': '/home/cltbld', 06:44:46 INFO - 'LANG': 'en_US.UTF-8', 06:44:46 INFO - 'LANGUAGE': 'en_US:en', 06:44:46 INFO - 'LOGNAME': 'cltbld', 06:44:46 INFO - 'MAIL': '/var/mail/cltbld', 06:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:46 INFO - 'MOZ_NO_REMOTE': '1', 06:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:46 INFO - 'NO_EM_RESTART': '1', 06:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:46 INFO - 'PWD': '/builds/slave/test', 06:44:46 INFO - 'SHELL': '/bin/bash', 06:44:46 INFO - 'SHLVL': '1', 06:44:46 INFO - 'TERM': 'linux', 06:44:46 INFO - 'TMOUT': '86400', 06:44:46 INFO - 'USER': 'cltbld', 06:44:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 06:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:46 INFO - '_': '/tools/buildbot/bin/python'} 06:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:44:46 INFO - Cleaning up... 06:44:46 INFO - Return code: 0 06:44:46 INFO - Running post-action listener: _resource_record_post_action 06:44:46 INFO - Running post-action listener: _start_resource_monitoring 06:44:46 INFO - Starting resource monitoring. 06:44:46 INFO - [mozharness: 2016-09-24 13:44:46.851535Z] Finished create-virtualenv step (success) 06:44:46 INFO - [mozharness: 2016-09-24 13:44:46.852512Z] Running install step. 06:44:46 INFO - Running pre-action listener: _resource_record_pre_action 06:44:46 INFO - Running main action method: install 06:44:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:44:47 INFO - Reading from file tmpfile_stdout 06:44:47 INFO - Detecting whether we're running mozinstall >=1.0... 06:44:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:44:47 INFO - Reading from file tmpfile_stdout 06:44:47 INFO - Output received: 06:44:47 INFO - Usage: mozinstall [options] installer 06:44:47 INFO - Options: 06:44:47 INFO - -h, --help show this help message and exit 06:44:47 INFO - -d DEST, --destination=DEST 06:44:47 INFO - Directory to install application into. [default: 06:44:47 INFO - "/builds/slave/test"] 06:44:47 INFO - --app=APP Application being installed. [default: firefox] 06:44:47 INFO - mkdir: /builds/slave/test/build/application 06:44:47 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'] 06:44:47 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 06:45:04 INFO - Reading from file tmpfile_stdout 06:45:04 INFO - Output received: 06:45:04 INFO - /builds/slave/test/build/application/firefox/firefox 06:45:04 INFO - Running post-action listener: _resource_record_post_action 06:45:04 INFO - [mozharness: 2016-09-24 13:45:04.127312Z] Finished install step (success) 06:45:04 INFO - [mozharness: 2016-09-24 13:45:04.127558Z] Running run-tests step. 06:45:04 INFO - Running pre-action listener: _resource_record_pre_action 06:45:04 INFO - Running main action method: run_tests 06:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:45:04 INFO - Python 2.7.3 06:45:04 INFO - Return code: 0 06:45:04 INFO - grabbing minidump binary from tooltool 06:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:04 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 0x2a6ef60>, '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 0x2a6fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a701d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:45:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:45:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:45:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:45:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:45:04 INFO - Return code: 0 06:45:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:45:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:45:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:45:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:45:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:45:04 INFO - Using env: {'DISPLAY': ':0', 06:45:04 INFO - 'HOME': '/home/cltbld', 06:45:04 INFO - 'LANG': 'en_US.UTF-8', 06:45:04 INFO - 'LANGUAGE': 'en_US:en', 06:45:04 INFO - 'LOGNAME': 'cltbld', 06:45:04 INFO - 'MAIL': '/var/mail/cltbld', 06:45:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:45:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:04 INFO - 'MOZ_NO_REMOTE': '1', 06:45:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:04 INFO - 'NO_EM_RESTART': '1', 06:45:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:04 INFO - 'PWD': '/builds/slave/test', 06:45:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:45:04 INFO - 'SHELL': '/bin/bash', 06:45:04 INFO - 'SHLVL': '1', 06:45:04 INFO - 'TERM': 'linux', 06:45:04 INFO - 'TMOUT': '86400', 06:45:04 INFO - 'USER': 'cltbld', 06:45:04 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123', 06:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:04 INFO - '_': '/tools/buildbot/bin/python'} 06:45:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:45:04 INFO - mozversion application_buildid: 20160924033004 06:45:04 INFO - mozversion application_changeset: d04a39c7195687061f2f0e0a8c2b6c7885fc7f4c 06:45:04 INFO - mozversion application_display_name: Nightly 06:45:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:45:04 INFO - mozversion application_name: Firefox 06:45:04 INFO - mozversion application_remotingname: firefox 06:45:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:45:04 INFO - mozversion application_vendor: Mozilla 06:45:04 INFO - mozversion application_version: 52.0a1 06:45:04 INFO - mozversion platform_buildid: 20160924033004 06:45:04 INFO - mozversion platform_changeset: d04a39c7195687061f2f0e0a8c2b6c7885fc7f4c 06:45:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:45:04 INFO - mozversion platform_version: 52.0a1 06:45:04 INFO - using testdate: 1474724704 06:45:04 INFO - actual date: 1474724704 06:45:04 INFO - starting webserver on 'localhost:34688' 06:45:04 INFO - SUITE-START | Running 2 tests 06:45:04 INFO - TEST-START | dromaeo_css 06:45:04 INFO - operating with platform_type : linux_ 06:45:04 INFO - Initialising browser for dromaeo_css test... 06:45:04 INFO - TEST-INFO | started process 3359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7dlfLL/profile http://localhost:34688/getInfo.html) 06:45:10 INFO - PROCESS | 3359 | __metrics Screen width/height:1600/1200 06:45:10 INFO - PROCESS | 3359 | colorDepth:24 06:45:10 INFO - PROCESS | 3359 | Browser inner width/height: 1024/697 06:45:10 INFO - PROCESS | 3359 | __metrics 06:45:10 INFO - PROCESS | 3359 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:45:10 INFO - PROCESS | 3359 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:45:11 INFO - PROCESS | 3359 | console.error: PushService: 06:45:11 INFO - PROCESS | 3359 | stateChangeProcessEnqueue: Error transitioning state 06:45:11 INFO - PROCESS | 3359 | UnknownError 06:45:11 INFO - TEST-INFO | 3359: exit 0 06:45:11 INFO - Browser initialized. 06:45:11 INFO - Running cycle 1/1 for dromaeo_css test... 06:45:11 INFO - TEST-INFO | started process 3443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7dlfLL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:45:23 INFO - PROCESS | 3443 | RSS: Main: 172929024 06:45:23 INFO - PROCESS | 3443 | 06:46:15 INFO - PROCESS | 3443 | 1474724775174 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:48:25 INFO - PROCESS | 3443 | Cycle 1(1): loaded http://localhost:34688/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34688/tests/dromaeo/cssquery-ext.html) 06:48:26 INFO - PROCESS | 3443 | RSS: Main: 312397824 06:48:26 INFO - PROCESS | 3443 | 06:51:28 INFO - PROCESS | 3443 | Cycle 1(1): loaded http://localhost:34688/tests/dromaeo/cssquery-ext.html (next: http://localhost:34688/tests/dromaeo/cssquery-jquery.html) 06:51:29 INFO - PROCESS | 3443 | RSS: Main: 285913088 06:51:29 INFO - PROCESS | 3443 | 06:54:31 INFO - PROCESS | 3443 | Cycle 1(1): loaded http://localhost:34688/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34688/tests/dromaeo/cssquery-mootools.html) 06:54:32 INFO - PROCESS | 3443 | RSS: Main: 216272896 06:54:32 INFO - PROCESS | 3443 | 06:57:34 INFO - PROCESS | 3443 | Cycle 1(1): loaded http://localhost:34688/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34688/tests/dromaeo/cssquery-prototype.html) 06:57:34 INFO - PROCESS | 3443 | RSS: Main: 253575168 06:57:34 INFO - PROCESS | 3443 | 07:00:37 INFO - PROCESS | 3443 | Cycle 1(1): loaded http://localhost:34688/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34688/tests/dromaeo/cssquery-yui.html) 07:00:38 INFO - PROCESS | 3443 | RSS: Main: 217485312 07:00:38 INFO - PROCESS | 3443 | 07:03:40 INFO - PROCESS | 3443 | Cycle 1(1): loaded http://localhost:34688/tests/dromaeo/cssquery-yui.html (next: http://localhost:34688/tests/dromaeo/cssquery-dojo.html) 07:03:41 INFO - PROCESS | 3443 | RSS: Main: 307331072 07:03:41 INFO - PROCESS | 3443 | 07:03:41 INFO - PROCESS | 3443 | __start_tp_report 07:03:41 INFO - PROCESS | 3443 | _x_x_mozilla_page_load 07:03:41 INFO - PROCESS | 3443 | _x_x_mozilla_page_load_details 07:03:41 INFO - PROCESS | 3443 | |i|pagename|runs| 07:03:41 INFO - PROCESS | 3443 | |0;dojo.html;3038.361943991762;3064.984675076624;3077.569140320354;3105.3168302973336;3120.26673731673;5225.137852254374;5310.36275646922;5317.042932272194;5385.488378604031;5434.429384914586;5426.782928682848;5486.780528778854;5528.55771538277;5577.079781835992;5578.832635020945;4678.064387122572;4883.487233840449;4903.950960490403;4923.261510773395;4975.925361119586;5056.443791182967;5066.06277838601;5071.492850714936;5072.188449848025;5077.974610126944;4816.638752093607;4875.829345972909;4923.359963204796;4989.650724449308;5047.873803154914;4801.447833499123;4834.830780922686;4854.854354369375;4914.459409464956;4943.604511639096;4833.492483289274;4835.274708793674;4848.22428411456;4868.269759536098;4905.950940490585;5390.460953904618;5398.541124004425;5406.297181366397;5410.83767486976;5494.697791621459;5486.506214440679;5553.389127196006;5793.304803423574;5801.129830525413;5802.7098645068;5711.314642242957;5752.683602401867;5755.539556835443;5760.107183386582;5775.768969241225;5382.650127741685;5384.542313903362;5384.976854397691;5390.272313237741;5395.919061214085;5736.42635736423;5799.3040835100055;5916;5919.260092488439;5919.467247947706;5538.418466061086;5588.3573389060775;5591.189277554732;5595.832125036255;5677.602567820296;5664.461876121762;5666.97166514173;5669.773209071591;5674.716264186774;5686.14707793826;5555.30558680165;5613.775448981995;5658.066419040894;5677.716114194273;5681.488666019995;5534.612577119563;5607.439256074442;5627.662340259598;5630.5214056805635;5728.341240757366;4356.172327257811;4388.648908087345;4397.560243975641;4399.758013309299;4444.577765112309;3911.1004468972296;3925.568187499373;3932.5477570079233;3965.980170099189;3985.860494882665;5344.43883392246;5382;5390.380106287748;5470.206820011155;5473.8357849264585;5752.683602401824;5818.272715910512;5820.476157145878;5823.679697616587;5825.271841019872;5440.020796256633;5447.101228297366;5450.04624190765;5450.127979523337;5454.481824226692;4996.200607902718;5034.8237811677145;5049.040682270357;5056.873578160576;5117.641765076483;5964.642121472725;6029.788957386558;6029.909551356734;6032.969835150796;6035.064564992434;5843.386444423444;5856;5858;5860.619059761102;5860.736266867916;5746.569007324384;5794.681292528951;5954.37479064692;6009.939900601113;6026.879462410815;5755.280589926259;5816.563757718103;5817.534597232296;5822.883542329215;5825.213596164633;5852.707364631666;5854.590178687451;5862.062070068769;5866.384029676993;5867.442592953663;5413.10683737179;5689.743961521659;5692.971535142297;5704.11586204139;5706.857328566819;5458.372287187024;5607.775688972395;5609.49514543693;5651.745671444713;5740.225069615549;5603.691796951207;5607.2149899014985;5607.775688972395;5610.158476228598;5614.101743720985;5650.29371328584;5691.800786972436;5698.686572238566;5698.943010569841;5706.457886500776;5365.356157261153;5418.945810541844;5480.753366098615;5538.529225015919;5541.307336582927 07:03:41 INFO - PROCESS | 3443 | |1;ext.html;550.0943302551882;592.2537602620694;596.6151832068316;609.4210500024977;615.969201539923;31549.526757098633;37054;37291.62708372915;37402.4389634155;37421.25157496848;43126.56873431265;43313.35029974553;43365;43437.78281108598;43580.12839743203;8250.834983300361;8863.911360886405;9000.414973026765;9005.14451127142;9009.414388064755;8289.83420331593;10502.159827213805;10769.084627806646;10777.62278320255;11144.777104457906;10961.397123158224;11033.172512061587;11041.613543525978;11042.282251653616;11042.834357484644;10746.623868164615;10806.29759065666;10808.78382432347;10849.620263290826;10932.398718070503;10585.947070264676;10795.5681772729;10816.72958176044;10821.83767243492;10827.187960902886;42604.57395426068;43045.35431968523;43142.13715725668;43194.56805431937;43205.56794432047;3017;3045.9086227413213;3084.52189910562;3153.779235453519;3167.3665266946705;32304.21611461596;32317.51523727146;32427.351452970808;32649.183770405692;32679.67320326814;4299.570042995707;4332.28517294646;4423.601875831158;4544.431946006749;4551.044280701057;345009.27495362615;345286.5563738349;345437;347001;347089;50882.236766448535;51029;51072.489275106775;51491.48508514867;52162.73918630383;61199.694001530595;61227.38772612306;61588;61613.38386616166;61708.44623983863;15682.215889205494;15861.762073568905;15876.047437153808;15882.60293492672;15888.60278493047;11134;11389.031932285683;11587.420628968517;12182;12262.877371226352;16431;17098.316067357417;17110.828891710924;17115.74326385105;17180.134469744207;5843.357230704619;6503.28463868974;6626.370494803083;6667.19993600771;6753.3921947025;976.272676855747;1014.7310962594918;1029.1920842138884;1068.5885933915342;1084.0568705226347;31609;31940.20149496281;32251;32362.514562281583;32413.837930810194;1094.7591529863416;1126.8253420719802;1177.711460692136;1178.5344788808372;1196.557273808679;16714.247858846138;17038.659226815642;17093;17115.486535403958;17133.742993855103;476014;517523;518796;521675;522099;52020;61156;62627.6868615654;62807.37192628015;62810.685946569974;1290.3354772292278;1295.0999055656227;1312.6259016180343;1321.6167311479562;1324.16577556139;31033.844830775703;33710.662893370754;33722;33859;34313.828430857684;51738.22392664038;52211;52361;52414.21378679399;52471.01525355085;412489;413004;414258;414881;415796;40093.58736570526;40402.59597403988;40704.3894341591;41345.79327103345;41368.82889638795;47607.76196118997;48651.756741216064;48700.75649621729;49283.26075108948;49786;40136.799316003235;40613.1877362457;40778.59221407748;41192.176156477304;42457.57542424536;36398.8180059098;36449;36836;37027.44458833174;37145.81427092847;41206.793966029974;41547.7922610385;41682.374764379165;42409.36385954275;42423.78788106163;33726.66273337235;36416.45375319319;36444.81777591095;36617.267654647294;37627;27682.446351072464;27889.721102788713;28083.157505274874;28138.71861281361;28208.71791282143 07:03:41 INFO - PROCESS | 3443 | |2;jquery.html;373.65623626263834;377.69972871567103;397.14019148543406;401.3999071388275;416.1344403640428;13478.932605336971;18693.532661683446;19036;19209.32767353143;19359.90320048398;17035.318587256526;17128.31486740532;17411.3035478581;17496.300147994098;17546.736798948026;5510.724463776815;5747.137929310595;5756.366799652056;5761.567882408815;5762.855928601797;4116.835326586933;4290.742555446667;4343.674224433164;5589.580781441387;5680.091185410335;6262.248530176363;6286.025666021774;6389.744410223609;6392.61644301341;6402.231732192144;5578.135389014709;5871.6183448075735;5896.38088000758;6379.106925030476;6384.776532821352;5778.855528611776;5779.566532510079;5782.450667186653;5784.450477204701;5789.334226563915;12657.683557911034;12672.176308539916;12825.294608796512;12845.67885802853;14264.215468149248;2029.4824819671037;2072.0882811562865;2104.158336665331;2171.9891400543056;2221.7889300516426;9644.132028117432;9715.854262186072;10026.548805303779;12297.077719171099;13810.309484525835;1816.9909150454164;1820.0899550224888;1850.2783914273443;1866.8319851213455;1867.3184287735014;78914.21085789126;88732.55633721854;89918;90419.99999999935;90597.54701226517;10376.325538839952;10711.357318560911;10769.62306319275;10840.5121769519;10882.401467919182;15163.696726065416;15210.490269105694;15218.619534511505;15223.31495082724;15259;7234.493585449073;7604.429667774939;7626.8093297668;7738.017956835732;7857.9214207857185;7133.358105333126;7164.677589508485;7234.276572342724;7371.336579707852;7377.0409846719585;4598.724076555417;4622.14490319292;4622.699524530894;4666.113438446684;4699.506551812079;1853.7682789651294;1886.377495426506;1909.3985394600656;1939.951501212481;1976.861619686637;914.963401463934;963.1909196275162;1008.5763979128636;1016.5628779624684;1030.90206430389;17448.21483033241;17482.65034699299;18650.53373665642;18684.439466816017;19018.71471927922;908.5729707037682;920.7099763574587;969.0551712080805;986.1026465915982;1015.5430056474615;10013.849792253122;10417.218708596885;10434.113100386401;10481.528331225114;10521.684349469528;468914;470284;471322;489029;492993;91815.081849182;94967.52516237374;98332;98989;100004.49997749965;929.972100836976;937.2970272295914;973.1922504321396;985.9507024648739;989.2135752077116;15753.527394178192;15915.80245195062;15956.202189890691;16631.75052374191;16995.40516081931;29221.415571688023;39548.209035819695;41223.793881030404;41817.79091104525;41993;54425;54938;54943.45056549383;55981.720091399286;57637;7668.097566805782;7738.883916741141;7837.49056311338;7932.405069619686;8179.0594081681365;8798.956005220189;11457.255278406878;13027.47890084386;13151.408186631434;13405.06164568471;11586.131040171853;11715.355655439032;11734.647960561197;11891.583794567148;11940.95483664642;11545.249558778989;11634.36011019402;11767.705807354541;11970.102242332034;12403;11693;11708.88291117078;11768.764624707286;11864.694883562628;12273;7869.134395216636;8019.278264956182;8065.798355041171;8264.710735124241;8360.08039115709;8945.418547794372;10753.569857205624;10925.235233533576;11095.889041109485;11113.555457781922 07:03:41 INFO - PROCESS | 3443 | |3;mootools.html;1339.0358941562072;1452.419032387045;1505.5859638599386;1635.8364163583635;1740.3647668600956;7693.653785579649;8678.522681252529;9033.23217526511;9034.006259311478;9298.349115561914;9021.639134434614;9097.363184577081;9104.27165826734;9107.59015844287;9111.817763644724;2354.9764502355015;2375.3942744600104;2376.512814872947;2376.8455050421753;2378.1319818266293;2311.503026849227;2337.357226762637;2372.4543355028354;2373.750756170603;2377.120465427794;2303.3435470890718;2310.260716570698;2310.9422264443438;2334.11303704592;2347;2270.205428100152;2300.160441438871;2302.343832007878;2306.054517647765;2307.284741730069;2265.6035193841176;2267.115824828318;2271.2958982715413;2275.5221403505284;2276.1236923784295;9019;9047.366684332099;9058.864117038249;9060.184583387461;9067.818643627157;5083.262926875583;5248.947510524922;5258.50044245796;5259.894802103937;5262.105442074857;3428.8971330860113;3632.745707800455;3675.5221821163345;3685.3734865073;3695.8521659133603;1198.9880101198964;1238.3127364312802;1244.2223610243598;1261.0416083776397;1286.4275397448139;12670.683232919158;12729.55446559366;12745.61763147107;12769.106162568623;12792.104552681316;4366.126774645084;4518.8418405356315;4696;4702.294655801588;4730.148573256847;9952.253580981456;9953.353032052893;9965.501724913725;9967.900320996841;9968.202543796478;5121.462246464068;5122.564582010571;5127.846164615067;5129.358830146231;5134.075866344019;4004.2191772604647;4103.5691252418665;4177.3316269397355;4228.302330115558;4737.170995075848;3504.15900183954;3836.5971572984995;3871.9419208711893;3872.6320999505;3904.843806247775;1134.4497918509517;1163.813789793629;1182.3024415594841;1196.8204769284503;1204.8132539456399;753.7135888362496;758.779953813399;829.7261903571807;831.8585840407145;842.0905422144069;5560.777568897199;5768.9711551442815;5793.131030345397;5819;5875.3243377012195;453.54186291074353;457.5584560898749;461.4808340616806;461.6514531528674;467.6329081670872;3816.4084566892175;3953.031507280677;4033.778142202207;4079.347304431336;4111.239420707178;10778.73053173677;11052.060574851228;11177.161712871568;11184.161187910939;11198.664040078811;10768.192385571114;10934.398608076632;11072.612458563912;11097.722556936142;11117.833232501518;7749.573773442515;7877.291043805971;7980.68077276914;8030.478018928751;8052.718154864551;5692.1461780733225;5844.590878638624;5881.529477641864;5904.498117660047;5973.80523895214;9931.255155863195;10027.899721002988;10123.24075694311;10144.746381340525;10181.694549163536;9241.953790231006;10300.536475858755;10301.536430860779;10377.429241391494;10485.10876575469;6765.424938880054;7060.188078371053;7237.746678866214;7241.493095483476;7474.215207403362;8440.620172092393;8571.185737354941;8587.141285871363;8598.742037738877;8689.000764911863;7728.729494467667;7737.961310193413;7762.5730584818375;7795.883061754192;7866.292033716764;7407.62961851916;7414.184439711519;7419.146798118286;7487.064116985377;7750.844983100419;6963.512554121163;7006.369426751617;7070.399016083485;7248.42012638977;7283.7450689225625;5142;5223.190405487156;5325.893482130413;5360.0619891518045;5364.4099149094345;5193.506616871391;5217.739113044408;5321.760520776652;5339.25250464943;5380.919286210632 07:03:41 INFO - PROCESS | 3443 | |4;prototype.html;325.13838328429665;326.114598864084;331.61201394368595;336.68351749355605;343.4007656639165;5065.936153407789;5214.921776173361;5222.321098257226;5312.442193569677;5320.738686058424;5056.469070747574;5117.846464606058;5117.872053198672;5127.615428842833;5156.200788877721;4116;4128.422020917074;4130.566290539495;4135.7725325107185;4157.875263742078;3803.83837387144;3961.0889495416072;4066.979665101685;4108.917821643566;4115.9176816463805;4036.1927614477077;4039.596040395966;4048.3522636378184;4056.7768772717636;4061.918761624766;4053.9797301013305;4063.0248740302263;4071.6742660587083;4077.1245227195527;4090.4477895484324;3583.5341405617105;3633.8001409922445;3642.0348607619003;3642.6175251598465;3646.6535679110443;5043.478260869565;5061.962297728956;5112.539871411591;5128.410232823198;5136.460671629462;4696.084263568606;4696.309328641686;4697.835575754866;4698.577128058491;4705.95294047062;5220.2430647556275;5386.434424385422;5391.78432862685;5421.26812880264;5437.891242175135;4000.3599424092004;4009.719319647626;4016.9196616067807;4029.717919745619;4045.575214602454;5623.775048998035;5633.830985070414;5638.520725738276;5638.746256418471;5684.8863022739315;4047.9392809107885;4145.2124096421585;4161.667066634662;4163.250614889349;4166.604172603597;4129.8967525812095;4144.896377590524;4144.896377590524;4161.334186530141;4163.854265100707;4664.600619814042;4671.649626278043;4673.836415725434;4676.836310729108;4676.976615116971;5374.1938709193155;5377.112776391929;5432.212329212242;5445;5448.373437054789;1381.2196109198271;1419.1201455097905;1420.5880294714418;1436.432609119392;1445.407382972976;892.5358813416987;908.8591268353416;918.3709159225951;929.7257309093834;955.9962039858121;4653.557911998355;4663.906721865612;4666.673332866734;4667.649926255544;4673.7429441381055;4881.8535443936735;4893.40649455789;4962.858542535237;4965.553100220997;4966.832794293338;4357;4635.884102897455;4638.582527572535;4656.4156892924075;4692.671512994058;2602.648642433285;2605.778508826771;2608.604396647784;2614.4640348728467;2627.3037645024083;4984.339642434263;5034.748262586856;5052.776778217572;5067.189249720027;5081.822136225214;4801.663883528189;4980.7509624518625;4999.475055119233;5015.82444614444;5030.748462576857;5005.524475174852;5013.022460620144;5020.443662464648;5028.446870844277;5036.823711170165;4865.788579537489;4916.262560615936;4923;4931.3589233399425;4937.703967655058;4579.198640238012;4853.830115945925;4877.341558889504;4883.584895283941;4889.779959901742;5046.1926091825135;5046.77289521965;5060.191593665551;5082.237664350377;5098.566621837185;3742.644448777362;3759.699224062123;3760.8307626157434;3940.251352243179;4058.0260737422213;5436.9456305438025;5522.5581953442825;5562.610617256753;5574.275344205227;5574.386817449996;5428.565714742732;5430.565554755531;5430.805222850967;5430.891382172255;5452.482014208644;5282.392524859691;5362.276092727432;5437.809676661298;5447.284105506753;5453.863653408696;5375.811846585507;5375.838724838261;5377.596680249075;5382.811601593926;5387.138057910715;5393.298871146726;5461.863453413537;5479.53423958968;5497.340319161726;5497.7355208301515;5156.664816786897;5316.415194328543;5339.065663508948;5342.839714808562;5368.8389348319615 07:03:41 INFO - PROCESS | 3443 | |5;yui.html;614.2506142506143;617.5029101573232;689.6034780001501;697.145190445127;723.3309189000173;15406.537803865887;16610.418635347763;16975.999999999985;17006.91496542517;17536.64926701465;16377.09925954072;16508.83491165088;16655.083970381624;16658.333666653318;16709.749353759704;765.223298352173;786.3551887452292;789.3487872505177;789.3487872505177;790.2650535002446;627.5513008199159;655.3708439897704;749.0412272291476;781.5506084001694;781.8045488627843;825.6037102190952;827.7765003449096;827.9337652987747;828.0312034919159;828.825946551225;824.3611201318996;825.2201669422399;825.3438516379492;825.4551995682881;825.4634487583029;485.4053784114467;499.293499697927;568.3719489963613;594.8066878264582;603.6317846113867;15288.770668439982;15363.846361536353;15378.615534611612;15384.230788460643;15399;12500.187487813353;13048.86951130486;13135.605931822061;13486.258255795927;13954.790678139836;12333.69165770854;12522.123451358408;12629.24224546521;12701.618951431472;12840.807387889188;4226.450561426995;4263.786810659486;4287.678424118172;4299.204647140289;4387.62705170061;87961;88388;88853.55573222092;89691.55154224252;92166;9749.317547771589;10187.847182292271;10190.184785217165;10544.57821687124;10741.301815381976;21855.125794968342;22355;22420;22429.43926401853;22433;8368.623411946477;8546.487210767375;8712.956435217784;8789.033206347296;8793.736187914374;4362.454693163355;4370.431843860278;4433.844815431445;4449.154660614473;4484.349769283501;3480.825958702055;3585.3904836177912;3591.066322756102;3592.1019745063736;3596;584.2200662116038;587.8354060862965;590.8700085981163;592.7925226170805;609.5611159964818;481.54734549523334;529.3330403691376;570.5920267009026;570.6747154122111;592.6651441935379;8782.297416206688;8820.294376449869;9148.542572871464;9429.717108486757;9637.18083962857;553.7729530892395;568.778176511161;572.2132068405942;594.8483136800088;604.5103466192398;4323.6757243206885;4357.2592659248;4498.167838949805;4501.527339629357;4581.770911454414;106026.46986765017;125723.37138314433;127905;128874;130148.3492582531;65656.67171664111;66368.66815665987;79987;109992;112918.43540782407;96435;98334.50832745791;100001;101638;101917;8342.457740246864;8572.699955501528;8690.826183476169;8748.978328173374;8908.910910890809;54818;55492.72253638706;56403.02589409351;57455.712721436124;58835.411645882996;74596.25403745893;78492;78883;82101;83544;10878.40168790724;10891.455427228766;11035.724106897393;11266.887331126913;11282.548698052315;12403.379831008233;12433.366017789058;12536.122471427278;12749.362531873554;12790.36048197605;11191.72020699489;11211;11354;12119.091068169746;12120.27278363301;11617.883821162019;11843;11869.821952670543;11964.162508624313;12183.573574924834;10981.725456863642;11208.66374008781;11285;11470.483828227583;11840.111991600492;8841.60212790413;9270.258379329503;9630.181434578139;9715.611375544899;9785.85321220168;8221.30118939873;9259.76850578741;9402.961280165844;9745.658901938397;9795 07:03:41 INFO - PROCESS | 3443 | __end_tp_report 07:03:41 INFO - PROCESS | 3443 | __start_cc_report 07:03:41 INFO - PROCESS | 3443 | _x_x_mozilla_cycle_collect,1061 07:03:41 INFO - PROCESS | 3443 | __end_cc_report 07:03:41 INFO - PROCESS | 3443 | __startTimestamp1474725821151__endTimestamp 07:03:41 INFO - PROCESS | 3443 | 07:03:41 INFO - PROCESS | 3443 | ------- Summary: start ------- 07:03:41 INFO - PROCESS | 3443 | Number of tests: 6 07:03:41 INFO - PROCESS | 3443 | 07:03:41 INFO - PROCESS | 3443 | [#0] dojo.html Cycles:165 Average:5354.72 Median:5541.31 stddev:608.26 (11.0%) stddev-sans-first:582.35 07:03:41 INFO - PROCESS | 3443 | Values: 3038.4 3065.0 3077.6 3105.3 3120.3 5225.1 5310.4 5317.0 5385.5 5434.4 5426.8 5486.8 5528.6 5577.1 5578.8 4678.1 4883.5 4904.0 4923.3 4975.9 5056.4 5066.1 5071.5 5072.2 5078.0 4816.6 4875.8 4923.4 4989.7 5047.9 4801.4 4834.8 4854.9 4914.5 4943.6 4833.5 4835.3 4848.2 4868.3 4906.0 5390.5 5398.5 5406.3 5410.8 5494.7 5486.5 5553.4 5793.3 5801.1 5802.7 5711.3 5752.7 5755.5 5760.1 5775.8 5382.7 5384.5 5385.0 5390.3 5395.9 5736.4 5799.3 5916.0 5919.3 5919.5 5538.4 5588.4 5591.2 5595.8 5677.6 5664.5 5667.0 5669.8 5674.7 5686.1 5555.3 5613.8 5658.1 5677.7 5681.5 5534.6 5607.4 5627.7 5630.5 5728.3 4356.2 4388.6 4397.6 4399.8 4444.6 3911.1 3925.6 3932.5 3966.0 3985.9 5344.4 5382.0 5390.4 5470.2 5473.8 5752.7 5818.3 5820.5 5823.7 5825.3 5440.0 5447.1 5450.0 5450.1 5454.5 4996.2 5034.8 5049.0 5056.9 5117.6 5964.6 6029.8 6029.9 6033.0 6035.1 5843.4 5856.0 5858.0 5860.6 5860.7 5746.6 5794.7 5954.4 6009.9 6026.9 5755.3 5816.6 5817.5 5822.9 5825.2 5852.7 5854.6 5862.1 5866.4 5867.4 5413.1 5689.7 5693.0 5704.1 5706.9 5458.4 5607.8 5609.5 5651.7 5740.2 5603.7 5607.2 5607.8 5610.2 5614.1 5650.3 5691.8 5698.7 5698.9 5706.5 5365.4 5418.9 5480.8 5538.5 5541.3 07:03:41 INFO - PROCESS | 3443 | 07:03:41 INFO - PROCESS | 3443 | [#1] ext.html Cycles:180 Average:58940.75 Median:36931.72 stddev:113514.65 (307.4%) stddev-sans-first:113748.43 07:03:41 INFO - PROCESS | 3443 | Values: 550.1 592.3 596.6 609.4 616.0 31549.5 37054.0 37291.6 37402.4 37421.3 43126.6 43313.4 43365.0 43437.8 43580.1 8250.8 8863.9 9000.4 9005.1 9009.4 8289.8 10502.2 10769.1 10777.6 11144.8 10961.4 11033.2 11041.6 11042.3 11042.8 10746.6 10806.3 10808.8 10849.6 10932.4 10585.9 10795.6 10816.7 10821.8 10827.2 42604.6 43045.4 43142.1 43194.6 43205.6 3017.0 3045.9 3084.5 3153.8 3167.4 32304.2 32317.5 32427.4 32649.2 32679.7 4299.6 4332.3 4423.6 4544.4 4551.0 345009.3 345286.6 345437.0 347001.0 347089.0 50882.2 51029.0 51072.5 51491.5 52162.7 61199.7 61227.4 61588.0 61613.4 61708.4 15682.2 15861.8 15876.0 15882.6 15888.6 11134.0 11389.0 11587.4 12182.0 12262.9 16431.0 17098.3 17110.8 17115.7 17180.1 5843.4 6503.3 6626.4 6667.2 6753.4 976.3 1014.7 1029.2 1068.6 1084.1 31609.0 31940.2 32251.0 32362.5 32413.8 1094.8 1126.8 1177.7 1178.5 1196.6 16714.2 17038.7 17093.0 17115.5 17133.7 476014.0 517523.0 518796.0 521675.0 522099.0 52020.0 61156.0 62627.7 62807.4 62810.7 1290.3 1295.1 1312.6 1321.6 1324.2 31033.8 33710.7 33722.0 33859.0 34313.8 51738.2 52211.0 52361.0 52414.2 52471.0 412489.0 413004.0 414258.0 414881.0 415796.0 40093.6 40402.6 40704.4 41345.8 41368.8 47607.8 48651.8 48700.8 49283.3 49786.0 40136.8 40613.2 40778.6 41192.2 42457.6 36398.8 36449.0 36836.0 37027.4 37145.8 41206.8 41547.8 41682.4 42409.4 42423.8 33726.7 36416.5 36444.8 36617.3 37627.0 27682.4 27889.7 28083.2 28138.7 28208.7 07:03:41 INFO - PROCESS | 3443 | 07:03:41 INFO - PROCESS | 3443 | [#2] jquery.html Cycles:180 Average:28305.86 Median:399.27 stddev:79285.06 (19857.5%) stddev-sans-first:79479.74 07:03:41 INFO - PROCESS | 3443 | Values: 373.7 377.7 397.1 401.4 416.1 13478.9 18693.5 19036.0 19209.3 19359.9 17035.3 17128.3 17411.3 17496.3 17546.7 5510.7 5747.1 5756.4 5761.6 5762.9 4116.8 4290.7 4343.7 5589.6 5680.1 6262.2 6286.0 6389.7 6392.6 6402.2 5578.1 5871.6 5896.4 6379.1 6384.8 5778.9 5779.6 5782.5 5784.5 5789.3 12657.7 12672.2 12825.3 12845.7 14264.2 2029.5 2072.1 2104.2 2172.0 2221.8 9644.1 9715.9 10026.5 12297.1 13810.3 1817.0 1820.1 1850.3 1866.8 1867.3 78914.2 88732.6 89918.0 90420.0 90597.5 10376.3 10711.4 10769.6 10840.5 10882.4 15163.7 15210.5 15218.6 15223.3 15259.0 7234.5 7604.4 7626.8 7738.0 7857.9 7133.4 7164.7 7234.3 7371.3 7377.0 4598.7 4622.1 4622.7 4666.1 4699.5 1853.8 1886.4 1909.4 1940.0 1976.9 915.0 963.2 1008.6 1016.6 1030.9 17448.2 17482.7 18650.5 18684.4 19018.7 908.6 920.7 969.1 986.1 1015.5 10013.8 10417.2 10434.1 10481.5 10521.7 468914.0 470284.0 471322.0 489029.0 492993.0 91815.1 94967.5 98332.0 98989.0 100004.5 930.0 937.3 973.2 986.0 989.2 15753.5 15915.8 15956.2 16631.8 16995.4 29221.4 39548.2 41223.8 41817.8 41993.0 54425.0 54938.0 54943.5 55981.7 57637.0 7668.1 7738.9 7837.5 7932.4 8179.1 8799.0 11457.3 13027.5 13151.4 13405.1 11586.1 11715.4 11734.6 11891.6 11941.0 11545.2 11634.4 11767.7 11970.1 12403.0 11693.0 11708.9 11768.8 11864.7 12273.0 7869.1 8019.3 8065.8 8264.7 8360.1 8945.4 10753.6 10925.2 11095.9 11113.6 07:03:41 INFO - PROCESS | 3443 | 07:03:41 INFO - PROCESS | 3443 | [#3] mootools.html Cycles:180 Average:5766.81 Median:4716.22 stddev:3353.01 (71.1%) stddev-sans-first:3345.90 07:03:41 INFO - PROCESS | 3443 | Values: 1339.0 1452.4 1505.6 1635.8 1740.4 7693.7 8678.5 9033.2 9034.0 9298.3 9021.6 9097.4 9104.3 9107.6 9111.8 2355.0 2375.4 2376.5 2376.8 2378.1 2311.5 2337.4 2372.5 2373.8 2377.1 2303.3 2310.3 2310.9 2334.1 2347.0 2270.2 2300.2 2302.3 2306.1 2307.3 2265.6 2267.1 2271.3 2275.5 2276.1 9019.0 9047.4 9058.9 9060.2 9067.8 5083.3 5248.9 5258.5 5259.9 5262.1 3428.9 3632.7 3675.5 3685.4 3695.9 1199.0 1238.3 1244.2 1261.0 1286.4 12670.7 12729.6 12745.6 12769.1 12792.1 4366.1 4518.8 4696.0 4702.3 4730.1 9952.3 9953.4 9965.5 9967.9 9968.2 5121.5 5122.6 5127.8 5129.4 5134.1 4004.2 4103.6 4177.3 4228.3 4737.2 3504.2 3836.6 3871.9 3872.6 3904.8 1134.4 1163.8 1182.3 1196.8 1204.8 753.7 758.8 829.7 831.9 842.1 5560.8 5769.0 5793.1 5819.0 5875.3 453.5 457.6 461.5 461.7 467.6 3816.4 3953.0 4033.8 4079.3 4111.2 10778.7 11052.1 11177.2 11184.2 11198.7 10768.2 10934.4 11072.6 11097.7 11117.8 7749.6 7877.3 7980.7 8030.5 8052.7 5692.1 5844.6 5881.5 5904.5 5973.8 9931.3 10027.9 10123.2 10144.7 10181.7 9242.0 10300.5 10301.5 10377.4 10485.1 6765.4 7060.2 7237.7 7241.5 7474.2 8440.6 8571.2 8587.1 8598.7 8689.0 7728.7 7738.0 7762.6 7795.9 7866.3 7407.6 7414.2 7419.1 7487.1 7750.8 6963.5 7006.4 7070.4 7248.4 7283.7 5142.0 5223.2 5325.9 5360.1 5364.4 5193.5 5217.7 5321.8 5339.3 5380.9 07:03:41 INFO - PROCESS | 3443 | 07:03:41 INFO - PROCESS | 3443 | [#4] prototype.html Cycles:180 Average:4420.04 Median:4927.18 stddev:1255.90 (25.5%) stddev-sans-first:1221.24 07:03:41 INFO - PROCESS | 3443 | Values: 325.1 326.1 331.6 336.7 343.4 5065.9 5214.9 5222.3 5312.4 5320.7 5056.5 5117.8 5117.9 5127.6 5156.2 4116.0 4128.4 4130.6 4135.8 4157.9 3803.8 3961.1 4067.0 4108.9 4115.9 4036.2 4039.6 4048.4 4056.8 4061.9 4054.0 4063.0 4071.7 4077.1 4090.4 3583.5 3633.8 3642.0 3642.6 3646.7 5043.5 5062.0 5112.5 5128.4 5136.5 4696.1 4696.3 4697.8 4698.6 4706.0 5220.2 5386.4 5391.8 5421.3 5437.9 4000.4 4009.7 4016.9 4029.7 4045.6 5623.8 5633.8 5638.5 5638.7 5684.9 4047.9 4145.2 4161.7 4163.3 4166.6 4129.9 4144.9 4144.9 4161.3 4163.9 4664.6 4671.6 4673.8 4676.8 4677.0 5374.2 5377.1 5432.2 5445.0 5448.4 1381.2 1419.1 1420.6 1436.4 1445.4 892.5 908.9 918.4 929.7 956.0 4653.6 4663.9 4666.7 4667.6 4673.7 4881.9 4893.4 4962.9 4965.6 4966.8 4357.0 4635.9 4638.6 4656.4 4692.7 2602.6 2605.8 2608.6 2614.5 2627.3 4984.3 5034.7 5052.8 5067.2 5081.8 4801.7 4980.8 4999.5 5015.8 5030.7 5005.5 5013.0 5020.4 5028.4 5036.8 4865.8 4916.3 4923.0 4931.4 4937.7 4579.2 4853.8 4877.3 4883.6 4889.8 5046.2 5046.8 5060.2 5082.2 5098.6 3742.6 3759.7 3760.8 3940.3 4058.0 5436.9 5522.6 5562.6 5574.3 5574.4 5428.6 5430.6 5430.8 5430.9 5452.5 5282.4 5362.3 5437.8 5447.3 5453.9 5375.8 5375.8 5377.6 5382.8 5387.1 5393.3 5461.9 5479.5 5497.3 5497.7 5156.7 5316.4 5339.1 5342.8 5368.8 07:03:41 INFO - PROCESS | 3443 | 07:03:41 INFO - PROCESS | 3443 | [#5] yui.html Cycles:180 Average:21375.36 Median:492.35 stddev:32281.42 (6556.6%) stddev-sans-first:32334.34 07:03:41 INFO - PROCESS | 3443 | Values: 614.3 617.5 689.6 697.1 723.3 15406.5 16610.4 16976.0 17006.9 17536.6 16377.1 16508.8 16655.1 16658.3 16709.7 765.2 786.4 789.3 789.3 790.3 627.6 655.4 749.0 781.6 781.8 825.6 827.8 827.9 828.0 828.8 824.4 825.2 825.3 825.5 825.5 485.4 499.3 568.4 594.8 603.6 15288.8 15363.8 15378.6 15384.2 15399.0 12500.2 13048.9 13135.6 13486.3 13954.8 12333.7 12522.1 12629.2 12701.6 12840.8 4226.5 4263.8 4287.7 4299.2 4387.6 87961.0 88388.0 88853.6 89691.6 92166.0 9749.3 10187.8 10190.2 10544.6 10741.3 21855.1 22355.0 22420.0 22429.4 22433.0 8368.6 8546.5 8713.0 8789.0 8793.7 4362.5 4370.4 4433.8 4449.2 4484.3 3480.8 3585.4 3591.1 3592.1 3596.0 584.2 587.8 590.9 592.8 609.6 481.5 529.3 570.6 570.7 592.7 8782.3 8820.3 9148.5 9429.7 9637.2 553.8 568.8 572.2 594.8 604.5 4323.7 4357.3 4498.2 4501.5 4581.8 106026.5 125723.4 127905.0 128874.0 130148.3 65656.7 66368.7 79987.0 109992.0 112918.4 96435.0 98334.5 100001.0 101638.0 101917.0 8342.5 8572.7 8690.8 8749.0 8908.9 54818.0 55492.7 56403.0 57455.7 58835.4 74596.3 78492.0 78883.0 82101.0 83544.0 10878.4 10891.5 11035.7 11266.9 11282.5 12403.4 12433.4 12536.1 12749.4 12790.4 11191.7 11211.0 11354.0 12119.1 12120.3 11617.9 11843.0 11869.8 11964.2 12183.6 10981.7 11208.7 11285.0 11470.5 11840.1 8841.6 9270.3 9630.2 9715.6 9785.9 8221.3 9259.8 9403.0 9745.7 9795.0 07:03:41 INFO - PROCESS | 3443 | -------- Summary: end -------- 07:03:41 INFO - PROCESS | 3443 | 07:03:42 INFO - TEST-INFO | 3443: exit 0 07:03:42 INFO - TEST-OK | dromaeo_css | took 1117579ms 07:03:42 INFO - TEST-START | kraken 07:03:42 INFO - operating with platform_type : linux_ 07:03:42 INFO - Initialising browser for kraken test... 07:03:42 INFO - TEST-INFO | started process 3751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWZ6Nyt/profile http://localhost:34688/getInfo.html) 07:03:46 INFO - PROCESS | 3751 | __metrics Screen width/height:1600/1200 07:03:46 INFO - PROCESS | 3751 | colorDepth:24 07:03:46 INFO - PROCESS | 3751 | Browser inner width/height: 1024/697 07:03:46 INFO - PROCESS | 3751 | __metrics 07:03:46 INFO - PROCESS | 3751 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:03:46 INFO - PROCESS | 3751 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:03:47 INFO - PROCESS | 3751 | console.error: PushService: 07:03:47 INFO - PROCESS | 3751 | stateChangeProcessEnqueue: Error transitioning state 07:03:47 INFO - PROCESS | 3751 | UnknownError 07:03:47 INFO - TEST-INFO | 3751: exit 0 07:03:47 INFO - Browser initialized. 07:03:47 INFO - Running cycle 1/1 for kraken test... 07:03:47 INFO - TEST-INFO | started process 3831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWZ6Nyt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:03:59 INFO - PROCESS | 3831 | RSS: Main: 173461504 07:03:59 INFO - PROCESS | 3831 | 07:04:02 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34688/tests/kraken/driver.html?testName=audio-beat-detection) 07:04:03 INFO - PROCESS | 3831 | RSS: Main: 233189376 07:04:03 INFO - PROCESS | 3831 | 07:04:05 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34688/tests/kraken/driver.html?testName=audio-dft) 07:04:06 INFO - PROCESS | 3831 | RSS: Main: 217980928 07:04:06 INFO - PROCESS | 3831 | 07:04:09 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34688/tests/kraken/driver.html?testName=audio-fft) 07:04:10 INFO - PROCESS | 3831 | RSS: Main: 298713088 07:04:10 INFO - PROCESS | 3831 | 07:04:12 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34688/tests/kraken/driver.html?testName=audio-oscillator) 07:04:12 INFO - PROCESS | 3831 | RSS: Main: 208887808 07:04:12 INFO - PROCESS | 3831 | 07:04:15 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34688/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:04:15 INFO - PROCESS | 3831 | RSS: Main: 213594112 07:04:15 INFO - PROCESS | 3831 | 07:04:18 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34688/tests/kraken/driver.html?testName=imaging-darkroom) 07:04:19 INFO - PROCESS | 3831 | RSS: Main: 249434112 07:04:19 INFO - PROCESS | 3831 | 07:04:22 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34688/tests/kraken/driver.html?testName=imaging-desaturate) 07:04:23 INFO - PROCESS | 3831 | RSS: Main: 248909824 07:04:23 INFO - PROCESS | 3831 | 07:04:26 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34688/tests/kraken/driver.html?testName=json-parse-financial) 07:04:26 INFO - PROCESS | 3831 | RSS: Main: 248983552 07:04:26 INFO - PROCESS | 3831 | 07:04:28 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34688/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:04:28 INFO - PROCESS | 3831 | RSS: Main: 210497536 07:04:28 INFO - PROCESS | 3831 | 07:04:30 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34688/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:04:31 INFO - PROCESS | 3831 | RSS: Main: 217423872 07:04:31 INFO - PROCESS | 3831 | 07:04:33 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34688/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:04:33 INFO - PROCESS | 3831 | RSS: Main: 222367744 07:04:33 INFO - PROCESS | 3831 | 07:04:36 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:04:36 INFO - PROCESS | 3831 | RSS: Main: 223789056 07:04:36 INFO - PROCESS | 3831 | 07:04:39 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:04:40 INFO - PROCESS | 3831 | RSS: Main: 222449664 07:04:40 INFO - PROCESS | 3831 | 07:04:41 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:34688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34688/tests/kraken/driver.html?testName=ai-astar) 07:04:42 INFO - PROCESS | 3831 | RSS: Main: 272740352 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | __start_tp_report 07:04:42 INFO - PROCESS | 3831 | _x_x_mozilla_page_load 07:04:42 INFO - PROCESS | 3831 | _x_x_mozilla_page_load_details 07:04:42 INFO - PROCESS | 3831 | |i|pagename|runs| 07:04:42 INFO - PROCESS | 3831 | |0;ai-astar;111;111;111;112;113;111;114;114;113;114 07:04:42 INFO - PROCESS | 3831 | |1;audio-beat-detection;147;120;118;171;121;119;122;118;160;117 07:04:42 INFO - PROCESS | 3831 | |2;audio-dft;161;163;162;160;162;162;161;164;161;161 07:04:42 INFO - PROCESS | 3831 | |3;audio-fft;75;76;76;99;77;76;76;76;111;76 07:04:42 INFO - PROCESS | 3831 | |4;audio-oscillator;83;82;109;82;82;82;112;83;83;116 07:04:42 INFO - PROCESS | 3831 | |5;imaging-gaussian-blur;117;117;117;118;117;118;118;117;118;118 07:04:42 INFO - PROCESS | 3831 | |6;imaging-darkroom;145;145;146;146;145;146;145;145;146;145 07:04:42 INFO - PROCESS | 3831 | |7;imaging-desaturate;95;95;94;95;95;94;95;96;95;95 07:04:42 INFO - PROCESS | 3831 | |8;json-parse-financial;54;49;51;49;50;52;52;54;53;51 07:04:42 INFO - PROCESS | 3831 | |9;json-stringify-tinderbox;59;60;59;60;61;60;61;61;61;61 07:04:42 INFO - PROCESS | 3831 | |10;stanford-crypto-aes;79;79;84;78;79;79;79;79;79;79 07:04:42 INFO - PROCESS | 3831 | |11;stanford-crypto-ccm;128;139;122;122;130;121;127;130;156;122 07:04:42 INFO - PROCESS | 3831 | |12;stanford-crypto-pbkdf2;170;169;166;167;167;166;163;163;164;162 07:04:42 INFO - PROCESS | 3831 | |13;stanford-crypto-sha256-iterative;63;65;70;64;67;68;66;65;64;64 07:04:42 INFO - PROCESS | 3831 | __end_tp_report 07:04:42 INFO - PROCESS | 3831 | __start_cc_report 07:04:42 INFO - PROCESS | 3831 | _x_x_mozilla_cycle_collect,1619 07:04:42 INFO - PROCESS | 3831 | __end_cc_report 07:04:42 INFO - PROCESS | 3831 | __startTimestamp1474725882209__endTimestamp 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | ------- Summary: start ------- 07:04:42 INFO - PROCESS | 3831 | Number of tests: 14 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.35 (1.2%) stddev-sans-first:1.33 07:04:42 INFO - PROCESS | 3831 | Values: 111.0 111.0 111.0 112.0 113.0 111.0 114.0 114.0 113.0 114.0 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:121.50 stddev:20.21 (16.6%) stddev-sans-first:20.62 07:04:42 INFO - PROCESS | 3831 | Values: 147.0 120.0 118.0 171.0 121.0 119.0 122.0 118.0 160.0 117.0 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 07:04:42 INFO - PROCESS | 3831 | Values: 161.0 163.0 162.0 160.0 162.0 162.0 161.0 164.0 161.0 161.0 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.56 (16.5%) stddev-sans-first:13.08 07:04:42 INFO - PROCESS | 3831 | Values: 75.0 76.0 76.0 99.0 77.0 76.0 76.0 76.0 111.0 76.0 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:82.00 stddev:14.55 (17.7%) stddev-sans-first:15.11 07:04:42 INFO - PROCESS | 3831 | Values: 83.0 82.0 109.0 82.0 82.0 82.0 112.0 83.0 83.0 116.0 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:04:42 INFO - PROCESS | 3831 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:04:42 INFO - PROCESS | 3831 | Values: 145.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:04:42 INFO - PROCESS | 3831 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 96.0 95.0 95.0 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:1.84 (3.5%) stddev-sans-first:1.72 07:04:42 INFO - PROCESS | 3831 | Values: 54.0 49.0 51.0 49.0 50.0 52.0 52.0 54.0 53.0 51.0 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 07:04:42 INFO - PROCESS | 3831 | Values: 59.0 60.0 59.0 60.0 61.0 60.0 61.0 61.0 61.0 61.0 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:1.65 (2.1%) stddev-sans-first:1.74 07:04:42 INFO - PROCESS | 3831 | Values: 79.0 79.0 84.0 78.0 79.0 79.0 79.0 79.0 79.0 79.0 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:129.00 stddev:10.76 (8.3%) stddev-sans-first:11.40 07:04:42 INFO - PROCESS | 3831 | Values: 128.0 139.0 122.0 122.0 130.0 121.0 127.0 130.0 156.0 122.0 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:166.50 stddev:2.67 (1.6%) stddev-sans-first:2.33 07:04:42 INFO - PROCESS | 3831 | Values: 170.0 169.0 166.0 167.0 167.0 166.0 163.0 163.0 164.0 162.0 07:04:42 INFO - PROCESS | 3831 | 07:04:42 INFO - PROCESS | 3831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:2.17 (3.3%) stddev-sans-first:2.09 07:04:42 INFO - PROCESS | 3831 | Values: 63.0 65.0 70.0 64.0 67.0 68.0 66.0 65.0 64.0 64.0 07:04:42 INFO - PROCESS | 3831 | -------- Summary: end -------- 07:04:42 INFO - PROCESS | 3831 | 07:04:43 INFO - TEST-INFO | 3831: exit 0 07:04:43 INFO - TEST-OK | kraken | took 61328ms 07:04:43 INFO - SUITE-END | took 1178s 07:04:43 INFO - Completed test suite (00:19:39) 07:04:43 INFO - javascript benchmark 07:04:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3038.361943991762, 3064.984675076624, 3077.569140320354, 3105.3168302973336, 3120.26673731673, 5225.137852254374, 5310.36275646922, 5317.042932272194, 5385.488378604031, 5434.429384914586, 5426.782928682848, 5486.780528778854, 5528.55771538277, 5577.079781835992, 5578.832635020945, 4678.064387122572, 4883.487233840449, 4903.950960490403, 4923.261510773395, 4975.925361119586, 5056.443791182967, 5066.06277838601, 5071.492850714936, 5072.188449848025, 5077.974610126944, 4816.638752093607, 4875.829345972909, 4923.359963204796, 4989.650724449308, 5047.873803154914, 4801.447833499123, 4834.830780922686, 4854.854354369375, 4914.459409464956, 4943.604511639096, 4833.492483289274, 4835.274708793674, 4848.22428411456, 4868.269759536098, 4905.950940490585, 5390.460953904618, 5398.541124004425, 5406.297181366397, 5410.83767486976, 5494.697791621459, 5486.506214440679, 5553.389127196006, 5793.304803423574, 5801.129830525413, 5802.7098645068, 5711.314642242957, 5752.683602401867, 5755.539556835443, 5760.107183386582, 5775.768969241225, 5382.650127741685, 5384.542313903362, 5384.976854397691, 5390.272313237741, 5395.919061214085, 5736.42635736423, 5799.3040835100055, 5916.0, 5919.260092488439, 5919.467247947706, 5538.418466061086, 5588.3573389060775, 5591.189277554732, 5595.832125036255, 5677.602567820296, 5664.461876121762, 5666.97166514173, 5669.773209071591, 5674.716264186774, 5686.14707793826, 5555.30558680165, 5613.775448981995, 5658.066419040894, 5677.716114194273, 5681.488666019995, 5534.612577119563, 5607.439256074442, 5627.662340259598, 5630.5214056805635, 5728.341240757366, 4356.172327257811, 4388.648908087345, 4397.560243975641, 4399.758013309299, 4444.577765112309, 3911.1004468972296, 3925.568187499373, 3932.5477570079233, 3965.980170099189, 3985.860494882665, 5344.43883392246, 5382.0, 5390.380106287748, 5470.206820011155, 5473.8357849264585, 5752.683602401824, 5818.272715910512, 5820.476157145878, 5823.679697616587, 5825.271841019872, 5440.020796256633, 5447.101228297366, 5450.04624190765, 5450.127979523337, 5454.481824226692, 4996.200607902718, 5034.8237811677145, 5049.040682270357, 5056.873578160576, 5117.641765076483, 5964.642121472725, 6029.788957386558, 6029.909551356734, 6032.969835150796, 6035.064564992434, 5843.386444423444, 5856.0, 5858.0, 5860.619059761102, 5860.736266867916, 5746.569007324384, 5794.681292528951, 5954.37479064692, 6009.939900601113, 6026.879462410815, 5755.280589926259, 5816.563757718103, 5817.534597232296, 5822.883542329215, 5825.213596164633, 5852.707364631666, 5854.590178687451, 5862.062070068769, 5866.384029676993, 5867.442592953663, 5413.10683737179, 5689.743961521659, 5692.971535142297, 5704.11586204139, 5706.857328566819, 5458.372287187024, 5607.775688972395, 5609.49514543693, 5651.745671444713, 5740.225069615549, 5603.691796951207, 5607.2149899014985, 5607.775688972395, 5610.158476228598, 5614.101743720985, 5650.29371328584, 5691.800786972436, 5698.686572238566, 5698.943010569841, 5706.457886500776, 5365.356157261153, 5418.945810541844, 5480.753366098615, 5538.529225015919, 5541.307336582927], "value": 5313.3723197876225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.0943302551882, 592.2537602620694, 596.6151832068316, 609.4210500024977, 615.969201539923, 31549.526757098633, 37054.0, 37291.62708372915, 37402.4389634155, 37421.25157496848, 43126.56873431265, 43313.35029974553, 43365.0, 43437.78281108598, 43580.12839743203, 8250.834983300361, 8863.911360886405, 9000.414973026765, 9005.14451127142, 9009.414388064755, 8289.83420331593, 10502.159827213805, 10769.084627806646, 10777.62278320255, 11144.777104457906, 10961.397123158224, 11033.172512061587, 11041.613543525978, 11042.282251653616, 11042.834357484644, 10746.623868164615, 10806.29759065666, 10808.78382432347, 10849.620263290826, 10932.398718070503, 10585.947070264676, 10795.5681772729, 10816.72958176044, 10821.83767243492, 10827.187960902886, 42604.57395426068, 43045.35431968523, 43142.13715725668, 43194.56805431937, 43205.56794432047, 3017.0, 3045.9086227413213, 3084.52189910562, 3153.779235453519, 3167.3665266946705, 32304.21611461596, 32317.51523727146, 32427.351452970808, 32649.183770405692, 32679.67320326814, 4299.570042995707, 4332.28517294646, 4423.601875831158, 4544.431946006749, 4551.044280701057, 345009.27495362615, 345286.5563738349, 345437.0, 347001.0, 347089.0, 50882.236766448535, 51029.0, 51072.489275106775, 51491.48508514867, 52162.73918630383, 61199.694001530595, 61227.38772612306, 61588.0, 61613.38386616166, 61708.44623983863, 15682.215889205494, 15861.762073568905, 15876.047437153808, 15882.60293492672, 15888.60278493047, 11134.0, 11389.031932285683, 11587.420628968517, 12182.0, 12262.877371226352, 16431.0, 17098.316067357417, 17110.828891710924, 17115.74326385105, 17180.134469744207, 5843.357230704619, 6503.28463868974, 6626.370494803083, 6667.19993600771, 6753.3921947025, 976.272676855747, 1014.7310962594918, 1029.1920842138884, 1068.5885933915342, 1084.0568705226347, 31609.0, 31940.20149496281, 32251.0, 32362.514562281583, 32413.837930810194, 1094.7591529863416, 1126.8253420719802, 1177.711460692136, 1178.5344788808372, 1196.557273808679, 16714.247858846138, 17038.659226815642, 17093.0, 17115.486535403958, 17133.742993855103, 476014.0, 517523.0, 518796.0, 521675.0, 522099.0, 52020.0, 61156.0, 62627.6868615654, 62807.37192628015, 62810.685946569974, 1290.3354772292278, 1295.0999055656227, 1312.6259016180343, 1321.6167311479562, 1324.16577556139, 31033.844830775703, 33710.662893370754, 33722.0, 33859.0, 34313.828430857684, 51738.22392664038, 52211.0, 52361.0, 52414.21378679399, 52471.01525355085, 412489.0, 413004.0, 414258.0, 414881.0, 415796.0, 40093.58736570526, 40402.59597403988, 40704.3894341591, 41345.79327103345, 41368.82889638795, 47607.76196118997, 48651.756741216064, 48700.75649621729, 49283.26075108948, 49786.0, 40136.799316003235, 40613.1877362457, 40778.59221407748, 41192.176156477304, 42457.57542424536, 36398.8180059098, 36449.0, 36836.0, 37027.44458833174, 37145.81427092847, 41206.793966029974, 41547.7922610385, 41682.374764379165, 42409.36385954275, 42423.78788106163, 33726.66273337235, 36416.45375319319, 36444.81777591095, 36617.267654647294, 37627.0, 27682.446351072464, 27889.721102788713, 28083.157505274874, 28138.71861281361, 28208.71791282143], "value": 20275.812974040506, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.65623626263834, 377.69972871567103, 397.14019148543406, 401.3999071388275, 416.1344403640428, 13478.932605336971, 18693.532661683446, 19036.0, 19209.32767353143, 19359.90320048398, 17035.318587256526, 17128.31486740532, 17411.3035478581, 17496.300147994098, 17546.736798948026, 5510.724463776815, 5747.137929310595, 5756.366799652056, 5761.567882408815, 5762.855928601797, 4116.835326586933, 4290.742555446667, 4343.674224433164, 5589.580781441387, 5680.091185410335, 6262.248530176363, 6286.025666021774, 6389.744410223609, 6392.61644301341, 6402.231732192144, 5578.135389014709, 5871.6183448075735, 5896.38088000758, 6379.106925030476, 6384.776532821352, 5778.855528611776, 5779.566532510079, 5782.450667186653, 5784.450477204701, 5789.334226563915, 12657.683557911034, 12672.176308539916, 12825.294608796512, 12845.67885802853, 14264.215468149248, 2029.4824819671037, 2072.0882811562865, 2104.158336665331, 2171.9891400543056, 2221.7889300516426, 9644.132028117432, 9715.854262186072, 10026.548805303779, 12297.077719171099, 13810.309484525835, 1816.9909150454164, 1820.0899550224888, 1850.2783914273443, 1866.8319851213455, 1867.3184287735014, 78914.21085789126, 88732.55633721854, 89918.0, 90419.99999999935, 90597.54701226517, 10376.325538839952, 10711.357318560911, 10769.62306319275, 10840.5121769519, 10882.401467919182, 15163.696726065416, 15210.490269105694, 15218.619534511505, 15223.31495082724, 15259.0, 7234.493585449073, 7604.429667774939, 7626.8093297668, 7738.017956835732, 7857.9214207857185, 7133.358105333126, 7164.677589508485, 7234.276572342724, 7371.336579707852, 7377.0409846719585, 4598.724076555417, 4622.14490319292, 4622.699524530894, 4666.113438446684, 4699.506551812079, 1853.7682789651294, 1886.377495426506, 1909.3985394600656, 1939.951501212481, 1976.861619686637, 914.963401463934, 963.1909196275162, 1008.5763979128636, 1016.5628779624684, 1030.90206430389, 17448.21483033241, 17482.65034699299, 18650.53373665642, 18684.439466816017, 19018.71471927922, 908.5729707037682, 920.7099763574587, 969.0551712080805, 986.1026465915982, 1015.5430056474615, 10013.849792253122, 10417.218708596885, 10434.113100386401, 10481.528331225114, 10521.684349469528, 468914.0, 470284.0, 471322.0, 489029.0, 492993.0, 91815.081849182, 94967.52516237374, 98332.0, 98989.0, 100004.49997749965, 929.972100836976, 937.2970272295914, 973.1922504321396, 985.9507024648739, 989.2135752077116, 15753.527394178192, 15915.80245195062, 15956.202189890691, 16631.75052374191, 16995.40516081931, 29221.415571688023, 39548.209035819695, 41223.793881030404, 41817.79091104525, 41993.0, 54425.0, 54938.0, 54943.45056549383, 55981.720091399286, 57637.0, 7668.097566805782, 7738.883916741141, 7837.49056311338, 7932.405069619686, 8179.0594081681365, 8798.956005220189, 11457.255278406878, 13027.47890084386, 13151.408186631434, 13405.06164568471, 11586.131040171853, 11715.355655439032, 11734.647960561197, 11891.583794567148, 11940.95483664642, 11545.249558778989, 11634.36011019402, 11767.705807354541, 11970.102242332034, 12403.0, 11693.0, 11708.88291117078, 11768.764624707286, 11864.694883562628, 12273.0, 7869.134395216636, 8019.278264956182, 8065.798355041171, 8264.710735124241, 8360.08039115709, 8945.418547794372, 10753.569857205624, 10925.235233533576, 11095.889041109485, 11113.555457781922], "value": 8825.147961744664, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.0358941562072, 1452.419032387045, 1505.5859638599386, 1635.8364163583635, 1740.3647668600956, 7693.653785579649, 8678.522681252529, 9033.23217526511, 9034.006259311478, 9298.349115561914, 9021.639134434614, 9097.363184577081, 9104.27165826734, 9107.59015844287, 9111.817763644724, 2354.9764502355015, 2375.3942744600104, 2376.512814872947, 2376.8455050421753, 2378.1319818266293, 2311.503026849227, 2337.357226762637, 2372.4543355028354, 2373.750756170603, 2377.120465427794, 2303.3435470890718, 2310.260716570698, 2310.9422264443438, 2334.11303704592, 2347.0, 2270.205428100152, 2300.160441438871, 2302.343832007878, 2306.054517647765, 2307.284741730069, 2265.6035193841176, 2267.115824828318, 2271.2958982715413, 2275.5221403505284, 2276.1236923784295, 9019.0, 9047.366684332099, 9058.864117038249, 9060.184583387461, 9067.818643627157, 5083.262926875583, 5248.947510524922, 5258.50044245796, 5259.894802103937, 5262.105442074857, 3428.8971330860113, 3632.745707800455, 3675.5221821163345, 3685.3734865073, 3695.8521659133603, 1198.9880101198964, 1238.3127364312802, 1244.2223610243598, 1261.0416083776397, 1286.4275397448139, 12670.683232919158, 12729.55446559366, 12745.61763147107, 12769.106162568623, 12792.104552681316, 4366.126774645084, 4518.8418405356315, 4696.0, 4702.294655801588, 4730.148573256847, 9952.253580981456, 9953.353032052893, 9965.501724913725, 9967.900320996841, 9968.202543796478, 5121.462246464068, 5122.564582010571, 5127.846164615067, 5129.358830146231, 5134.075866344019, 4004.2191772604647, 4103.5691252418665, 4177.3316269397355, 4228.302330115558, 4737.170995075848, 3504.15900183954, 3836.5971572984995, 3871.9419208711893, 3872.6320999505, 3904.843806247775, 1134.4497918509517, 1163.813789793629, 1182.3024415594841, 1196.8204769284503, 1204.8132539456399, 753.7135888362496, 758.779953813399, 829.7261903571807, 831.8585840407145, 842.0905422144069, 5560.777568897199, 5768.9711551442815, 5793.131030345397, 5819.0, 5875.3243377012195, 453.54186291074353, 457.5584560898749, 461.4808340616806, 461.6514531528674, 467.6329081670872, 3816.4084566892175, 3953.031507280677, 4033.778142202207, 4079.347304431336, 4111.239420707178, 10778.73053173677, 11052.060574851228, 11177.161712871568, 11184.161187910939, 11198.664040078811, 10768.192385571114, 10934.398608076632, 11072.612458563912, 11097.722556936142, 11117.833232501518, 7749.573773442515, 7877.291043805971, 7980.68077276914, 8030.478018928751, 8052.718154864551, 5692.1461780733225, 5844.590878638624, 5881.529477641864, 5904.498117660047, 5973.80523895214, 9931.255155863195, 10027.899721002988, 10123.24075694311, 10144.746381340525, 10181.694549163536, 9241.953790231006, 10300.536475858755, 10301.536430860779, 10377.429241391494, 10485.10876575469, 6765.424938880054, 7060.188078371053, 7237.746678866214, 7241.493095483476, 7474.215207403362, 8440.620172092393, 8571.185737354941, 8587.141285871363, 8598.742037738877, 8689.000764911863, 7728.729494467667, 7737.961310193413, 7762.5730584818375, 7795.883061754192, 7866.292033716764, 7407.62961851916, 7414.184439711519, 7419.146798118286, 7487.064116985377, 7750.844983100419, 6963.512554121163, 7006.369426751617, 7070.399016083485, 7248.42012638977, 7283.7450689225625, 5142.0, 5223.190405487156, 5325.893482130413, 5360.0619891518045, 5364.4099149094345, 5193.506616871391, 5217.739113044408, 5321.760520776652, 5339.25250464943, 5380.919286210632], "value": 4509.380353735902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.13838328429665, 326.114598864084, 331.61201394368595, 336.68351749355605, 343.4007656639165, 5065.936153407789, 5214.921776173361, 5222.321098257226, 5312.442193569677, 5320.738686058424, 5056.469070747574, 5117.846464606058, 5117.872053198672, 5127.615428842833, 5156.200788877721, 4116.0, 4128.422020917074, 4130.566290539495, 4135.7725325107185, 4157.875263742078, 3803.83837387144, 3961.0889495416072, 4066.979665101685, 4108.917821643566, 4115.9176816463805, 4036.1927614477077, 4039.596040395966, 4048.3522636378184, 4056.7768772717636, 4061.918761624766, 4053.9797301013305, 4063.0248740302263, 4071.6742660587083, 4077.1245227195527, 4090.4477895484324, 3583.5341405617105, 3633.8001409922445, 3642.0348607619003, 3642.6175251598465, 3646.6535679110443, 5043.478260869565, 5061.962297728956, 5112.539871411591, 5128.410232823198, 5136.460671629462, 4696.084263568606, 4696.309328641686, 4697.835575754866, 4698.577128058491, 4705.95294047062, 5220.2430647556275, 5386.434424385422, 5391.78432862685, 5421.26812880264, 5437.891242175135, 4000.3599424092004, 4009.719319647626, 4016.9196616067807, 4029.717919745619, 4045.575214602454, 5623.775048998035, 5633.830985070414, 5638.520725738276, 5638.746256418471, 5684.8863022739315, 4047.9392809107885, 4145.2124096421585, 4161.667066634662, 4163.250614889349, 4166.604172603597, 4129.8967525812095, 4144.896377590524, 4144.896377590524, 4161.334186530141, 4163.854265100707, 4664.600619814042, 4671.649626278043, 4673.836415725434, 4676.836310729108, 4676.976615116971, 5374.1938709193155, 5377.112776391929, 5432.212329212242, 5445.0, 5448.373437054789, 1381.2196109198271, 1419.1201455097905, 1420.5880294714418, 1436.432609119392, 1445.407382972976, 892.5358813416987, 908.8591268353416, 918.3709159225951, 929.7257309093834, 955.9962039858121, 4653.557911998355, 4663.906721865612, 4666.673332866734, 4667.649926255544, 4673.7429441381055, 4881.8535443936735, 4893.40649455789, 4962.858542535237, 4965.553100220997, 4966.832794293338, 4357.0, 4635.884102897455, 4638.582527572535, 4656.4156892924075, 4692.671512994058, 2602.648642433285, 2605.778508826771, 2608.604396647784, 2614.4640348728467, 2627.3037645024083, 4984.339642434263, 5034.748262586856, 5052.776778217572, 5067.189249720027, 5081.822136225214, 4801.663883528189, 4980.7509624518625, 4999.475055119233, 5015.82444614444, 5030.748462576857, 5005.524475174852, 5013.022460620144, 5020.443662464648, 5028.446870844277, 5036.823711170165, 4865.788579537489, 4916.262560615936, 4923.0, 4931.3589233399425, 4937.703967655058, 4579.198640238012, 4853.830115945925, 4877.341558889504, 4883.584895283941, 4889.779959901742, 5046.1926091825135, 5046.77289521965, 5060.191593665551, 5082.237664350377, 5098.566621837185, 3742.644448777362, 3759.699224062123, 3760.8307626157434, 3940.251352243179, 4058.0260737422213, 5436.9456305438025, 5522.5581953442825, 5562.610617256753, 5574.275344205227, 5574.386817449996, 5428.565714742732, 5430.565554755531, 5430.805222850967, 5430.891382172255, 5452.482014208644, 5282.392524859691, 5362.276092727432, 5437.809676661298, 5447.284105506753, 5453.863653408696, 5375.811846585507, 5375.838724838261, 5377.596680249075, 5382.811601593926, 5387.138057910715, 5393.298871146726, 5461.863453413537, 5479.53423958968, 5497.340319161726, 5497.7355208301515, 5156.664816786897, 5316.415194328543, 5339.065663508948, 5342.839714808562, 5368.8389348319615], "value": 4026.0920715726284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.2506142506143, 617.5029101573232, 689.6034780001501, 697.145190445127, 723.3309189000173, 15406.537803865887, 16610.418635347763, 16975.999999999985, 17006.91496542517, 17536.64926701465, 16377.09925954072, 16508.83491165088, 16655.083970381624, 16658.333666653318, 16709.749353759704, 765.223298352173, 786.3551887452292, 789.3487872505177, 789.3487872505177, 790.2650535002446, 627.5513008199159, 655.3708439897704, 749.0412272291476, 781.5506084001694, 781.8045488627843, 825.6037102190952, 827.7765003449096, 827.9337652987747, 828.0312034919159, 828.825946551225, 824.3611201318996, 825.2201669422399, 825.3438516379492, 825.4551995682881, 825.4634487583029, 485.4053784114467, 499.293499697927, 568.3719489963613, 594.8066878264582, 603.6317846113867, 15288.770668439982, 15363.846361536353, 15378.615534611612, 15384.230788460643, 15399.0, 12500.187487813353, 13048.86951130486, 13135.605931822061, 13486.258255795927, 13954.790678139836, 12333.69165770854, 12522.123451358408, 12629.24224546521, 12701.618951431472, 12840.807387889188, 4226.450561426995, 4263.786810659486, 4287.678424118172, 4299.204647140289, 4387.62705170061, 87961.0, 88388.0, 88853.55573222092, 89691.55154224252, 92166.0, 9749.317547771589, 10187.847182292271, 10190.184785217165, 10544.57821687124, 10741.301815381976, 21855.125794968342, 22355.0, 22420.0, 22429.43926401853, 22433.0, 8368.623411946477, 8546.487210767375, 8712.956435217784, 8789.033206347296, 8793.736187914374, 4362.454693163355, 4370.431843860278, 4433.844815431445, 4449.154660614473, 4484.349769283501, 3480.825958702055, 3585.3904836177912, 3591.066322756102, 3592.1019745063736, 3596.0, 584.2200662116038, 587.8354060862965, 590.8700085981163, 592.7925226170805, 609.5611159964818, 481.54734549523334, 529.3330403691376, 570.5920267009026, 570.6747154122111, 592.6651441935379, 8782.297416206688, 8820.294376449869, 9148.542572871464, 9429.717108486757, 9637.18083962857, 553.7729530892395, 568.778176511161, 572.2132068405942, 594.8483136800088, 604.5103466192398, 4323.6757243206885, 4357.2592659248, 4498.167838949805, 4501.527339629357, 4581.770911454414, 106026.46986765017, 125723.37138314433, 127905.0, 128874.0, 130148.3492582531, 65656.67171664111, 66368.66815665987, 79987.0, 109992.0, 112918.43540782407, 96435.0, 98334.50832745791, 100001.0, 101638.0, 101917.0, 8342.457740246864, 8572.699955501528, 8690.826183476169, 8748.978328173374, 8908.910910890809, 54818.0, 55492.72253638706, 56403.02589409351, 57455.712721436124, 58835.411645882996, 74596.25403745893, 78492.0, 78883.0, 82101.0, 83544.0, 10878.40168790724, 10891.455427228766, 11035.724106897393, 11266.887331126913, 11282.548698052315, 12403.379831008233, 12433.366017789058, 12536.122471427278, 12749.362531873554, 12790.36048197605, 11191.72020699489, 11211.0, 11354.0, 12119.091068169746, 12120.27278363301, 11617.883821162019, 11843.0, 11869.821952670543, 11964.162508624313, 12183.573574924834, 10981.725456863642, 11208.66374008781, 11285.0, 11470.483828227583, 11840.111991600492, 8841.60212790413, 9270.258379329503, 9630.181434578139, 9715.611375544899, 9785.85321220168, 8221.30118939873, 9259.76850578741, 9402.961280165844, 9745.658901938397, 9795.0], "value": 7205.120198607243, "unit": "score"}], "name": "dromaeo_css", "value": 7065.236748781673, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 112.0, 113.0, 111.0, 114.0, 114.0, 113.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 118.0, 171.0, 121.0, 119.0, 122.0, 118.0, 160.0, 117.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 160.0, 162.0, 162.0, 161.0, 164.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 99.0, 77.0, 76.0, 76.0, 76.0, 111.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 109.0, 82.0, 82.0, 82.0, 112.0, 83.0, 83.0, 116.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 49.0, 51.0, 49.0, 50.0, 52.0, 52.0, 54.0, 53.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 84.0, 78.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 139.0, 122.0, 122.0, 130.0, 121.0, 127.0, 130.0, 156.0, 122.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 166.0, 167.0, 167.0, 166.0, 163.0, 163.0, 164.0, 162.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 70.0, 64.0, 67.0, 68.0, 66.0, 65.0, 64.0, 64.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1488.6000000000001, "alertThreshold": 2.0}]} 07:04:43 INFO - Return code: 0 07:04:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:04:44 INFO - # TBPL SUCCESS # 07:04:44 INFO - Running post-action listener: _resource_record_post_action 07:04:44 INFO - [mozharness: 2016-09-24 14:04:44.022958Z] Finished run-tests step (success) 07:04:44 INFO - Running post-run listener: _resource_record_post_run 07:04:44 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 7991296; Write bytes: 420065280; Read time: 2296; Write time: 314700 07:04:44 INFO - TinderboxPrint: CPU usage
13.1% 07:04:44 INFO - TinderboxPrint: I/O read bytes / time
7,991,296 / 2,296 07:04:44 INFO - TinderboxPrint: I/O write bytes / time
420,065,280 / 314,700 07:04:44 INFO - TinderboxPrint: CPU idle
8,296.1 (86.9%) 07:04:44 INFO - TinderboxPrint: CPU user
1,202.0 (12.6%) 07:04:44 INFO - TinderboxPrint: Swap in / out
0 / 0 07:04:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 94482432; Read time: 0; Write time: 81072 07:04:44 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 5611520; Write bytes: 325582848; Read time: 1916; Write time: 233628 07:04:44 INFO - Running post-run listener: _upload_blobber_files 07:04:44 INFO - Blob upload gear active. 07:04:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:04:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:04:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:04:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:04:45 INFO - (blobuploader) - INFO - Open directory for files ... 07:04:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:04:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:04:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:50 INFO - (blobuploader) - INFO - Done attempting. 07:04:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:04:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:04:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:50 INFO - (blobuploader) - INFO - Done attempting. 07:04:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:04:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:04:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:51 INFO - (blobuploader) - INFO - Done attempting. 07:04:51 INFO - (blobuploader) - INFO - Iteration through files over. 07:04:51 INFO - Return code: 0 07:04:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:04:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:04:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/112befb12b407a1a193c52f46163db9bb091f60d4fceeae756a1d78bcce21767ca8f7e60c54e1f1261055ade32ff08ace70001f280d7341ee8d26d3272737cbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9b48537ca9520089e7b2b51dfdebc33cf4838e717f09745e753efc69c937cb479c90ba27fc0581de79c84810f0b8ccde98cc4895af235a869474a9cf363ad6c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d674f88781aa55f52f348f55d743764f8c1815e13ff4ca337909d6316a768d1598a147218a9cdb788abe4713e8b166c5e0618d6d13dbaf85632281c926f61564"} 07:04:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:04:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:04:51 INFO - Contents: 07:04:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/112befb12b407a1a193c52f46163db9bb091f60d4fceeae756a1d78bcce21767ca8f7e60c54e1f1261055ade32ff08ace70001f280d7341ee8d26d3272737cbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9b48537ca9520089e7b2b51dfdebc33cf4838e717f09745e753efc69c937cb479c90ba27fc0581de79c84810f0b8ccde98cc4895af235a869474a9cf363ad6c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d674f88781aa55f52f348f55d743764f8c1815e13ff4ca337909d6316a768d1598a147218a9cdb788abe4713e8b166c5e0618d6d13dbaf85632281c926f61564"} 07:04:51 INFO - Running post-run listener: copy_logs_to_upload_dir 07:04:51 INFO - Copying logs to upload dir... 07:04:51 INFO - mkdir: /builds/slave/test/build/upload/logs 07:04:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.646010 ========= master_lag: 167.85 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 33 secs) (at 2016-09-24 07:07:39.466418) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-09-24 07:07:39.470104) ========= 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=db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/112befb12b407a1a193c52f46163db9bb091f60d4fceeae756a1d78bcce21767ca8f7e60c54e1f1261055ade32ff08ace70001f280d7341ee8d26d3272737cbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9b48537ca9520089e7b2b51dfdebc33cf4838e717f09745e753efc69c937cb479c90ba27fc0581de79c84810f0b8ccde98cc4895af235a869474a9cf363ad6c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d674f88781aa55f52f348f55d743764f8c1815e13ff4ca337909d6316a768d1598a147218a9cdb788abe4713e8b166c5e0618d6d13dbaf85632281c926f61564"} build_url:https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/LxbphYLuTnupwhBsvcYD0A/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/Mozilla-Inbound/sha512/112befb12b407a1a193c52f46163db9bb091f60d4fceeae756a1d78bcce21767ca8f7e60c54e1f1261055ade32ff08ace70001f280d7341ee8d26d3272737cbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9b48537ca9520089e7b2b51dfdebc33cf4838e717f09745e753efc69c937cb479c90ba27fc0581de79c84810f0b8ccde98cc4895af235a869474a9cf363ad6c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d674f88781aa55f52f348f55d743764f8c1815e13ff4ca337909d6316a768d1598a147218a9cdb788abe4713e8b166c5e0618d6d13dbaf85632281c926f61564"}' ========= master_lag: 2.39 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-09-24 07:07:41.873462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-09-24 07:07:41.873850) ========= 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=db0483c52d987ecb441a263b000001ad-1474720194.417669-1376770123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 4.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-09-24 07:07:45.936803) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-24 07:07:45.937375) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-24 07:07:45.948869) ========= ========= Total master_lag: 174.36 =========