builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1479136236.47 results: success (0) buildid: 20161114021920 builduid: 34a00fa3aee34299865356c4ee83715c revision: 2d9b6132e7d75327e063a15d8e5e279077adf987 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:36.468349) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:36.468828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:36.469160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:36.485381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:36.486060) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 07:10:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-11-14 07:10:36 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088347 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:36.593178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:36.593851) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020562 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:36.645213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:36.645585) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2d9b6132e7d75327e063a15d8e5e279077adf987 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2d9b6132e7d75327e063a15d8e5e279077adf987 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 07:10:36,861 truncating revision to first 12 chars 2016-11-14 07:10:36,861 Setting DEBUG logging. 2016-11-14 07:10:36,862 attempt 1/10 2016-11-14 07:10:36,862 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2d9b6132e7d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 07:10:37,172 unpacking tar archive at: mozilla-aurora-2d9b6132e7d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:37.341912) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:37.342683) ========= script_repo_revision: 2d9b6132e7d75327e063a15d8e5e279077adf987 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:37.343601) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:37.344108) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 07:10:37.354947) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-14 07:10:37.355279) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:10:37 INFO - MultiFileLogger online at 20161114 07:10:37 in /builds/slave/test 07:10:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:10:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:10:37 INFO - {'append_to_log': False, 07:10:37 INFO - 'base_work_dir': '/builds/slave/test', 07:10:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:10:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:10:37 INFO - 'branch': 'Mozilla-Aurora', 07:10:37 INFO - 'buildbot_json_path': 'buildprops.json', 07:10:37 INFO - 'config_files': ('talos/linux_config.py',), 07:10:37 INFO - 'default_actions': ('clobber', 07:10:37 INFO - 'read-buildbot-config', 07:10:37 INFO - 'download-and-extract', 07:10:37 INFO - 'populate-webroot', 07:10:37 INFO - 'create-virtualenv', 07:10:37 INFO - 'install', 07:10:37 INFO - 'run-tests'), 07:10:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:10:37 INFO - 'download_minidump_stackwalk': True, 07:10:37 INFO - 'download_symbols': 'ondemand', 07:10:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:10:37 INFO - 'tooltool.py': '/tools/tooltool.py', 07:10:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:10:37 INFO - '/tools/misc-python/virtualenv.py')}, 07:10:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:10:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:10:37 INFO - 'installer_path': 'installer.exe', 07:10:37 INFO - 'log_level': 'info', 07:10:37 INFO - 'log_name': 'talos', 07:10:37 INFO - 'log_to_console': True, 07:10:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:10:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:10:37 INFO - 'opt_config_files': (), 07:10:37 INFO - 'pip_index': False, 07:10:37 INFO - 'sps_profile': False, 07:10:37 INFO - 'sps_profile_interval': 0, 07:10:37 INFO - 'suite': 'dromaeojs', 07:10:37 INFO - 'system_bits': '32', 07:10:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:10:37 INFO - 'title': 'talos-linux64-ix-037', 07:10:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:10:37 INFO - 'use_talos_json': True, 07:10:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:10:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:10:37 INFO - 'work_dir': 'build'} 07:10:37 INFO - [mozharness: 2016-11-14 15:10:37.667524Z] Running clobber step. 07:10:37 INFO - Running pre-action listener: _resource_record_pre_action 07:10:37 INFO - Running main action method: clobber 07:10:37 INFO - rmtree: /builds/slave/test/build 07:10:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:10:38 INFO - Running post-action listener: _resource_record_post_action 07:10:38 INFO - [mozharness: 2016-11-14 15:10:38.133135Z] Finished clobber step (success) 07:10:38 INFO - [mozharness: 2016-11-14 15:10:38.133255Z] Running read-buildbot-config step. 07:10:38 INFO - Running pre-action listener: _resource_record_pre_action 07:10:38 INFO - Running main action method: read_buildbot_config 07:10:38 INFO - Using buildbot properties: 07:10:38 INFO - { 07:10:38 INFO - "project": "", 07:10:38 INFO - "product": "firefox", 07:10:38 INFO - "script_repo_revision": "production", 07:10:38 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:10:38 INFO - "repository": "", 07:10:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:10:38 INFO - "buildid": "20161114021920", 07:10:38 INFO - "pgo_build": "True", 07:10:38 INFO - "basedir": "/builds/slave/test", 07:10:38 INFO - "buildnumber": 621, 07:10:38 INFO - "slavename": "talos-linux64-ix-037", 07:10:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:10:38 INFO - "platform": "ubuntu64_hw", 07:10:38 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:10:38 INFO - "branch": "mozilla-aurora", 07:10:38 INFO - "repo_path": "releases/mozilla-aurora", 07:10:38 INFO - "revision": "2d9b6132e7d75327e063a15d8e5e279077adf987", 07:10:38 INFO - "stage_platform": "linux64-pgo", 07:10:38 INFO - "builduid": "34a00fa3aee34299865356c4ee83715c", 07:10:38 INFO - "slavebuilddir": "test" 07:10:38 INFO - } 07:10:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 07:10:38 INFO - Running post-action listener: _resource_record_post_action 07:10:38 INFO - [mozharness: 2016-11-14 15:10:38.135703Z] Finished read-buildbot-config step (success) 07:10:38 INFO - [mozharness: 2016-11-14 15:10:38.135793Z] Running download-and-extract step. 07:10:38 INFO - Running pre-action listener: _resource_record_pre_action 07:10:38 INFO - Running main action method: download_and_extract 07:10:38 INFO - mkdir: /builds/slave/test/build/tests 07:10:38 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')]} 07:10:38 INFO - trying https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:10:38 INFO - Downloading https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:10:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:10:38 INFO - Downloaded 1361 bytes. 07:10:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:10:38 INFO - Using the following test package requirements: 07:10:38 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 07:10:38 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:10:38 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:10:38 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'jsshell-linux-x86_64.zip'], 07:10:38 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:10:38 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 07:10:38 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:10:38 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:10:38 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:10:38 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:10:38 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:10:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 07:10:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:10:38 INFO - Fetch https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:10:39 INFO - Expected file size: 21962209 07:10:43 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:10:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 07:10:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:10:43 INFO - Fetch https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:10:44 INFO - Expected file size: 21962209 07:10:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 07:10:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:10:48 INFO - Fetch https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 07:10:49 INFO - Expected file size: 14414089 07:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:49 INFO - trying https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:10:49 INFO - Downloading https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:10:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:10:51 INFO - Downloaded 64088036 bytes. 07:10:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:10:51 INFO - mkdir: /builds/slave/test/properties 07:10:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:10:51 INFO - Writing to file /builds/slave/test/properties/build_url 07:10:51 INFO - Contents: 07:10:51 INFO - build_url:https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:10:51 INFO - Running post-action listener: _resource_record_post_action 07:10:51 INFO - Running post-action listener: set_extra_try_arguments 07:10:51 INFO - [mozharness: 2016-11-14 15:10:51.716420Z] Finished download-and-extract step (success) 07:10:51 INFO - [mozharness: 2016-11-14 15:10:51.716647Z] Running populate-webroot step. 07:10:51 INFO - Running pre-action listener: _resource_record_pre_action 07:10:51 INFO - Running main action method: populate_webroot 07:10:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:10:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:10:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:10:51 INFO - '--tppagecycles', 07:10:51 INFO - '7'], 07:10:51 INFO - 'tests': ['tsvgm']}}, 07:10:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:10:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:10:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:10:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:10:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:10:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:10:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:51 INFO - 'talos_options': ['--disable-e10s'], 07:10:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:51 INFO - 'talos_options': ['--disable-e10s'], 07:10:51 INFO - 'tests': ['damp', 'tps']}, 07:10:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:51 INFO - 'tests': ['damp', 'tps']}, 07:10:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:10:51 INFO - 'tests': ['dromaeo_dom']}, 07:10:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:10:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:10:51 INFO - 'tests': ['basic_compositor_video']}, 07:10:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:10:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:10:51 INFO - 'tests': ['a11yr', 07:10:51 INFO - 'ts_paint', 07:10:51 INFO - 'tpaint', 07:10:51 INFO - 'sessionrestore', 07:10:51 INFO - 'sessionrestore_no_auto_restore', 07:10:51 INFO - 'tabpaint']}, 07:10:51 INFO - 'other-e10s': {'tests': ['a11yr', 07:10:51 INFO - 'ts_paint', 07:10:51 INFO - 'tpaint', 07:10:51 INFO - 'sessionrestore', 07:10:51 INFO - 'sessionrestore_no_auto_restore', 07:10:51 INFO - 'tabpaint']}, 07:10:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:10:51 INFO - 'ts_paint', 07:10:51 INFO - 'tpaint', 07:10:51 INFO - 'sessionrestore', 07:10:51 INFO - 'sessionrestore_no_auto_restore', 07:10:51 INFO - 'tabpaint']}, 07:10:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:10:51 INFO - 'ts_paint', 07:10:51 INFO - 'tpaint', 07:10:51 INFO - 'sessionrestore', 07:10:51 INFO - 'sessionrestore_no_auto_restore', 07:10:51 INFO - 'tabpaint']}, 07:10:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:10:51 INFO - 'tests': ['a11yr', 07:10:51 INFO - 'ts_paint', 07:10:51 INFO - 'tpaint', 07:10:51 INFO - 'sessionrestore', 07:10:51 INFO - 'sessionrestore_no_auto_restore', 07:10:51 INFO - 'tabpaint']}, 07:10:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:10:51 INFO - 'tests': ['a11yr', 07:10:51 INFO - 'ts_paint', 07:10:51 INFO - 'tpaint', 07:10:51 INFO - 'sessionrestore', 07:10:51 INFO - 'sessionrestore_no_auto_restore', 07:10:51 INFO - 'tabpaint']}, 07:10:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:10:51 INFO - 'tests': ['tsvgx', 07:10:51 INFO - 'tsvgr_opacity', 07:10:51 INFO - 'tart', 07:10:51 INFO - 'tscrollx', 07:10:51 INFO - 'cart']}, 07:10:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:10:51 INFO - 'tsvgr_opacity', 07:10:51 INFO - 'tart', 07:10:51 INFO - 'tscrollx', 07:10:51 INFO - 'cart']}, 07:10:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:51 INFO - 'talos_options': ['--disable-e10s'], 07:10:51 INFO - 'tests': ['tp5o']}, 07:10:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:51 INFO - 'tests': ['tp5o']}, 07:10:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:51 INFO - 'talos_options': ['--disable-e10s', 07:10:51 INFO - '--xperf_path', 07:10:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:51 INFO - 'tests': ['tp5n']}, 07:10:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:51 INFO - 'talos_options': ['--xperf_path', 07:10:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:51 INFO - 'tests': ['tp5n']}}, 07:10:51 INFO - 'talos.zip': {'path': '', 07:10:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:10:51 INFO - Running post-action listener: _resource_record_post_action 07:10:51 INFO - [mozharness: 2016-11-14 15:10:51.737992Z] Finished populate-webroot step (success) 07:10:51 INFO - [mozharness: 2016-11-14 15:10:51.738080Z] Running create-virtualenv step. 07:10:51 INFO - Running pre-action listener: _resource_record_pre_action 07:10:51 INFO - Running main action method: create_virtualenv 07:10:51 INFO - Creating virtualenv /builds/slave/test/build/venv 07:10:51 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 07:10:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:10:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:10:51 INFO - Using real prefix '/usr' 07:10:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:10:52 INFO - Installing distribute.............................................................................................................................................................................................done. 07:10:54 INFO - Installing pip.................done. 07:10:54 INFO - Return code: 0 07:10:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:10:54 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')]} 07:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:54 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')]} 07:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:54 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 0x7fb99600ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1df60>, '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 0x1b1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', '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 07:10:54 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 07:10:54 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 07:10:54 INFO - Using env: {'DISPLAY': ':0', 07:10:54 INFO - 'HOME': '/home/cltbld', 07:10:54 INFO - 'LANG': 'en_US.UTF-8', 07:10:54 INFO - 'LANGUAGE': 'en_US:en', 07:10:54 INFO - 'LOGNAME': 'cltbld', 07:10:54 INFO - 'MAIL': '/var/mail/cltbld', 07:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:54 INFO - 'MOZ_NO_REMOTE': '1', 07:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:54 INFO - 'NO_EM_RESTART': '1', 07:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:54 INFO - 'PWD': '/builds/slave/test', 07:10:54 INFO - 'SHELL': '/bin/bash', 07:10:54 INFO - 'SHLVL': '1', 07:10:54 INFO - 'TERM': 'linux', 07:10:54 INFO - 'TMOUT': '86400', 07:10:54 INFO - 'USER': 'cltbld', 07:10:54 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', 07:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:54 INFO - '_': '/tools/buildbot/bin/python'} 07:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:54 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 07:10:54 INFO - Cleaning up... 07:10:54 INFO - Return code: 0 07:10:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:10:54 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')]} 07:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:54 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')]} 07:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:54 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 0x7fb99600ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1df60>, '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 0x1b1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', '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 07:10:54 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 07:10:54 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 07:10:54 INFO - Using env: {'DISPLAY': ':0', 07:10:54 INFO - 'HOME': '/home/cltbld', 07:10:54 INFO - 'LANG': 'en_US.UTF-8', 07:10:54 INFO - 'LANGUAGE': 'en_US:en', 07:10:54 INFO - 'LOGNAME': 'cltbld', 07:10:54 INFO - 'MAIL': '/var/mail/cltbld', 07:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:54 INFO - 'MOZ_NO_REMOTE': '1', 07:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:54 INFO - 'NO_EM_RESTART': '1', 07:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:54 INFO - 'PWD': '/builds/slave/test', 07:10:54 INFO - 'SHELL': '/bin/bash', 07:10:54 INFO - 'SHLVL': '1', 07:10:54 INFO - 'TERM': 'linux', 07:10:54 INFO - 'TMOUT': '86400', 07:10:54 INFO - 'USER': 'cltbld', 07:10:54 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', 07:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:54 INFO - '_': '/tools/buildbot/bin/python'} 07:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:54 INFO - Downloading/unpacking psutil>=3.1.1 07:10:54 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 07:10:54 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 07:10:54 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 07:10:54 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 07:10:54 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 07:10:54 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 07:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:10:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:56 INFO - Installing collected packages: psutil 07:10:56 INFO - Running setup.py install for psutil 07:10:56 INFO - building 'psutil._psutil_linux' extension 07:10:56 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 07:10:57 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 07:10:57 INFO - building 'psutil._psutil_posix' extension 07:10:57 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 07:10:57 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 07:10:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:57 INFO - Successfully installed psutil 07:10:57 INFO - Cleaning up... 07:10:57 INFO - Return code: 0 07:10:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:10:57 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')]} 07:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:57 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')]} 07:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:57 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 0x7fb99600ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1df60>, '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 0x1b1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', '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 07:10:57 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 07:10:57 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 07:10:57 INFO - Using env: {'DISPLAY': ':0', 07:10:57 INFO - 'HOME': '/home/cltbld', 07:10:57 INFO - 'LANG': 'en_US.UTF-8', 07:10:57 INFO - 'LANGUAGE': 'en_US:en', 07:10:57 INFO - 'LOGNAME': 'cltbld', 07:10:57 INFO - 'MAIL': '/var/mail/cltbld', 07:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:57 INFO - 'MOZ_NO_REMOTE': '1', 07:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:57 INFO - 'NO_EM_RESTART': '1', 07:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:57 INFO - 'PWD': '/builds/slave/test', 07:10:57 INFO - 'SHELL': '/bin/bash', 07:10:57 INFO - 'SHLVL': '1', 07:10:57 INFO - 'TERM': 'linux', 07:10:57 INFO - 'TMOUT': '86400', 07:10:57 INFO - 'USER': 'cltbld', 07:10:57 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', 07:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:57 INFO - '_': '/tools/buildbot/bin/python'} 07:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:10:59 INFO - Installing collected packages: mozsystemmonitor 07:10:59 INFO - Running setup.py install for mozsystemmonitor 07:10:59 INFO - Successfully installed mozsystemmonitor 07:10:59 INFO - Cleaning up... 07:10:59 INFO - Return code: 0 07:10:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:10:59 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')]} 07:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:59 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')]} 07:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:59 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 0x7fb99600ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1df60>, '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 0x1b1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', '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 07:10:59 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 07:10:59 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 07:10:59 INFO - Using env: {'DISPLAY': ':0', 07:10:59 INFO - 'HOME': '/home/cltbld', 07:10:59 INFO - 'LANG': 'en_US.UTF-8', 07:10:59 INFO - 'LANGUAGE': 'en_US:en', 07:10:59 INFO - 'LOGNAME': 'cltbld', 07:10:59 INFO - 'MAIL': '/var/mail/cltbld', 07:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:59 INFO - 'MOZ_NO_REMOTE': '1', 07:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:59 INFO - 'NO_EM_RESTART': '1', 07:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:59 INFO - 'PWD': '/builds/slave/test', 07:10:59 INFO - 'SHELL': '/bin/bash', 07:10:59 INFO - 'SHLVL': '1', 07:10:59 INFO - 'TERM': 'linux', 07:10:59 INFO - 'TMOUT': '86400', 07:10:59 INFO - 'USER': 'cltbld', 07:10:59 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', 07:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:59 INFO - '_': '/tools/buildbot/bin/python'} 07:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:59 INFO - Downloading/unpacking jsonschema==2.5.1 07:10:59 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 07:10:59 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 07:10:59 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 07:10:59 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 07:10:59 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 07:10:59 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 07:11:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:11:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:11:01 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 07:11:01 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 07:11:01 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 07:11:01 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 07:11:01 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 07:11:01 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 07:11:02 INFO - Downloading functools32-3.2.3-2.tar.gz 07:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:11:02 INFO - warning: no files found matching '*.txt' 07:11:02 INFO - no previously-included directories found matching 'build' 07:11:02 INFO - no previously-included directories found matching 'dist' 07:11:02 INFO - no previously-included directories found matching '.git*' 07:11:02 INFO - Installing collected packages: jsonschema, functools32 07:11:02 INFO - Running setup.py install for functools32 07:11:02 INFO - warning: no files found matching '*.txt' 07:11:02 INFO - no previously-included directories found matching 'build' 07:11:02 INFO - no previously-included directories found matching 'dist' 07:11:02 INFO - no previously-included directories found matching '.git*' 07:11:02 INFO - Successfully installed jsonschema functools32 07:11:02 INFO - Cleaning up... 07:11:02 INFO - Return code: 0 07:11:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:02 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 0x7fb99600ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1df60>, '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 0x1b1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', '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 07:11:02 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 07:11:02 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 07:11:02 INFO - Using env: {'DISPLAY': ':0', 07:11:02 INFO - 'HOME': '/home/cltbld', 07:11:02 INFO - 'LANG': 'en_US.UTF-8', 07:11:02 INFO - 'LANGUAGE': 'en_US:en', 07:11:02 INFO - 'LOGNAME': 'cltbld', 07:11:02 INFO - 'MAIL': '/var/mail/cltbld', 07:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:02 INFO - 'MOZ_NO_REMOTE': '1', 07:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:02 INFO - 'NO_EM_RESTART': '1', 07:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:02 INFO - 'PWD': '/builds/slave/test', 07:11:02 INFO - 'SHELL': '/bin/bash', 07:11:02 INFO - 'SHLVL': '1', 07:11:02 INFO - 'TERM': 'linux', 07:11:02 INFO - 'TMOUT': '86400', 07:11:02 INFO - 'USER': 'cltbld', 07:11:02 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', 07:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:02 INFO - '_': '/tools/buildbot/bin/python'} 07:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:11:02 INFO - Cleaning up... 07:11:02 INFO - Return code: 0 07:11:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:02 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 0x7fb99600ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1df60>, '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 0x1b1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', '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 07:11:02 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 07:11:02 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 07:11:02 INFO - Using env: {'DISPLAY': ':0', 07:11:02 INFO - 'HOME': '/home/cltbld', 07:11:02 INFO - 'LANG': 'en_US.UTF-8', 07:11:02 INFO - 'LANGUAGE': 'en_US:en', 07:11:02 INFO - 'LOGNAME': 'cltbld', 07:11:02 INFO - 'MAIL': '/var/mail/cltbld', 07:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:02 INFO - 'MOZ_NO_REMOTE': '1', 07:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:02 INFO - 'NO_EM_RESTART': '1', 07:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:02 INFO - 'PWD': '/builds/slave/test', 07:11:02 INFO - 'SHELL': '/bin/bash', 07:11:02 INFO - 'SHLVL': '1', 07:11:02 INFO - 'TERM': 'linux', 07:11:02 INFO - 'TMOUT': '86400', 07:11:02 INFO - 'USER': 'cltbld', 07:11:02 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', 07:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:02 INFO - '_': '/tools/buildbot/bin/python'} 07:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:02 INFO - Downloading/unpacking blobuploader==1.2.4 07:11:02 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 07:11:02 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 07:11:02 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 07:11:02 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 07:11:02 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 07:11:02 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 07:11:04 INFO - Downloading blobuploader-1.2.4.tar.gz 07:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:11:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:11:04 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 07:11:04 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 07:11:04 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 07:11:04 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 07:11:04 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 07:11:04 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 07:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:11:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:05 INFO - Downloading docopt-0.6.1.tar.gz 07:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:11:05 INFO - Installing collected packages: blobuploader, requests, docopt 07:11:05 INFO - Running setup.py install for blobuploader 07:11:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:11:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:11:05 INFO - Running setup.py install for requests 07:11:05 INFO - Running setup.py install for docopt 07:11:05 INFO - Successfully installed blobuploader requests docopt 07:11:05 INFO - Cleaning up... 07:11:06 INFO - Return code: 0 07:11:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:06 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')]} 07:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:06 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')]} 07:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:06 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 0x7fb99600ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1df60>, '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 0x1b1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', '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 07:11:06 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 07:11:06 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 07:11:06 INFO - Using env: {'DISPLAY': ':0', 07:11:06 INFO - 'HOME': '/home/cltbld', 07:11:06 INFO - 'LANG': 'en_US.UTF-8', 07:11:06 INFO - 'LANGUAGE': 'en_US:en', 07:11:06 INFO - 'LOGNAME': 'cltbld', 07:11:06 INFO - 'MAIL': '/var/mail/cltbld', 07:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:06 INFO - 'MOZ_NO_REMOTE': '1', 07:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:06 INFO - 'NO_EM_RESTART': '1', 07:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:06 INFO - 'PWD': '/builds/slave/test', 07:11:06 INFO - 'SHELL': '/bin/bash', 07:11:06 INFO - 'SHLVL': '1', 07:11:06 INFO - 'TERM': 'linux', 07:11:06 INFO - 'TMOUT': '86400', 07:11:06 INFO - 'USER': 'cltbld', 07:11:06 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', 07:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:06 INFO - '_': '/tools/buildbot/bin/python'} 07:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:06 INFO - Running setup.py (path:/tmp/pip-SfmAXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:06 INFO - Running setup.py (path:/tmp/pip-kr2iI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:06 INFO - Running setup.py (path:/tmp/pip-KyvFaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:06 INFO - Running setup.py (path:/tmp/pip-d0N8OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:06 INFO - Running setup.py (path:/tmp/pip-yopPEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:06 INFO - Running setup.py (path:/tmp/pip-NQTXI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:06 INFO - Running setup.py (path:/tmp/pip-GoLQv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:06 INFO - Running setup.py (path:/tmp/pip-WbPkIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:06 INFO - Running setup.py (path:/tmp/pip-2jylWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:06 INFO - Running setup.py (path:/tmp/pip-YylqDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:06 INFO - Running setup.py (path:/tmp/pip-y7GGgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:07 INFO - Running setup.py (path:/tmp/pip-Fi4ZLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:07 INFO - Running setup.py (path:/tmp/pip-Q8pksX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:07 INFO - Running setup.py (path:/tmp/pip-jLLbhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:07 INFO - Running setup.py (path:/tmp/pip-HIQz_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:07 INFO - Running setup.py (path:/tmp/pip-IcAp9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:07 INFO - Running setup.py (path:/tmp/pip-gH6jh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:11:07 INFO - Running setup.py install for manifestparser 07:11:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:11:07 INFO - Running setup.py install for mozcrash 07:11:07 INFO - Running setup.py install for mozdebug 07:11:07 INFO - Running setup.py install for mozdevice 07:11:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:11:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:11:07 INFO - Running setup.py install for mozfile 07:11:07 INFO - Running setup.py install for mozhttpd 07:11:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:11:08 INFO - Running setup.py install for mozinfo 07:11:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:11:08 INFO - Running setup.py install for mozInstall 07:11:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:11:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:11:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:11:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:11:08 INFO - Running setup.py install for mozleak 07:11:08 INFO - Running setup.py install for mozlog 07:11:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:11:08 INFO - Running setup.py install for moznetwork 07:11:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:11:08 INFO - Running setup.py install for mozprocess 07:11:08 INFO - Running setup.py install for mozprofile 07:11:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:11:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:11:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:11:08 INFO - Running setup.py install for mozrunner 07:11:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:11:08 INFO - Running setup.py install for mozscreenshot 07:11:09 INFO - Running setup.py install for moztest 07:11:09 INFO - Running setup.py install for mozversion 07:11:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:11:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:11:09 INFO - Cleaning up... 07:11:09 INFO - Return code: 0 07:11:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:09 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')]} 07:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:09 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')]} 07:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:09 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 0x7fb99600ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1df60>, '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 0x1b1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', '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 07:11:09 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 07:11:09 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 07:11:09 INFO - Using env: {'DISPLAY': ':0', 07:11:09 INFO - 'HOME': '/home/cltbld', 07:11:09 INFO - 'LANG': 'en_US.UTF-8', 07:11:09 INFO - 'LANGUAGE': 'en_US:en', 07:11:09 INFO - 'LOGNAME': 'cltbld', 07:11:09 INFO - 'MAIL': '/var/mail/cltbld', 07:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:09 INFO - 'MOZ_NO_REMOTE': '1', 07:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:09 INFO - 'NO_EM_RESTART': '1', 07:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:09 INFO - 'PWD': '/builds/slave/test', 07:11:09 INFO - 'SHELL': '/bin/bash', 07:11:09 INFO - 'SHLVL': '1', 07:11:09 INFO - 'TERM': 'linux', 07:11:09 INFO - 'TMOUT': '86400', 07:11:09 INFO - 'USER': 'cltbld', 07:11:09 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', 07:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:09 INFO - '_': '/tools/buildbot/bin/python'} 07:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:09 INFO - Running setup.py (path:/tmp/pip-q7vVfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:09 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)) 07:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:09 INFO - Running setup.py (path:/tmp/pip-_sPtyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:09 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)) 07:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:09 INFO - Running setup.py (path:/tmp/pip-uH2T7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:09 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)) 07:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:09 INFO - Running setup.py (path:/tmp/pip-x48GqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:09 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)) 07:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:09 INFO - Running setup.py (path:/tmp/pip-g88CeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:09 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)) 07:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:09 INFO - Running setup.py (path:/tmp/pip-5xhMxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:09 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)) 07:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:09 INFO - Running setup.py (path:/tmp/pip-bglwS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:09 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)) 07:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:09 INFO - Running setup.py (path:/tmp/pip-Gciwgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:10 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)) 07:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:10 INFO - Running setup.py (path:/tmp/pip-Udl14I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:10 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)) 07:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:10 INFO - Running setup.py (path:/tmp/pip-trkGrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:10 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)) 07:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:10 INFO - Running setup.py (path:/tmp/pip-eDvX7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:10 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)) 07:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:10 INFO - Running setup.py (path:/tmp/pip-3aYisZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:10 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)) 07:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:10 INFO - Running setup.py (path:/tmp/pip-X_0SWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:10 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)) 07:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:10 INFO - Running setup.py (path:/tmp/pip-qqFT_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:10 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)) 07:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:10 INFO - Running setup.py (path:/tmp/pip-eTvsJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:10 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)) 07:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:10 INFO - Running setup.py (path:/tmp/pip-T6OF7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:10 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)) 07:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:10 INFO - Running setup.py (path:/tmp/pip-OCj7gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:10 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)) 07:11:10 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)) 07:11:10 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)) 07:11:10 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)) 07:11:10 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)) 07:11:10 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)) 07:11:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:12 INFO - Downloading blessings-1.6.tar.gz 07:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:11:12 INFO - Installing collected packages: blessings 07:11:12 INFO - Running setup.py install for blessings 07:11:12 INFO - Successfully installed blessings 07:11:12 INFO - Cleaning up... 07:11:12 INFO - Return code: 0 07:11:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:11:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:13 INFO - Reading from file tmpfile_stdout 07:11:13 INFO - Current package versions: 07:11:13 INFO - argparse == 1.2.1 07:11:13 INFO - blessings == 1.6 07:11:13 INFO - blobuploader == 1.2.4 07:11:13 INFO - docopt == 0.6.1 07:11:13 INFO - functools32 == 3.2.3-2 07:11:13 INFO - jsonschema == 2.5.1 07:11:13 INFO - manifestparser == 1.1 07:11:13 INFO - mozInstall == 1.12 07:11:13 INFO - mozcrash == 0.17 07:11:13 INFO - mozdebug == 0.1 07:11:13 INFO - mozdevice == 0.48 07:11:13 INFO - mozfile == 1.2 07:11:13 INFO - mozhttpd == 0.7 07:11:13 INFO - mozinfo == 0.9 07:11:13 INFO - mozleak == 0.1 07:11:13 INFO - mozlog == 3.4 07:11:13 INFO - moznetwork == 0.27 07:11:13 INFO - mozprocess == 0.23 07:11:13 INFO - mozprofile == 0.28 07:11:13 INFO - mozrunner == 6.12 07:11:13 INFO - mozscreenshot == 0.1 07:11:13 INFO - mozsystemmonitor == 0.3 07:11:13 INFO - moztest == 0.7 07:11:13 INFO - mozversion == 1.4 07:11:13 INFO - psutil == 3.1.1 07:11:13 INFO - requests == 1.2.3 07:11:13 INFO - wsgiref == 0.1.2 07:11:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:13 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 0x7fb99600ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1df60>, '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 0x1b1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', '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 07:11:13 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 07:11:13 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 07:11:13 INFO - Using env: {'DISPLAY': ':0', 07:11:13 INFO - 'HOME': '/home/cltbld', 07:11:13 INFO - 'LANG': 'en_US.UTF-8', 07:11:13 INFO - 'LANGUAGE': 'en_US:en', 07:11:13 INFO - 'LOGNAME': 'cltbld', 07:11:13 INFO - 'MAIL': '/var/mail/cltbld', 07:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:13 INFO - 'MOZ_NO_REMOTE': '1', 07:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:13 INFO - 'NO_EM_RESTART': '1', 07:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:13 INFO - 'PWD': '/builds/slave/test', 07:11:13 INFO - 'SHELL': '/bin/bash', 07:11:13 INFO - 'SHLVL': '1', 07:11:13 INFO - 'TERM': 'linux', 07:11:13 INFO - 'TMOUT': '86400', 07:11:13 INFO - 'USER': 'cltbld', 07:11:13 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', 07:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:13 INFO - '_': '/tools/buildbot/bin/python'} 07:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:13 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)) 07:11:13 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)) 07:11:13 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)) 07:11:13 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)) 07:11:13 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)) 07:11:13 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)) 07:11:13 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)) 07:11:13 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)) 07:11:13 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)) 07:11:13 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)) 07:11:13 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)) 07:11:13 INFO - Cleaning up... 07:11:13 INFO - Return code: 0 07:11:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb99600ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1df60>, '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 0x1b1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', '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 07:11:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:11:13 INFO - Using env: {'DISPLAY': ':0', 07:11:13 INFO - 'HOME': '/home/cltbld', 07:11:13 INFO - 'LANG': 'en_US.UTF-8', 07:11:13 INFO - 'LANGUAGE': 'en_US:en', 07:11:13 INFO - 'LOGNAME': 'cltbld', 07:11:13 INFO - 'MAIL': '/var/mail/cltbld', 07:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:13 INFO - 'MOZ_NO_REMOTE': '1', 07:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:13 INFO - 'NO_EM_RESTART': '1', 07:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:13 INFO - 'PWD': '/builds/slave/test', 07:11:13 INFO - 'SHELL': '/bin/bash', 07:11:13 INFO - 'SHLVL': '1', 07:11:13 INFO - 'TERM': 'linux', 07:11:13 INFO - 'TMOUT': '86400', 07:11:13 INFO - 'USER': 'cltbld', 07:11:13 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', 07:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:13 INFO - '_': '/tools/buildbot/bin/python'} 07:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:11:13 INFO - Cleaning up... 07:11:13 INFO - Return code: 0 07:11:13 INFO - Running post-action listener: _resource_record_post_action 07:11:13 INFO - Running post-action listener: _start_resource_monitoring 07:11:13 INFO - Starting resource monitoring. 07:11:13 INFO - [mozharness: 2016-11-14 15:11:13.562624Z] Finished create-virtualenv step (success) 07:11:13 INFO - [mozharness: 2016-11-14 15:11:13.563073Z] Running install step. 07:11:13 INFO - Running pre-action listener: _resource_record_pre_action 07:11:13 INFO - Running main action method: install 07:11:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:13 INFO - Reading from file tmpfile_stdout 07:11:13 INFO - Detecting whether we're running mozinstall >=1.0... 07:11:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:11:13 INFO - Reading from file tmpfile_stdout 07:11:13 INFO - Output received: 07:11:13 INFO - Usage: mozinstall [options] installer 07:11:13 INFO - Options: 07:11:13 INFO - -h, --help show this help message and exit 07:11:13 INFO - -d DEST, --destination=DEST 07:11:13 INFO - Directory to install application into. [default: 07:11:13 INFO - "/builds/slave/test"] 07:11:13 INFO - --app=APP Application being installed. [default: firefox] 07:11:13 INFO - mkdir: /builds/slave/test/build/application 07:11:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:11:29 INFO - Reading from file tmpfile_stdout 07:11:29 INFO - Output received: 07:11:29 INFO - /builds/slave/test/build/application/firefox/firefox 07:11:29 INFO - Running post-action listener: _resource_record_post_action 07:11:29 INFO - [mozharness: 2016-11-14 15:11:29.853774Z] Finished install step (success) 07:11:29 INFO - [mozharness: 2016-11-14 15:11:29.854019Z] Running run-tests step. 07:11:29 INFO - Running pre-action listener: _resource_record_pre_action 07:11:29 INFO - Running main action method: run_tests 07:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:11:29 INFO - Python 2.7.3 07:11:29 INFO - Return code: 0 07:11:29 INFO - grabbing minidump binary from tooltool 07:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:29 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 0x1b1df60>, '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 0x1b1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:11:29 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 07:11:29 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 07:11:29 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 07:11:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:11:29 INFO - Return code: 0 07:11:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:11:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:11:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:11:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:11:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 07:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 07:11:29 INFO - Using env: {'DISPLAY': ':0', 07:11:29 INFO - 'HOME': '/home/cltbld', 07:11:29 INFO - 'LANG': 'en_US.UTF-8', 07:11:29 INFO - 'LANGUAGE': 'en_US:en', 07:11:29 INFO - 'LOGNAME': 'cltbld', 07:11:29 INFO - 'MAIL': '/var/mail/cltbld', 07:11:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:11:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:29 INFO - 'MOZ_NO_REMOTE': '1', 07:11:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:29 INFO - 'NO_EM_RESTART': '1', 07:11:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:29 INFO - 'PWD': '/builds/slave/test', 07:11:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:11:29 INFO - 'SHELL': '/bin/bash', 07:11:29 INFO - 'SHLVL': '1', 07:11:29 INFO - 'TERM': 'linux', 07:11:29 INFO - 'TMOUT': '86400', 07:11:29 INFO - 'USER': 'cltbld', 07:11:29 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507', 07:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:29 INFO - '_': '/tools/buildbot/bin/python'} 07:11:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 07:11:30 INFO - mozversion application_buildid: 20161114021920 07:11:30 INFO - mozversion application_changeset: 2d9b6132e7d75327e063a15d8e5e279077adf987 07:11:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:11:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:11:30 INFO - mozversion application_name: Firefox 07:11:30 INFO - mozversion application_remotingname: firefox-dev 07:11:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:11:30 INFO - mozversion application_vendor: Mozilla 07:11:30 INFO - mozversion application_version: 51.0a2 07:11:30 INFO - mozversion platform_buildid: 20161114021920 07:11:30 INFO - mozversion platform_changeset: 2d9b6132e7d75327e063a15d8e5e279077adf987 07:11:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:11:30 INFO - mozversion platform_version: 51.0a2 07:11:30 INFO - using testdate: 1479136290 07:11:30 INFO - actual date: 1479136290 07:11:30 INFO - starting webserver on 'localhost:58620' 07:11:30 INFO - SUITE-START | Running 2 tests 07:11:30 INFO - TEST-START | dromaeo_css 07:11:30 INFO - operating with platform_type : linux_ 07:11:30 INFO - Initialising browser for dromaeo_css test... 07:11:30 INFO - TEST-INFO | started process 10233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4HC2Gf/profile http://localhost:58620/getInfo.html) 07:11:34 INFO - PROCESS | 10233 | __metrics Screen width/height:1600/1200 07:11:34 INFO - PROCESS | 10233 | colorDepth:24 07:11:34 INFO - PROCESS | 10233 | Browser inner width/height: 1024/697 07:11:34 INFO - PROCESS | 10233 | __metrics 07:11:34 INFO - PROCESS | 10233 | 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:11:34 INFO - PROCESS | 10233 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:11:35 INFO - PROCESS | 10233 | console.error: PushService: 07:11:35 INFO - PROCESS | 10233 | stateChangeProcessEnqueue: Error transitioning state 07:11:35 INFO - PROCESS | 10233 | UnknownError 07:11:35 INFO - TEST-INFO | 10233: exit 0 07:11:35 INFO - Browser initialized. 07:11:35 INFO - Running cycle 1/1 for dromaeo_css test... 07:11:35 INFO - TEST-INFO | started process 10326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4HC2Gf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:47 INFO - PROCESS | 10326 | RSS: Main: 144461824 07:11:47 INFO - PROCESS | 10326 | 07:12:38 INFO - PROCESS | 10326 | 1479136358544 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:14:47 INFO - PROCESS | 10326 | Cycle 1(1): loaded http://localhost:58620/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58620/tests/dromaeo/cssquery-ext.html) 07:14:48 INFO - PROCESS | 10326 | RSS: Main: 237441024 07:14:48 INFO - PROCESS | 10326 | 07:17:51 INFO - PROCESS | 10326 | Cycle 1(1): loaded http://localhost:58620/tests/dromaeo/cssquery-ext.html (next: http://localhost:58620/tests/dromaeo/cssquery-jquery.html) 07:17:51 INFO - PROCESS | 10326 | RSS: Main: 234414080 07:17:51 INFO - PROCESS | 10326 | 07:20:53 INFO - PROCESS | 10326 | Cycle 1(1): loaded http://localhost:58620/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58620/tests/dromaeo/cssquery-mootools.html) 07:20:54 INFO - PROCESS | 10326 | RSS: Main: 173207552 07:20:54 INFO - PROCESS | 10326 | 07:23:56 INFO - PROCESS | 10326 | Cycle 1(1): loaded http://localhost:58620/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58620/tests/dromaeo/cssquery-prototype.html) 07:23:56 INFO - PROCESS | 10326 | RSS: Main: 218632192 07:23:56 INFO - PROCESS | 10326 | 07:26:59 INFO - PROCESS | 10326 | Cycle 1(1): loaded http://localhost:58620/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58620/tests/dromaeo/cssquery-yui.html) 07:26:59 INFO - PROCESS | 10326 | RSS: Main: 174665728 07:26:59 INFO - PROCESS | 10326 | 07:30:02 INFO - PROCESS | 10326 | Cycle 1(1): loaded http://localhost:58620/tests/dromaeo/cssquery-yui.html (next: http://localhost:58620/tests/dromaeo/cssquery-dojo.html) 07:30:02 INFO - PROCESS | 10326 | RSS: Main: 261562368 07:30:02 INFO - PROCESS | 10326 | 07:30:02 INFO - PROCESS | 10326 | __start_tp_report 07:30:02 INFO - PROCESS | 10326 | _x_x_mozilla_page_load 07:30:02 INFO - PROCESS | 10326 | _x_x_mozilla_page_load_details 07:30:02 INFO - PROCESS | 10326 | |i|pagename|runs| 07:30:02 INFO - PROCESS | 10326 | |0;dojo.html;3109.782315237933;3144.2296637323857;3154.7476201903864;3172.254520187754;3190.6330771961216;5507.80722674706;5515.7242137893045;5540.2243685884005;5558.027345214591;5560.555155587548;5615.045442274813;5637.3517045539775;5684.403137670537;5689.118186681071;5701.714914254281;5108.361454818148;5128.205128205115;5141.794328226885;5189.896202075956;5199.454057323965;4974.37820272466;5141.794328226866;5198.064348417283;5203.271541984125;5205.479452054783;4951.925721114186;5053.519915608012;5071.771770270347;5091.083604951107;5106.821261255838;5131.512506311913;5161.200013997836;5168.043911876315;5223.503767142115;5228.816991405282;5081.72050537224;5128.948710512885;5189.273501709726;5204.219367094928;5230.398504172031;5408.080626293539;5460.6177567570285;5474.151506516497;5571.913476872011;5669.518090962273;5952.077427998667;6014.428629280212;6033.969830150865;6042.546808989343;6045;6067.544934129958;6076.848078798065;6077.392260773931;6089.847753806191;6090.056041313604;5318.707471089088;5356.330458692663;5498.1752737089355;5508.669479831143;5550.139728342114;6090.6041107328765;6095.817125486243;6096.390360963868;6100;6109.419605137505;5853.356130825606;5853.590248682552;5854.151148083504;5854.2096816930025;5858.619189752652;5833.183354330397;5852.707364631751;5888.411158884077;5905.881882362329;5916.053431450947;5961.910571341434;5963.612365196248;5964.463198312173;5984.73068711909;6005.489533389711;5935.436133567304;5939.22790037301;5997.0404735242155;6002.759889604455;6020.217371741734;4501.977490112528;4545.340925565841;4548.590626843534;4638.79125439356;4640.048789998043;4055.0673345130785;4098.549159592442;4101.692373072032;4122.196171746541;4129.463169787969;5670.262865827416;5680.829575112753;5681.233033540502;5681.289838770153;5683.090705487102;5908.409159084057;5973.671448070311;5979.521638268928;6004.969975150097;6008.609440386361;5673.00722373583;5676.4323567642905;5693.743781529841;5698.800541981093;5735.426457354231;5127.051495473349;5132.769025393866;5133.743312834344;5142.04872098663;5164.793408263702;6242.719077641517;6269.435750782452;6297.086922396135;6303.905441418382;6306.243250809932;5874.823755287348;5937.970310148422;6040.335563087969;6093.573449858467;6136.29432615255;6146.477549408351;6231.096491008869;6251.374862513712;6257.56197066201;6258.843528911813;5961.076033214858;5964.761409543569;5965.689814007848;5969.791057312973;6000.21997140369;5812.070068789142;5882.941170588239;5922.2597175353085;6001.219841420588;6061.272647282354;5823.679697616672;5912.704364781658;5914.083317085859;5951.761929522944;5952.434518720715;5875.911861321998;5881.206037185097;5884.6469211847425;5888.558358123072;5888.793892213752;5529.30883639545;5531.032069387921;5801.042827933344;5835.6790376528;5849.532037436909;5929.16991621182;5938.257717785277;5989.071693887455;6023.608465449732;6032.819015429544;5849;5850.531957443309;5858.794942177004;5860.208871802252;5866.2960444746905 07:30:02 INFO - PROCESS | 10326 | |1;ext.html;592.1946153231607;626.6522080245462;630.8044506203078;646.1922596754055;651.1535004494158;36207.4568881467;39866.2026759465;39883.80058099713;39912;48639.51360486394;49521.752391238086;49901.75049124749;49994.50005499944;50058.749706251416;50169;9422.246220302359;9590.616375344978;9634;9645.95177024114;9648.372855764354;8494.40539162259;8661.69684061058;9470.479123648196;9580.760480987996;11175.161862860277;11126.165537584673;11202.439878006107;11207;11211.719707007349;11249.437528123603;11090.168237382228;11104.44477776112;11124.054455371303;11134.777304453906;11142.164337674625;11165.162612803992;11247.268927519684;11247.437628118561;11248.887511124865;11259.099272058216;46162;46598.06803863904;46728.766356168344;46738.5326146741;46778.76610616959;3810.1998580298173;3824.177801772604;3832.2910261601414;3890.708196885245;4231.1749208904275;35326.11684707903;35344.82327588371;35730.28539429223;37180.442293365624;37306.44040339397;4742.668013239075;4763.285507173917;4805.20714082176;4894.4371397289415;4999.700017998932;374234;376914;378601;378622;379069;41527.37708934368;42166.367504487454;43268.350974735404;67315;67819;42139;42615.57384426178;42628.78685606552;42712.35931461031;42750;15762.527124186292;15798.131102789228;15800.36798528046;15800.36798528069;15805;14952.177630230224;15022.624434389229;15024.924875375553;15027.774583381259;15028.924855375653;9108.499032553273;9387;9433.433993960385;9825.410475371358;9853.359531630422;3669.3578623741273;3726.8509259629855;3744.1388480649603;3798.525184351956;3800.847966081381;1099.5601759296346;1109.567268765166;1114.9832752508719;1121.5794077221042;1177.0230708511915;34839.65160348415;34892.65107348945;34971.125721856646;35210.64789352125;35334.64665353365;1166.1720178673238;1196;1202.8015377462796;1239.5599562155485;1256.9308688022247;17954;18071.72892406615;18163.273469061354;18182.818171818377;18203.726944095848;516862;518149;521842;521994;522474;64197.67901160558;64458.355416446175;64526;64684.67657661682;64742;1412;1443.3577058208996;1470.5808844479486;1478.911265324084;1481.2889812889873;32309;33660.66339336673;33714.831425843695;33935.36074181755;34296.65703343035;57502.7124864373;57882.421175787706;57886;57920.71039644775;57930;456795;460073;460106;460171;460839;27730.445391092468;29613;30043.549346760254;32788.180295492806;33190.834045829615;49208.26187607117;52298;52412;53052.20421693601;53124.73437632787;44310.55689443064;44489;44505.10989780251;44701.55298447104;46331.073378532914;44410.555894440644;44837.10325793531;45664.54335456603;46202.306965396216;46349.30476042795;45400.77299613481;45794;46044.92797824039;47120.528794711616;47177.764111179225;39380.40929386119;40016.59983400245;40561.59438405696;40917.59082409138;41473.1705365885;29549.55675664824;30026.549601755552;30127.849360753054;30270;30667.2333191672 07:30:02 INFO - PROCESS | 10326 | |2;jquery.html;402.4565790194604;435.1427687455713;439.15462734236587;443.86462129050625;448.5581702023507;18011.639767204666;21021;21059.68410473844;21099.894500527495;21539.67690484644;20109.899450502726;20728.963551822388;20739.170433182655;20752.377428677126;20761.065752041155;5532.6680399176075;5874.70626468677;5934.910976335358;5939.109133629969;5940.316863560681;5751.56863235257;5840.97079514604;5930.406959304079;5934.31755348134;5936.821895343125;6044.365341639131;6070.089486577004;6087.2086628738425;6094.299155597097;6105.755769769204;6090.817275481721;6096.390360963913;6175.536834737412;6630.801075967729;6667.566608170453;6041.24484439445;6045.909311360333;6046.455818976269;6050.45545900871;6051.546134039964;18337.724934126;22389.44026399337;22835.20076797304;23032.65451018236;23087.307380778602;2337.777911098443;2471.5798314286612;2655.721149279317;2785.7075007124367;3021.8337991410463;10163;10237.69286921386;10263.589456421734;10295.3822770634;10474.895251047468;2014.0332640332722;2039.2352867674622;2047.8566500344982;2055.5888822235465;2077.7610574783944;79700;84873.57563212207;85650.57174714148;86236.56881715613;86488.5675571618;11548.364839933884;11572.132090093108;11923.582674606347;11957.940210299066;12248.877511224951;17031.574210644834;17054.829451705573;17079.31682732677;17092.658146837242;17100.65798684044;8759.518226497476;8849.247813935888;8860.246879015356;8933.821323573493;9049.502277374808;8278.544680042656;8296.83406331882;8326.583670816435;8517.233448989497;8523.48859068458;4750.501197374295;4904.926426103611;4933.605311575137;5065.164247899129;5167.741612919339;1882.4258601126787;1914.4250982428612;2100.5213847659907;2142.7256306012705;2177.2162021672184;912.5300470257822;1008.3798463944621;1009.3705896140449;1045.8012977534397;1143.8798926112804;18747.802488944202;19502.219911203676;19612.411627651192;19713.605727885362;19985;1047.188428967541;1087.2335003822286;1120.5125770289949;1134.6482590397004;1178.9528418863322;10832.593538347992;10982.176336774774;10984.670459886216;11008;11210.43947802623;406171;411034;411323;412450;415731;53727;72604;88405.55797220973;89595.10404895998;90714.09285907056;1056.3450660590483;1058.5448257249302;1064.1965316186229;1067.199600299775;1068.6580294305747;16884.493465196065;17171.141442928052;17448.47654570365;17567.736483952496;17646.823531765032;30617.387652246383;41404.58595414007;43498;45932.7703361481;46201.537984619725;60023.39976600178;60165.39834601598;60395.69802150961;61468.692656536434;61731.691341543;6412.6793660317735;9160.358774885693;9270.953645231732;9353.158215760614;9419.952900235729;12277.263364198177;14139.151650900978;14150.221737804519;14171.929140354232;14179.787303190255;8313.750587482386;11687.415629218334;11700.531978720755;11825.40872956366;12171.817422738843;11554.42227888619;11611;11894;12024;12457.439415226518;6419.903701444388;9411.905880941104;11283.548658053585;12559.497620095093;12673.30296833683;9089.227415669742;9178.770530736785;9426.057394260519;9428.811423771624;9476.431414115175;10947.781044378908;11949.76100478003;12213.145079844326;12354.752904941672;12580.748385032432 07:30:02 INFO - PROCESS | 10326 | |3;mootools.html;1470.7867359232907;1531.8161820581531;1640.4422496351237;1751.7109676903312;1765.4703588923328;8093.757187284384;8728.389012769108;8734.737957861267;8735.082816304292;8747.562621868912;7194.316539928698;7457.515261507998;8106.91893081069;8357.20606542379;8367.539785311805;2402.3153401280683;2427.053449154831;2432.063655492639;2433.488967316857;2435.7198922124007;2043.4891277180704;2392.222527678503;2413.058907026252;2424.2242482405636;2424.9393765155837;2134.658454647257;2365.526894621074;2427.2475532584867;2430.914917977871;2441.182203961666;2348.201611452106;2354.576176288276;2363.420961864346;2369.9881500592387;2403.531311394279;2279.840411171219;2282.315305408371;2287.8103386239227;2288.61093614086;2289.072925465189;8536.487810731314;8568.10034946334;8568.957155214246;8628.180322869317;8631.913680863174;5270.39390470097;5393.568514518829;5402.540784033362;5404.83785486436;5412.323459567554;3270.9836450817834;3380.8478618462227;3445.879394221215;3447.4484082546674;3470.0977745786026;1136.7044568412273;1151.441550847838;1166.7374840660868;1198.5385626533848;1223.174357308822;11451.370174640391;11491.138164637685;11496.540138394454;11512.424378781112;11557.53769849205;4504.774761261924;4687.601553867891;4791.089692958327;4820.30105634681;4855.927161092586;9822.754431139136;9834.950825245827;9837.852432213522;9846.950765246127;9847.606095756233;5298.417174110845;5307.336582927134;5321.388040375329;5324.840254792362;5335;4904.8773780655765;4944.629152813553;4963.6277279204205;4964.404271487445;5010.599152067826;3828.885133446001;3833.463315135883;3890.358090915024;3892.5328960524917;3976.562578116405;1096.7696783675358;1103.6082190822303;1149.4597539156582;1168.8363629091934;1180.8464899563173;880.3705350674298;987.6839411388287;1042.7966546523508;1044.1229367331478;1064.122099268107;5848.327442344185;6010.879782404415;6022.09668549721;6050.092486127116;6079;553.518438958101;553.5239693863274;572.513363640902;572.8711040016046;698.9825254368579;4056.371262454324;4255.127698821734;4281.785910704452;4338.58783415575;4389.714668546534;10137.239707021856;10405.791884162274;10480.056794888344;10490.265681402228;10492.947535262427;9951.303408761318;10362.585496580203;10450.843237351446;10454.843177352346;10456.52945617449;7903.486273392211;8049.51702897828;8082.9191708083345;8088.878666820003;8091.312238459797;5832.970835145967;5932.228810254639;5975.850603734768;6036.267491456971;6284.874302514016;8948.149925757043;9304.511278195456;9321.906780932104;9357.953210233905;9385.38994965325;9676.70969870905;9682.951585242028;9685.806283874424;9695.418274903528;9697.854532181882;7713.691452341844;7803.804904877424;7805.765827025199;7806.102298235775;7814.882776758467;8173;8197.262246397853;8208.09710931785;8273.214044665747;8275.172482751677;6592.510859948777;7472.925270747223;7560.886586701094;7607.88588171189;7620.771376858703;7526;7598.506097103671;7615.048118985127;7647.464677472523;7650.158482567024;6687.565308254948;6788;6861.1080559526945;6987.860242795217;6995.580265184105;5108.208227724708;5115.079285728604;5218.321618189611;5226.738663066907;5300.681959082467;5123.5644970177955;5130.871728206825;5293.153095504701;5295.232191332312;5390.353157621111 07:30:02 INFO - PROCESS | 10326 | |4;prototype.html;361.19273423897585;363.3205904957729;369.6691461142277;377.4432711750169;378.92800367930107;5231.24146998685;5424;5433.565314774818;5476.698781567012;5492.176173573961;5262.842114736564;5371.113766228567;5378.677279363241;5391.56867450604;5425.240466334716;4348.695591308609;4356.8257269709175;4357.7385356878685;4361.473484280492;4364.388985542027;4214.524916279308;4271.466066741657;4295.26980413329;4343.9348409773875;4351.847685331014;4249.298865687158;4264.147170565884;4266.189424009443;4266.402703621496;4273.508546517143;4236.809343579531;4249.490061192677;4256.404103425508;4267.871963841089;4292.806823692941;3642.9253370255838;3781.4138808484727;3793.696504279651;3799.0502374406396;3835.5780864104927;5307.28351672527;5338.199270109515;5341.412444631087;5341.691285635045;5354.678719276817;4923.606111511106;4932.186189278765;4944.110060189165;4948.604111671058;4949.975250123763;5586.776528938837;5652.349979752299;5684.8010319639025;5687;5689.330381903649;4156.397322388237;4174.5616710245295;4183.4979802423595;4188.727732697395;4191.140816132685;5867.559933005042;5907.734151963215;5943.4056594340655;5950.8809823803285;5958.314793798725;4053.9391909121387;4253.723507971972;4285.207236661166;4307.815350778561;4308.978455107767;4349.934266104825;4352.542982986804;4354.847580334673;4355.976345558791;4362.323839804835;4910.6808057476865;4917.213245880642;4921.163402221631;4923.679960802537;4929.211326187865;5519.2824932758485;5739.311282646109;5769.941930776695;5786.152208781114;5801.462612407715;1413.3074793351184;1443.8844892408792;1449.412987739946;1480.940762369493;1487.516557118919;1003.2826529031777;1007.9143272821892;1031.118393773328;1043.2436483549518;1047.219821233171;5557.916631250535;5559.722013899289;5567.387587365387;5570.610057296031;5578.414266501959;5788.913166302509;5833.541614596351;5855;5856.648601083949;5887.791153821177;5342.679439233659;5557.305336832896;5570.301058177214;5651.4348565143155;5679.801206957736;3144.701253380925;3161.3361194149024;3167.8099314041233;3168.207948012997;3169.7781155319367;5763.8559036024435;6086.786962456293;6107.908381374283;6111.54163437744;6116.877662446726;6030.276366836008;6050.273967123885;6068.9696551517845;6077.450250186174;6084.969575152096;6076.513878889767;6079.452849243589;6101.60339577926;6123.418275263843;6124.724387402578;5684.658920464785;5921.904447677193;5923.437273459014;5973.283206015306;5981.743833794952;5867.970660146672;5872.354041055395;5879.353271140086;5880.500157486662;5892.882142357043;5779.624324418899;6065.120557519223;6074.149619053248;6076.966915624266;6088.908666369919;4280.636145927631;4307.8276868924895;4312.7627980461375;4325.372820940883;4336.3278691802825;5634.211210430625;5816.651000939957;5976.282846058501;5982.192404025401;5983.730732117152;5626.549876009991;5654.180143879197;5662.915056274077;5751.884962300647;5810.360860305447;5726.914096288642;5792.623479473821;5802;5802.114312848257;5803.274590676166;5560.19377190297;5717.142428635738;5721.885562288648;5734.770609175586;5751.913721294268;5763.567732420001;5824.970875145597;5829.067349224104;5847.707614619167;5853.682921342835;5404.756905911584;5680.460356266148;5689.914651280317;5696.487316141567;5711.200431939615 07:30:02 INFO - PROCESS | 10326 | |5;yui.html;757.4886951307866;804.4489524675598;805.0701439836987;849.1254008371378;890.4301247201796;14741.262936853169;15167.241637918116;15243.84756152438;15318.923405382971;15319.234038298096;16265.593360166002;16506.25721842517;16507.91746041271;16513.256903439345;16628;726.4007194064891;746.3208480282943;861.3970220845433;873.4017198219209;890.9376343655947;882.9117088291184;886.6674996876171;886.6852267445029;886.685226744506;888.6711916590871;942.2791564453199;942.8727121838533;943.6555657185147;943.7687766497183;944.0323668240075;763.8472305538887;782.0459039971227;909.3498148823556;924.8381533231658;947.114447991127;691.6438034412282;691.9930800691978;692.0484334040694;692.3457332820486;692.6363659078974;15610.141442220673;15626.687466250725;15654.295556699975;15673.059616423052;15678.294476748573;14731.484398046125;14993;15013.024153430102;15050.774238386433;15268.083914965138;13241.933790330986;13659.112157709817;13724.45102195911;13734.45062197511;13854.515091971733;4254.553271906436;4288.270993931039;4306.784660766981;4330.870073897788;4374.956250437487;67771.66114169447;69328;69880;70979.64510177467;80864.19135808684;12403.069769767304;13283.734325313633;13672.794908076386;13782.862171378158;13854.86145138556;25450;25539.36151596225;26021.869890650425;26096.8695156523;26107.608385874228;9390.248780097576;9407.388519746195;9410.106039926197;9594.952025239829;9766.07222313879;5088.287639730441;5111.488851114858;5115.130427827278;5247.239150323258;5376.623636345496;3555.1112221944513;3679.7240206984584;3682.429223470366;3705.2404257127764;3707.4624179494363;622.9813105606839;625.6121204853021;633.5944995203074;639.3191251317332;645.9321771214048;671.2482020137477;751.1999720297865;776.4875182379602;780.3445106110894;820.6717313074818;10036.598536058476;10528.152339173907;10556.788864222826;10652.573897044187;10817.83773243402;656.4420242793683;770.2297702297702;779.9766007019798;780.2626517940605;780.6565111350988;4977.726225057584;5115.130427827278;5155.717616115775;5165.635058182718;5281.683099013994;75518.62240688762;75848;76235;102255;126172;111405;113839.43080284711;114629;116469.41765291289;117574;60933.390666092775;63469;81830.59084704658;91720.54139729259;102742.97257027484;9397.295202859676;9517.048295170427;9602.375845570015;9643.421394716339;9682.273829462678;53750.118745843705;55311.44688553063;55729.442705574045;56966;57612.71193644005;75763.62118189374;80573.19426805657;82459.17540824755;83938.16061839303;85091;13098.083134180515;13643.454261829416;13646.113002655193;13888.722225555635;14290.35693393779;14265.786013209603;14473.92763036178;15919.522414327588;15959.920200398923;15966.28151733198;13594.728105438033;13654.795178072536;14176.149431034171;14259.215743134228;14312.212828294543;14059.156450612996;14089.506867259597;14225.14649121056;14314;14884.330205140577;13955.790663140264;14298.57104286873;14453;14726.190059546827;14742.336594853472;12106.697332566757;12198.390080496118;12929.418176182282;12987.740245195233;13187.868121318665;11915.2255103418;12875;13061;13230.933845330712;13324.333783310602 07:30:02 INFO - PROCESS | 10326 | __end_tp_report 07:30:02 INFO - PROCESS | 10326 | __start_cc_report 07:30:02 INFO - PROCESS | 10326 | _x_x_mozilla_cycle_collect,800 07:30:02 INFO - PROCESS | 10326 | __end_cc_report 07:30:02 INFO - PROCESS | 10326 | __startTimestamp1479137402704__endTimestamp 07:30:02 INFO - PROCESS | 10326 | 07:30:02 INFO - PROCESS | 10326 | ------- Summary: start ------- 07:30:02 INFO - PROCESS | 10326 | Number of tests: 6 07:30:02 INFO - PROCESS | 10326 | 07:30:02 INFO - PROCESS | 10326 | [#0] dojo.html Cycles:165 Average:5571.38 Median:5849.00 stddev:643.56 (11.0%) stddev-sans-first:615.88 07:30:02 INFO - PROCESS | 10326 | Values: 3109.8 3144.2 3154.7 3172.3 3190.6 5507.8 5515.7 5540.2 5558.0 5560.6 5615.0 5637.4 5684.4 5689.1 5701.7 5108.4 5128.2 5141.8 5189.9 5199.5 4974.4 5141.8 5198.1 5203.3 5205.5 4951.9 5053.5 5071.8 5091.1 5106.8 5131.5 5161.2 5168.0 5223.5 5228.8 5081.7 5128.9 5189.3 5204.2 5230.4 5408.1 5460.6 5474.2 5571.9 5669.5 5952.1 6014.4 6034.0 6042.5 6045.0 6067.5 6076.8 6077.4 6089.8 6090.1 5318.7 5356.3 5498.2 5508.7 5550.1 6090.6 6095.8 6096.4 6100.0 6109.4 5853.4 5853.6 5854.2 5854.2 5858.6 5833.2 5852.7 5888.4 5905.9 5916.1 5961.9 5963.6 5964.5 5984.7 6005.5 5935.4 5939.2 5997.0 6002.8 6020.2 4502.0 4545.3 4548.6 4638.8 4640.0 4055.1 4098.5 4101.7 4122.2 4129.5 5670.3 5680.8 5681.2 5681.3 5683.1 5908.4 5973.7 5979.5 6005.0 6008.6 5673.0 5676.4 5693.7 5698.8 5735.4 5127.1 5132.8 5133.7 5142.0 5164.8 6242.7 6269.4 6297.1 6303.9 6306.2 5874.8 5938.0 6040.3 6093.6 6136.3 6146.5 6231.1 6251.4 6257.6 6258.8 5961.1 5964.8 5965.7 5969.8 6000.2 5812.1 5882.9 5922.3 6001.2 6061.3 5823.7 5912.7 5914.1 5951.8 5952.4 5875.9 5881.2 5884.6 5888.6 5888.8 5529.3 5531.0 5801.0 5835.7 5849.5 5929.2 5938.3 5989.1 6023.6 6032.8 5849.0 5850.5 5858.8 5860.2 5866.3 07:30:02 INFO - PROCESS | 10326 | 07:30:02 INFO - PROCESS | 10326 | [#1] ext.html Cycles:180 Average:62079.80 Median:40289.10 stddev:120734.50 (299.7%) stddev-sans-first:120984.93 07:30:02 INFO - PROCESS | 10326 | Values: 592.2 626.7 630.8 646.2 651.2 36207.5 39866.2 39883.8 39912.0 48639.5 49521.8 49901.8 49994.5 50058.7 50169.0 9422.2 9590.6 9634.0 9646.0 9648.4 8494.4 8661.7 9470.5 9580.8 11175.2 11126.2 11202.4 11207.0 11211.7 11249.4 11090.2 11104.4 11124.1 11134.8 11142.2 11165.2 11247.3 11247.4 11248.9 11259.1 46162.0 46598.1 46728.8 46738.5 46778.8 3810.2 3824.2 3832.3 3890.7 4231.2 35326.1 35344.8 35730.3 37180.4 37306.4 4742.7 4763.3 4805.2 4894.4 4999.7 374234.0 376914.0 378601.0 378622.0 379069.0 41527.4 42166.4 43268.4 67315.0 67819.0 42139.0 42615.6 42628.8 42712.4 42750.0 15762.5 15798.1 15800.4 15800.4 15805.0 14952.2 15022.6 15024.9 15027.8 15028.9 9108.5 9387.0 9433.4 9825.4 9853.4 3669.4 3726.9 3744.1 3798.5 3800.8 1099.6 1109.6 1115.0 1121.6 1177.0 34839.7 34892.7 34971.1 35210.6 35334.6 1166.2 1196.0 1202.8 1239.6 1256.9 17954.0 18071.7 18163.3 18182.8 18203.7 516862.0 518149.0 521842.0 521994.0 522474.0 64197.7 64458.4 64526.0 64684.7 64742.0 1412.0 1443.4 1470.6 1478.9 1481.3 32309.0 33660.7 33714.8 33935.4 34296.7 57502.7 57882.4 57886.0 57920.7 57930.0 456795.0 460073.0 460106.0 460171.0 460839.0 27730.4 29613.0 30043.5 32788.2 33190.8 49208.3 52298.0 52412.0 53052.2 53124.7 44310.6 44489.0 44505.1 44701.6 46331.1 44410.6 44837.1 45664.5 46202.3 46349.3 45400.8 45794.0 46044.9 47120.5 47177.8 39380.4 40016.6 40561.6 40917.6 41473.2 29549.6 30026.5 30127.8 30270.0 30667.2 07:30:02 INFO - PROCESS | 10326 | 07:30:02 INFO - PROCESS | 10326 | [#2] jquery.html Cycles:180 Average:26876.60 Median:12712.54 stddev:68134.86 (536.0%) stddev-sans-first:68297.00 07:30:02 INFO - PROCESS | 10326 | Values: 402.5 435.1 439.2 443.9 448.6 18011.6 21021.0 21059.7 21099.9 21539.7 20109.9 20729.0 20739.2 20752.4 20761.1 5532.7 5874.7 5934.9 5939.1 5940.3 5751.6 5841.0 5930.4 5934.3 5936.8 6044.4 6070.1 6087.2 6094.3 6105.8 6090.8 6096.4 6175.5 6630.8 6667.6 6041.2 6045.9 6046.5 6050.5 6051.5 18337.7 22389.4 22835.2 23032.7 23087.3 2337.8 2471.6 2655.7 2785.7 3021.8 10163.0 10237.7 10263.6 10295.4 10474.9 2014.0 2039.2 2047.9 2055.6 2077.8 79700.0 84873.6 85650.6 86236.6 86488.6 11548.4 11572.1 11923.6 11957.9 12248.9 17031.6 17054.8 17079.3 17092.7 17100.7 8759.5 8849.2 8860.2 8933.8 9049.5 8278.5 8296.8 8326.6 8517.2 8523.5 4750.5 4904.9 4933.6 5065.2 5167.7 1882.4 1914.4 2100.5 2142.7 2177.2 912.5 1008.4 1009.4 1045.8 1143.9 18747.8 19502.2 19612.4 19713.6 19985.0 1047.2 1087.2 1120.5 1134.6 1179.0 10832.6 10982.2 10984.7 11008.0 11210.4 406171.0 411034.0 411323.0 412450.0 415731.0 53727.0 72604.0 88405.6 89595.1 90714.1 1056.3 1058.5 1064.2 1067.2 1068.7 16884.5 17171.1 17448.5 17567.7 17646.8 30617.4 41404.6 43498.0 45932.8 46201.5 60023.4 60165.4 60395.7 61468.7 61731.7 6412.7 9160.4 9271.0 9353.2 9420.0 12277.3 14139.2 14150.2 14171.9 14179.8 8313.8 11687.4 11700.5 11825.4 12171.8 11554.4 11611.0 11894.0 12024.0 12457.4 6419.9 9411.9 11283.5 12559.5 12673.3 9089.2 9178.8 9426.1 9428.8 9476.4 10947.8 11949.8 12213.1 12354.8 12580.7 07:30:02 INFO - PROCESS | 10326 | 07:30:02 INFO - PROCESS | 10326 | [#3] mootools.html Cycles:180 Average:5659.16 Median:5296.82 stddev:3100.65 (58.5%) stddev-sans-first:3093.37 07:30:02 INFO - PROCESS | 10326 | Values: 1470.8 1531.8 1640.4 1751.7 1765.5 8093.8 8728.4 8734.7 8735.1 8747.6 7194.3 7457.5 8106.9 8357.2 8367.5 2402.3 2427.1 2432.1 2433.5 2435.7 2043.5 2392.2 2413.1 2424.2 2424.9 2134.7 2365.5 2427.2 2430.9 2441.2 2348.2 2354.6 2363.4 2370.0 2403.5 2279.8 2282.3 2287.8 2288.6 2289.1 8536.5 8568.1 8569.0 8628.2 8631.9 5270.4 5393.6 5402.5 5404.8 5412.3 3271.0 3380.8 3445.9 3447.4 3470.1 1136.7 1151.4 1166.7 1198.5 1223.2 11451.4 11491.1 11496.5 11512.4 11557.5 4504.8 4687.6 4791.1 4820.3 4855.9 9822.8 9835.0 9837.9 9847.0 9847.6 5298.4 5307.3 5321.4 5324.8 5335.0 4904.9 4944.6 4963.6 4964.4 5010.6 3828.9 3833.5 3890.4 3892.5 3976.6 1096.8 1103.6 1149.5 1168.8 1180.8 880.4 987.7 1042.8 1044.1 1064.1 5848.3 6010.9 6022.1 6050.1 6079.0 553.5 553.5 572.5 572.9 699.0 4056.4 4255.1 4281.8 4338.6 4389.7 10137.2 10405.8 10480.1 10490.3 10492.9 9951.3 10362.6 10450.8 10454.8 10456.5 7903.5 8049.5 8082.9 8088.9 8091.3 5833.0 5932.2 5975.9 6036.3 6284.9 8948.1 9304.5 9321.9 9358.0 9385.4 9676.7 9683.0 9685.8 9695.4 9697.9 7713.7 7803.8 7805.8 7806.1 7814.9 8173.0 8197.3 8208.1 8273.2 8275.2 6592.5 7472.9 7560.9 7607.9 7620.8 7526.0 7598.5 7615.0 7647.5 7650.2 6687.6 6788.0 6861.1 6987.9 6995.6 5108.2 5115.1 5218.3 5226.7 5300.7 5123.6 5130.9 5293.2 5295.2 5390.4 07:30:02 INFO - PROCESS | 10326 | 07:30:02 INFO - PROCESS | 10326 | [#4] prototype.html Cycles:180 Average:4856.16 Median:5484.44 stddev:1411.12 (25.7%) stddev-sans-first:1374.15 07:30:02 INFO - PROCESS | 10326 | Values: 361.2 363.3 369.7 377.4 378.9 5231.2 5424.0 5433.6 5476.7 5492.2 5262.8 5371.1 5378.7 5391.6 5425.2 4348.7 4356.8 4357.7 4361.5 4364.4 4214.5 4271.5 4295.3 4343.9 4351.8 4249.3 4264.1 4266.2 4266.4 4273.5 4236.8 4249.5 4256.4 4267.9 4292.8 3642.9 3781.4 3793.7 3799.1 3835.6 5307.3 5338.2 5341.4 5341.7 5354.7 4923.6 4932.2 4944.1 4948.6 4950.0 5586.8 5652.3 5684.8 5687.0 5689.3 4156.4 4174.6 4183.5 4188.7 4191.1 5867.6 5907.7 5943.4 5950.9 5958.3 4053.9 4253.7 4285.2 4307.8 4309.0 4349.9 4352.5 4354.8 4356.0 4362.3 4910.7 4917.2 4921.2 4923.7 4929.2 5519.3 5739.3 5769.9 5786.2 5801.5 1413.3 1443.9 1449.4 1480.9 1487.5 1003.3 1007.9 1031.1 1043.2 1047.2 5557.9 5559.7 5567.4 5570.6 5578.4 5788.9 5833.5 5855.0 5856.6 5887.8 5342.7 5557.3 5570.3 5651.4 5679.8 3144.7 3161.3 3167.8 3168.2 3169.8 5763.9 6086.8 6107.9 6111.5 6116.9 6030.3 6050.3 6069.0 6077.5 6085.0 6076.5 6079.5 6101.6 6123.4 6124.7 5684.7 5921.9 5923.4 5973.3 5981.7 5868.0 5872.4 5879.4 5880.5 5892.9 5779.6 6065.1 6074.1 6077.0 6088.9 4280.6 4307.8 4312.8 4325.4 4336.3 5634.2 5816.7 5976.3 5982.2 5983.7 5626.5 5654.2 5662.9 5751.9 5810.4 5726.9 5792.6 5802.0 5802.1 5803.3 5560.2 5717.1 5721.9 5734.8 5751.9 5763.6 5825.0 5829.1 5847.7 5853.7 5404.8 5680.5 5689.9 5696.5 5711.2 07:30:02 INFO - PROCESS | 10326 | 07:30:02 INFO - PROCESS | 10326 | [#5] yui.html Cycles:180 Average:21192.84 Median:4318.83 stddev:29488.14 (682.8%) stddev-sans-first:29530.94 07:30:02 INFO - PROCESS | 10326 | Values: 757.5 804.4 805.1 849.1 890.4 14741.3 15167.2 15243.8 15318.9 15319.2 16265.6 16506.3 16507.9 16513.3 16628.0 726.4 746.3 861.4 873.4 890.9 882.9 886.7 886.7 886.7 888.7 942.3 942.9 943.7 943.8 944.0 763.8 782.0 909.3 924.8 947.1 691.6 692.0 692.0 692.3 692.6 15610.1 15626.7 15654.3 15673.1 15678.3 14731.5 14993.0 15013.0 15050.8 15268.1 13241.9 13659.1 13724.5 13734.5 13854.5 4254.6 4288.3 4306.8 4330.9 4375.0 67771.7 69328.0 69880.0 70979.6 80864.2 12403.1 13283.7 13672.8 13782.9 13854.9 25450.0 25539.4 26021.9 26096.9 26107.6 9390.2 9407.4 9410.1 9595.0 9766.1 5088.3 5111.5 5115.1 5247.2 5376.6 3555.1 3679.7 3682.4 3705.2 3707.5 623.0 625.6 633.6 639.3 645.9 671.2 751.2 776.5 780.3 820.7 10036.6 10528.2 10556.8 10652.6 10817.8 656.4 770.2 780.0 780.3 780.7 4977.7 5115.1 5155.7 5165.6 5281.7 75518.6 75848.0 76235.0 102255.0 126172.0 111405.0 113839.4 114629.0 116469.4 117574.0 60933.4 63469.0 81830.6 91720.5 102743.0 9397.3 9517.0 9602.4 9643.4 9682.3 53750.1 55311.4 55729.4 56966.0 57612.7 75763.6 80573.2 82459.2 83938.2 85091.0 13098.1 13643.5 13646.1 13888.7 14290.4 14265.8 14473.9 15919.5 15959.9 15966.3 13594.7 13654.8 14176.1 14259.2 14312.2 14059.2 14089.5 14225.1 14314.0 14884.3 13955.8 14298.6 14453.0 14726.2 14742.3 12106.7 12198.4 12929.4 12987.7 13187.9 11915.2 12875.0 13061.0 13230.9 13324.3 07:30:02 INFO - PROCESS | 10326 | -------- Summary: end -------- 07:30:02 INFO - PROCESS | 10326 | 07:30:03 INFO - TEST-INFO | 10326: exit 0 07:30:03 INFO - TEST-OK | dromaeo_css | took 1113288ms 07:30:03 INFO - TEST-START | kraken 07:30:03 INFO - operating with platform_type : linux_ 07:30:03 INFO - Initialising browser for kraken test... 07:30:03 INFO - TEST-INFO | started process 10650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprbDzCS/profile http://localhost:58620/getInfo.html) 07:30:07 INFO - PROCESS | 10650 | __metrics Screen width/height:1600/1200 07:30:07 INFO - PROCESS | 10650 | colorDepth:24 07:30:07 INFO - PROCESS | 10650 | Browser inner width/height: 1024/697 07:30:07 INFO - PROCESS | 10650 | __metrics 07:30:07 INFO - PROCESS | 10650 | 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:30:07 INFO - PROCESS | 10650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:30:08 INFO - PROCESS | 10650 | console.error: PushService: 07:30:08 INFO - PROCESS | 10650 | stateChangeProcessEnqueue: Error transitioning state 07:30:08 INFO - PROCESS | 10650 | UnknownError 07:30:08 INFO - TEST-INFO | 10650: exit 0 07:30:08 INFO - Browser initialized. 07:30:08 INFO - Running cycle 1/1 for kraken test... 07:30:08 INFO - TEST-INFO | started process 10743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprbDzCS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:20 INFO - PROCESS | 10743 | RSS: Main: 144629760 07:30:20 INFO - PROCESS | 10743 | 07:30:23 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58620/tests/kraken/driver.html?testName=audio-beat-detection) 07:30:23 INFO - PROCESS | 10743 | RSS: Main: 186191872 07:30:23 INFO - PROCESS | 10743 | 07:30:26 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58620/tests/kraken/driver.html?testName=audio-dft) 07:30:27 INFO - PROCESS | 10743 | RSS: Main: 175693824 07:30:27 INFO - PROCESS | 10743 | 07:30:29 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58620/tests/kraken/driver.html?testName=audio-fft) 07:30:30 INFO - PROCESS | 10743 | RSS: Main: 267079680 07:30:30 INFO - PROCESS | 10743 | 07:30:32 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58620/tests/kraken/driver.html?testName=audio-oscillator) 07:30:33 INFO - PROCESS | 10743 | RSS: Main: 173678592 07:30:33 INFO - PROCESS | 10743 | 07:30:35 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58620/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:30:35 INFO - PROCESS | 10743 | RSS: Main: 174772224 07:30:35 INFO - PROCESS | 10743 | 07:30:38 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58620/tests/kraken/driver.html?testName=imaging-darkroom) 07:30:39 INFO - PROCESS | 10743 | RSS: Main: 211095552 07:30:39 INFO - PROCESS | 10743 | 07:30:42 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58620/tests/kraken/driver.html?testName=imaging-desaturate) 07:30:43 INFO - PROCESS | 10743 | RSS: Main: 210157568 07:30:43 INFO - PROCESS | 10743 | 07:30:45 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58620/tests/kraken/driver.html?testName=json-parse-financial) 07:30:46 INFO - PROCESS | 10743 | RSS: Main: 209891328 07:30:46 INFO - PROCESS | 10743 | 07:30:48 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58620/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:30:48 INFO - PROCESS | 10743 | RSS: Main: 171053056 07:30:48 INFO - PROCESS | 10743 | 07:30:50 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58620/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:30:50 INFO - PROCESS | 10743 | RSS: Main: 179982336 07:30:50 INFO - PROCESS | 10743 | 07:30:52 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58620/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:30:53 INFO - PROCESS | 10743 | RSS: Main: 188866560 07:30:53 INFO - PROCESS | 10743 | 07:30:56 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:30:56 INFO - PROCESS | 10743 | RSS: Main: 197713920 07:30:56 INFO - PROCESS | 10743 | 07:30:59 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:30:59 INFO - PROCESS | 10743 | RSS: Main: 193523712 07:30:59 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | Cycle 1(1): loaded http://localhost:58620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58620/tests/kraken/driver.html?testName=ai-astar) 07:31:01 INFO - PROCESS | 10743 | RSS: Main: 244142080 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | __start_tp_report 07:31:01 INFO - PROCESS | 10743 | _x_x_mozilla_page_load 07:31:01 INFO - PROCESS | 10743 | _x_x_mozilla_page_load_details 07:31:01 INFO - PROCESS | 10743 | |i|pagename|runs| 07:31:01 INFO - PROCESS | 10743 | |0;ai-astar;110;111;111;110;111;111;111;111;110;112 07:31:01 INFO - PROCESS | 10743 | |1;audio-beat-detection;145;116;121;158;117;118;118;115;150;116 07:31:01 INFO - PROCESS | 10743 | |2;audio-dft;161;160;161;160;159;162;162;161;161;161 07:31:01 INFO - PROCESS | 10743 | |3;audio-fft;75;75;75;110;75;76;76;76;96;75 07:31:01 INFO - PROCESS | 10743 | |4;audio-oscillator;82;80;130;81;82;81;105;82;81;108 07:31:01 INFO - PROCESS | 10743 | |5;imaging-gaussian-blur;117;116;116;117;116;116;116;116;116;117 07:31:01 INFO - PROCESS | 10743 | |6;imaging-darkroom;146;147;146;146;146;148;146;146;147;147 07:31:01 INFO - PROCESS | 10743 | |7;imaging-desaturate;95;95;95;95;94;94;94;95;94;94 07:31:01 INFO - PROCESS | 10743 | |8;json-parse-financial;50;49;48;49;50;50;48;49;49;47 07:31:01 INFO - PROCESS | 10743 | |9;json-stringify-tinderbox;59;58;59;60;69;59;59;59;59;59 07:31:01 INFO - PROCESS | 10743 | |10;stanford-crypto-aes;74;73;73;73;73;78;72;73;72;73 07:31:01 INFO - PROCESS | 10743 | |11;stanford-crypto-ccm;125;123;123;130;121;122;120;130;159;121 07:31:01 INFO - PROCESS | 10743 | |12;stanford-crypto-pbkdf2;162;156;154;155;158;154;152;156;151;158 07:31:01 INFO - PROCESS | 10743 | |13;stanford-crypto-sha256-iterative;71;62;62;63;61;65;61;63;60;62 07:31:01 INFO - PROCESS | 10743 | __end_tp_report 07:31:01 INFO - PROCESS | 10743 | __start_cc_report 07:31:01 INFO - PROCESS | 10743 | _x_x_mozilla_cycle_collect,1601 07:31:01 INFO - PROCESS | 10743 | __end_cc_report 07:31:01 INFO - PROCESS | 10743 | __startTimestamp1479137461870__endTimestamp 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | ------- Summary: start ------- 07:31:01 INFO - PROCESS | 10743 | Number of tests: 14 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 07:31:01 INFO - PROCESS | 10743 | Values: 110.0 111.0 111.0 110.0 111.0 111.0 111.0 111.0 110.0 112.0 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:119.50 stddev:16.65 (13.9%) stddev-sans-first:16.40 07:31:01 INFO - PROCESS | 10743 | Values: 145.0 116.0 121.0 158.0 117.0 118.0 118.0 115.0 150.0 116.0 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 07:31:01 INFO - PROCESS | 10743 | Values: 161.0 160.0 161.0 160.0 159.0 162.0 162.0 161.0 161.0 161.0 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.50 stddev:12.11 (16.0%) stddev-sans-first:12.66 07:31:01 INFO - PROCESS | 10743 | Values: 75.0 75.0 75.0 110.0 75.0 76.0 76.0 76.0 96.0 75.0 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:81.00 stddev:17.22 (21.3%) stddev-sans-first:17.94 07:31:01 INFO - PROCESS | 10743 | Values: 82.0 80.0 130.0 81.0 82.0 81.0 105.0 82.0 81.0 108.0 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 07:31:01 INFO - PROCESS | 10743 | Values: 117.0 116.0 116.0 117.0 116.0 116.0 116.0 116.0 116.0 117.0 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:31:01 INFO - PROCESS | 10743 | Values: 146.0 147.0 146.0 146.0 146.0 148.0 146.0 146.0 147.0 147.0 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 07:31:01 INFO - PROCESS | 10743 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#8] json-parse-financial Cycles:10 Average:48.90 Median:49.00 stddev:0.99 (2.0%) stddev-sans-first:0.97 07:31:01 INFO - PROCESS | 10743 | Values: 50.0 49.0 48.0 49.0 50.0 50.0 48.0 49.0 49.0 47.0 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:59.00 stddev:3.20 (5.4%) stddev-sans-first:3.37 07:31:01 INFO - PROCESS | 10743 | Values: 59.0 58.0 59.0 60.0 69.0 59.0 59.0 59.0 59.0 59.0 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#10] stanford-crypto-aes Cycles:10 Average:73.40 Median:73.00 stddev:1.71 (2.3%) stddev-sans-first:1.80 07:31:01 INFO - PROCESS | 10743 | Values: 74.0 73.0 73.0 73.0 73.0 78.0 72.0 73.0 72.0 73.0 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:124.00 stddev:11.65 (9.4%) stddev-sans-first:12.33 07:31:01 INFO - PROCESS | 10743 | Values: 125.0 123.0 123.0 130.0 121.0 122.0 120.0 130.0 159.0 121.0 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:156.00 stddev:3.20 (2.1%) stddev-sans-first:2.42 07:31:01 INFO - PROCESS | 10743 | Values: 162.0 156.0 154.0 155.0 158.0 154.0 152.0 156.0 151.0 158.0 07:31:01 INFO - PROCESS | 10743 | 07:31:01 INFO - PROCESS | 10743 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:62.50 stddev:3.13 (5.0%) stddev-sans-first:1.45 07:31:01 INFO - PROCESS | 10743 | Values: 71.0 62.0 62.0 63.0 61.0 65.0 61.0 63.0 60.0 62.0 07:31:01 INFO - PROCESS | 10743 | -------- Summary: end -------- 07:31:01 INFO - PROCESS | 10743 | 07:31:02 INFO - TEST-INFO | 10743: exit 0 07:31:02 INFO - TEST-OK | kraken | took 59448ms 07:31:02 INFO - SUITE-END | took 1172s 07:31:03 INFO - Completed test suite (00:19:32) 07:31:03 INFO - javascript benchmark 07:31:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.782315237933, 3144.2296637323857, 3154.7476201903864, 3172.254520187754, 3190.6330771961216, 5507.80722674706, 5515.7242137893045, 5540.2243685884005, 5558.027345214591, 5560.555155587548, 5615.045442274813, 5637.3517045539775, 5684.403137670537, 5689.118186681071, 5701.714914254281, 5108.361454818148, 5128.205128205115, 5141.794328226885, 5189.896202075956, 5199.454057323965, 4974.37820272466, 5141.794328226866, 5198.064348417283, 5203.271541984125, 5205.479452054783, 4951.925721114186, 5053.519915608012, 5071.771770270347, 5091.083604951107, 5106.821261255838, 5131.512506311913, 5161.200013997836, 5168.043911876315, 5223.503767142115, 5228.816991405282, 5081.72050537224, 5128.948710512885, 5189.273501709726, 5204.219367094928, 5230.398504172031, 5408.080626293539, 5460.6177567570285, 5474.151506516497, 5571.913476872011, 5669.518090962273, 5952.077427998667, 6014.428629280212, 6033.969830150865, 6042.546808989343, 6045.0, 6067.544934129958, 6076.848078798065, 6077.392260773931, 6089.847753806191, 6090.056041313604, 5318.707471089088, 5356.330458692663, 5498.1752737089355, 5508.669479831143, 5550.139728342114, 6090.6041107328765, 6095.817125486243, 6096.390360963868, 6100.0, 6109.419605137505, 5853.356130825606, 5853.590248682552, 5854.151148083504, 5854.2096816930025, 5858.619189752652, 5833.183354330397, 5852.707364631751, 5888.411158884077, 5905.881882362329, 5916.053431450947, 5961.910571341434, 5963.612365196248, 5964.463198312173, 5984.73068711909, 6005.489533389711, 5935.436133567304, 5939.22790037301, 5997.0404735242155, 6002.759889604455, 6020.217371741734, 4501.977490112528, 4545.340925565841, 4548.590626843534, 4638.79125439356, 4640.048789998043, 4055.0673345130785, 4098.549159592442, 4101.692373072032, 4122.196171746541, 4129.463169787969, 5670.262865827416, 5680.829575112753, 5681.233033540502, 5681.289838770153, 5683.090705487102, 5908.409159084057, 5973.671448070311, 5979.521638268928, 6004.969975150097, 6008.609440386361, 5673.00722373583, 5676.4323567642905, 5693.743781529841, 5698.800541981093, 5735.426457354231, 5127.051495473349, 5132.769025393866, 5133.743312834344, 5142.04872098663, 5164.793408263702, 6242.719077641517, 6269.435750782452, 6297.086922396135, 6303.905441418382, 6306.243250809932, 5874.823755287348, 5937.970310148422, 6040.335563087969, 6093.573449858467, 6136.29432615255, 6146.477549408351, 6231.096491008869, 6251.374862513712, 6257.56197066201, 6258.843528911813, 5961.076033214858, 5964.761409543569, 5965.689814007848, 5969.791057312973, 6000.21997140369, 5812.070068789142, 5882.941170588239, 5922.2597175353085, 6001.219841420588, 6061.272647282354, 5823.679697616672, 5912.704364781658, 5914.083317085859, 5951.761929522944, 5952.434518720715, 5875.911861321998, 5881.206037185097, 5884.6469211847425, 5888.558358123072, 5888.793892213752, 5529.30883639545, 5531.032069387921, 5801.042827933344, 5835.6790376528, 5849.532037436909, 5929.16991621182, 5938.257717785277, 5989.071693887455, 6023.608465449732, 6032.819015429544, 5849.0, 5850.531957443309, 5858.794942177004, 5860.208871802252, 5866.2960444746905], "value": 5526.618266606691, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.1946153231607, 626.6522080245462, 630.8044506203078, 646.1922596754055, 651.1535004494158, 36207.4568881467, 39866.2026759465, 39883.80058099713, 39912.0, 48639.51360486394, 49521.752391238086, 49901.75049124749, 49994.50005499944, 50058.749706251416, 50169.0, 9422.246220302359, 9590.616375344978, 9634.0, 9645.95177024114, 9648.372855764354, 8494.40539162259, 8661.69684061058, 9470.479123648196, 9580.760480987996, 11175.161862860277, 11126.165537584673, 11202.439878006107, 11207.0, 11211.719707007349, 11249.437528123603, 11090.168237382228, 11104.44477776112, 11124.054455371303, 11134.777304453906, 11142.164337674625, 11165.162612803992, 11247.268927519684, 11247.437628118561, 11248.887511124865, 11259.099272058216, 46162.0, 46598.06803863904, 46728.766356168344, 46738.5326146741, 46778.76610616959, 3810.1998580298173, 3824.177801772604, 3832.2910261601414, 3890.708196885245, 4231.1749208904275, 35326.11684707903, 35344.82327588371, 35730.28539429223, 37180.442293365624, 37306.44040339397, 4742.668013239075, 4763.285507173917, 4805.20714082176, 4894.4371397289415, 4999.700017998932, 374234.0, 376914.0, 378601.0, 378622.0, 379069.0, 41527.37708934368, 42166.367504487454, 43268.350974735404, 67315.0, 67819.0, 42139.0, 42615.57384426178, 42628.78685606552, 42712.35931461031, 42750.0, 15762.527124186292, 15798.131102789228, 15800.36798528046, 15800.36798528069, 15805.0, 14952.177630230224, 15022.624434389229, 15024.924875375553, 15027.774583381259, 15028.924855375653, 9108.499032553273, 9387.0, 9433.433993960385, 9825.410475371358, 9853.359531630422, 3669.3578623741273, 3726.8509259629855, 3744.1388480649603, 3798.525184351956, 3800.847966081381, 1099.5601759296346, 1109.567268765166, 1114.9832752508719, 1121.5794077221042, 1177.0230708511915, 34839.65160348415, 34892.65107348945, 34971.125721856646, 35210.64789352125, 35334.64665353365, 1166.1720178673238, 1196.0, 1202.8015377462796, 1239.5599562155485, 1256.9308688022247, 17954.0, 18071.72892406615, 18163.273469061354, 18182.818171818377, 18203.726944095848, 516862.0, 518149.0, 521842.0, 521994.0, 522474.0, 64197.67901160558, 64458.355416446175, 64526.0, 64684.67657661682, 64742.0, 1412.0, 1443.3577058208996, 1470.5808844479486, 1478.911265324084, 1481.2889812889873, 32309.0, 33660.66339336673, 33714.831425843695, 33935.36074181755, 34296.65703343035, 57502.7124864373, 57882.421175787706, 57886.0, 57920.71039644775, 57930.0, 456795.0, 460073.0, 460106.0, 460171.0, 460839.0, 27730.445391092468, 29613.0, 30043.549346760254, 32788.180295492806, 33190.834045829615, 49208.26187607117, 52298.0, 52412.0, 53052.20421693601, 53124.73437632787, 44310.55689443064, 44489.0, 44505.10989780251, 44701.55298447104, 46331.073378532914, 44410.555894440644, 44837.10325793531, 45664.54335456603, 46202.306965396216, 46349.30476042795, 45400.77299613481, 45794.0, 46044.92797824039, 47120.528794711616, 47177.764111179225, 39380.40929386119, 40016.59983400245, 40561.59438405696, 40917.59082409138, 41473.1705365885, 29549.55675664824, 30026.549601755552, 30127.849360753054, 30270.0, 30667.2333191672], "value": 20752.608990321754, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.4565790194604, 435.1427687455713, 439.15462734236587, 443.86462129050625, 448.5581702023507, 18011.639767204666, 21021.0, 21059.68410473844, 21099.894500527495, 21539.67690484644, 20109.899450502726, 20728.963551822388, 20739.170433182655, 20752.377428677126, 20761.065752041155, 5532.6680399176075, 5874.70626468677, 5934.910976335358, 5939.109133629969, 5940.316863560681, 5751.56863235257, 5840.97079514604, 5930.406959304079, 5934.31755348134, 5936.821895343125, 6044.365341639131, 6070.089486577004, 6087.2086628738425, 6094.299155597097, 6105.755769769204, 6090.817275481721, 6096.390360963913, 6175.536834737412, 6630.801075967729, 6667.566608170453, 6041.24484439445, 6045.909311360333, 6046.455818976269, 6050.45545900871, 6051.546134039964, 18337.724934126, 22389.44026399337, 22835.20076797304, 23032.65451018236, 23087.307380778602, 2337.777911098443, 2471.5798314286612, 2655.721149279317, 2785.7075007124367, 3021.8337991410463, 10163.0, 10237.69286921386, 10263.589456421734, 10295.3822770634, 10474.895251047468, 2014.0332640332722, 2039.2352867674622, 2047.8566500344982, 2055.5888822235465, 2077.7610574783944, 79700.0, 84873.57563212207, 85650.57174714148, 86236.56881715613, 86488.5675571618, 11548.364839933884, 11572.132090093108, 11923.582674606347, 11957.940210299066, 12248.877511224951, 17031.574210644834, 17054.829451705573, 17079.31682732677, 17092.658146837242, 17100.65798684044, 8759.518226497476, 8849.247813935888, 8860.246879015356, 8933.821323573493, 9049.502277374808, 8278.544680042656, 8296.83406331882, 8326.583670816435, 8517.233448989497, 8523.48859068458, 4750.501197374295, 4904.926426103611, 4933.605311575137, 5065.164247899129, 5167.741612919339, 1882.4258601126787, 1914.4250982428612, 2100.5213847659907, 2142.7256306012705, 2177.2162021672184, 912.5300470257822, 1008.3798463944621, 1009.3705896140449, 1045.8012977534397, 1143.8798926112804, 18747.802488944202, 19502.219911203676, 19612.411627651192, 19713.605727885362, 19985.0, 1047.188428967541, 1087.2335003822286, 1120.5125770289949, 1134.6482590397004, 1178.9528418863322, 10832.593538347992, 10982.176336774774, 10984.670459886216, 11008.0, 11210.43947802623, 406171.0, 411034.0, 411323.0, 412450.0, 415731.0, 53727.0, 72604.0, 88405.55797220973, 89595.10404895998, 90714.09285907056, 1056.3450660590483, 1058.5448257249302, 1064.1965316186229, 1067.199600299775, 1068.6580294305747, 16884.493465196065, 17171.141442928052, 17448.47654570365, 17567.736483952496, 17646.823531765032, 30617.387652246383, 41404.58595414007, 43498.0, 45932.7703361481, 46201.537984619725, 60023.39976600178, 60165.39834601598, 60395.69802150961, 61468.692656536434, 61731.691341543, 6412.6793660317735, 9160.358774885693, 9270.953645231732, 9353.158215760614, 9419.952900235729, 12277.263364198177, 14139.151650900978, 14150.221737804519, 14171.929140354232, 14179.787303190255, 8313.750587482386, 11687.415629218334, 11700.531978720755, 11825.40872956366, 12171.817422738843, 11554.42227888619, 11611.0, 11894.0, 12024.0, 12457.439415226518, 6419.903701444388, 9411.905880941104, 11283.548658053585, 12559.497620095093, 12673.30296833683, 9089.227415669742, 9178.770530736785, 9426.057394260519, 9428.811423771624, 9476.431414115175, 10947.781044378908, 11949.76100478003, 12213.145079844326, 12354.752904941672, 12580.748385032432], "value": 9507.510361586856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.7867359232907, 1531.8161820581531, 1640.4422496351237, 1751.7109676903312, 1765.4703588923328, 8093.757187284384, 8728.389012769108, 8734.737957861267, 8735.082816304292, 8747.562621868912, 7194.316539928698, 7457.515261507998, 8106.91893081069, 8357.20606542379, 8367.539785311805, 2402.3153401280683, 2427.053449154831, 2432.063655492639, 2433.488967316857, 2435.7198922124007, 2043.4891277180704, 2392.222527678503, 2413.058907026252, 2424.2242482405636, 2424.9393765155837, 2134.658454647257, 2365.526894621074, 2427.2475532584867, 2430.914917977871, 2441.182203961666, 2348.201611452106, 2354.576176288276, 2363.420961864346, 2369.9881500592387, 2403.531311394279, 2279.840411171219, 2282.315305408371, 2287.8103386239227, 2288.61093614086, 2289.072925465189, 8536.487810731314, 8568.10034946334, 8568.957155214246, 8628.180322869317, 8631.913680863174, 5270.39390470097, 5393.568514518829, 5402.540784033362, 5404.83785486436, 5412.323459567554, 3270.9836450817834, 3380.8478618462227, 3445.879394221215, 3447.4484082546674, 3470.0977745786026, 1136.7044568412273, 1151.441550847838, 1166.7374840660868, 1198.5385626533848, 1223.174357308822, 11451.370174640391, 11491.138164637685, 11496.540138394454, 11512.424378781112, 11557.53769849205, 4504.774761261924, 4687.601553867891, 4791.089692958327, 4820.30105634681, 4855.927161092586, 9822.754431139136, 9834.950825245827, 9837.852432213522, 9846.950765246127, 9847.606095756233, 5298.417174110845, 5307.336582927134, 5321.388040375329, 5324.840254792362, 5335.0, 4904.8773780655765, 4944.629152813553, 4963.6277279204205, 4964.404271487445, 5010.599152067826, 3828.885133446001, 3833.463315135883, 3890.358090915024, 3892.5328960524917, 3976.562578116405, 1096.7696783675358, 1103.6082190822303, 1149.4597539156582, 1168.8363629091934, 1180.8464899563173, 880.3705350674298, 987.6839411388287, 1042.7966546523508, 1044.1229367331478, 1064.122099268107, 5848.327442344185, 6010.879782404415, 6022.09668549721, 6050.092486127116, 6079.0, 553.518438958101, 553.5239693863274, 572.513363640902, 572.8711040016046, 698.9825254368579, 4056.371262454324, 4255.127698821734, 4281.785910704452, 4338.58783415575, 4389.714668546534, 10137.239707021856, 10405.791884162274, 10480.056794888344, 10490.265681402228, 10492.947535262427, 9951.303408761318, 10362.585496580203, 10450.843237351446, 10454.843177352346, 10456.52945617449, 7903.486273392211, 8049.51702897828, 8082.9191708083345, 8088.878666820003, 8091.312238459797, 5832.970835145967, 5932.228810254639, 5975.850603734768, 6036.267491456971, 6284.874302514016, 8948.149925757043, 9304.511278195456, 9321.906780932104, 9357.953210233905, 9385.38994965325, 9676.70969870905, 9682.951585242028, 9685.806283874424, 9695.418274903528, 9697.854532181882, 7713.691452341844, 7803.804904877424, 7805.765827025199, 7806.102298235775, 7814.882776758467, 8173.0, 8197.262246397853, 8208.09710931785, 8273.214044665747, 8275.172482751677, 6592.510859948777, 7472.925270747223, 7560.886586701094, 7607.88588171189, 7620.771376858703, 7526.0, 7598.506097103671, 7615.048118985127, 7647.464677472523, 7650.158482567024, 6687.565308254948, 6788.0, 6861.1080559526945, 6987.860242795217, 6995.580265184105, 5108.208227724708, 5115.079285728604, 5218.321618189611, 5226.738663066907, 5300.681959082467, 5123.5644970177955, 5130.871728206825, 5293.153095504701, 5295.232191332312, 5390.353157621111], "value": 4537.711287926887, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.19273423897585, 363.3205904957729, 369.6691461142277, 377.4432711750169, 378.92800367930107, 5231.24146998685, 5424.0, 5433.565314774818, 5476.698781567012, 5492.176173573961, 5262.842114736564, 5371.113766228567, 5378.677279363241, 5391.56867450604, 5425.240466334716, 4348.695591308609, 4356.8257269709175, 4357.7385356878685, 4361.473484280492, 4364.388985542027, 4214.524916279308, 4271.466066741657, 4295.26980413329, 4343.9348409773875, 4351.847685331014, 4249.298865687158, 4264.147170565884, 4266.189424009443, 4266.402703621496, 4273.508546517143, 4236.809343579531, 4249.490061192677, 4256.404103425508, 4267.871963841089, 4292.806823692941, 3642.9253370255838, 3781.4138808484727, 3793.696504279651, 3799.0502374406396, 3835.5780864104927, 5307.28351672527, 5338.199270109515, 5341.412444631087, 5341.691285635045, 5354.678719276817, 4923.606111511106, 4932.186189278765, 4944.110060189165, 4948.604111671058, 4949.975250123763, 5586.776528938837, 5652.349979752299, 5684.8010319639025, 5687.0, 5689.330381903649, 4156.397322388237, 4174.5616710245295, 4183.4979802423595, 4188.727732697395, 4191.140816132685, 5867.559933005042, 5907.734151963215, 5943.4056594340655, 5950.8809823803285, 5958.314793798725, 4053.9391909121387, 4253.723507971972, 4285.207236661166, 4307.815350778561, 4308.978455107767, 4349.934266104825, 4352.542982986804, 4354.847580334673, 4355.976345558791, 4362.323839804835, 4910.6808057476865, 4917.213245880642, 4921.163402221631, 4923.679960802537, 4929.211326187865, 5519.2824932758485, 5739.311282646109, 5769.941930776695, 5786.152208781114, 5801.462612407715, 1413.3074793351184, 1443.8844892408792, 1449.412987739946, 1480.940762369493, 1487.516557118919, 1003.2826529031777, 1007.9143272821892, 1031.118393773328, 1043.2436483549518, 1047.219821233171, 5557.916631250535, 5559.722013899289, 5567.387587365387, 5570.610057296031, 5578.414266501959, 5788.913166302509, 5833.541614596351, 5855.0, 5856.648601083949, 5887.791153821177, 5342.679439233659, 5557.305336832896, 5570.301058177214, 5651.4348565143155, 5679.801206957736, 3144.701253380925, 3161.3361194149024, 3167.8099314041233, 3168.207948012997, 3169.7781155319367, 5763.8559036024435, 6086.786962456293, 6107.908381374283, 6111.54163437744, 6116.877662446726, 6030.276366836008, 6050.273967123885, 6068.9696551517845, 6077.450250186174, 6084.969575152096, 6076.513878889767, 6079.452849243589, 6101.60339577926, 6123.418275263843, 6124.724387402578, 5684.658920464785, 5921.904447677193, 5923.437273459014, 5973.283206015306, 5981.743833794952, 5867.970660146672, 5872.354041055395, 5879.353271140086, 5880.500157486662, 5892.882142357043, 5779.624324418899, 6065.120557519223, 6074.149619053248, 6076.966915624266, 6088.908666369919, 4280.636145927631, 4307.8276868924895, 4312.7627980461375, 4325.372820940883, 4336.3278691802825, 5634.211210430625, 5816.651000939957, 5976.282846058501, 5982.192404025401, 5983.730732117152, 5626.549876009991, 5654.180143879197, 5662.915056274077, 5751.884962300647, 5810.360860305447, 5726.914096288642, 5792.623479473821, 5802.0, 5802.114312848257, 5803.274590676166, 5560.19377190297, 5717.142428635738, 5721.885562288648, 5734.770609175586, 5751.913721294268, 5763.567732420001, 5824.970875145597, 5829.067349224104, 5847.707614619167, 5853.682921342835, 5404.756905911584, 5680.460356266148, 5689.914651280317, 5696.487316141567, 5711.200431939615], "value": 4415.2250355253655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.4886951307866, 804.4489524675598, 805.0701439836987, 849.1254008371378, 890.4301247201796, 14741.262936853169, 15167.241637918116, 15243.84756152438, 15318.923405382971, 15319.234038298096, 16265.593360166002, 16506.25721842517, 16507.91746041271, 16513.256903439345, 16628.0, 726.4007194064891, 746.3208480282943, 861.3970220845433, 873.4017198219209, 890.9376343655947, 882.9117088291184, 886.6674996876171, 886.6852267445029, 886.685226744506, 888.6711916590871, 942.2791564453199, 942.8727121838533, 943.6555657185147, 943.7687766497183, 944.0323668240075, 763.8472305538887, 782.0459039971227, 909.3498148823556, 924.8381533231658, 947.114447991127, 691.6438034412282, 691.9930800691978, 692.0484334040694, 692.3457332820486, 692.6363659078974, 15610.141442220673, 15626.687466250725, 15654.295556699975, 15673.059616423052, 15678.294476748573, 14731.484398046125, 14993.0, 15013.024153430102, 15050.774238386433, 15268.083914965138, 13241.933790330986, 13659.112157709817, 13724.45102195911, 13734.45062197511, 13854.515091971733, 4254.553271906436, 4288.270993931039, 4306.784660766981, 4330.870073897788, 4374.956250437487, 67771.66114169447, 69328.0, 69880.0, 70979.64510177467, 80864.19135808684, 12403.069769767304, 13283.734325313633, 13672.794908076386, 13782.862171378158, 13854.86145138556, 25450.0, 25539.36151596225, 26021.869890650425, 26096.8695156523, 26107.608385874228, 9390.248780097576, 9407.388519746195, 9410.106039926197, 9594.952025239829, 9766.07222313879, 5088.287639730441, 5111.488851114858, 5115.130427827278, 5247.239150323258, 5376.623636345496, 3555.1112221944513, 3679.7240206984584, 3682.429223470366, 3705.2404257127764, 3707.4624179494363, 622.9813105606839, 625.6121204853021, 633.5944995203074, 639.3191251317332, 645.9321771214048, 671.2482020137477, 751.1999720297865, 776.4875182379602, 780.3445106110894, 820.6717313074818, 10036.598536058476, 10528.152339173907, 10556.788864222826, 10652.573897044187, 10817.83773243402, 656.4420242793683, 770.2297702297702, 779.9766007019798, 780.2626517940605, 780.6565111350988, 4977.726225057584, 5115.130427827278, 5155.717616115775, 5165.635058182718, 5281.683099013994, 75518.62240688762, 75848.0, 76235.0, 102255.0, 126172.0, 111405.0, 113839.43080284711, 114629.0, 116469.41765291289, 117574.0, 60933.390666092775, 63469.0, 81830.59084704658, 91720.54139729259, 102742.97257027484, 9397.295202859676, 9517.048295170427, 9602.375845570015, 9643.421394716339, 9682.273829462678, 53750.118745843705, 55311.44688553063, 55729.442705574045, 56966.0, 57612.71193644005, 75763.62118189374, 80573.19426805657, 82459.17540824755, 83938.16061839303, 85091.0, 13098.083134180515, 13643.454261829416, 13646.113002655193, 13888.722225555635, 14290.35693393779, 14265.786013209603, 14473.92763036178, 15919.522414327588, 15959.920200398923, 15966.28151733198, 13594.728105438033, 13654.795178072536, 14176.149431034171, 14259.215743134228, 14312.212828294543, 14059.156450612996, 14089.506867259597, 14225.14649121056, 14314.0, 14884.330205140577, 13955.790663140264, 14298.57104286873, 14453.0, 14726.190059546827, 14742.336594853472, 12106.697332566757, 12198.390080496118, 12929.418176182282, 12987.740245195233, 13187.868121318665, 11915.2255103418, 12875.0, 13061.0, 13230.933845330712, 13324.333783310602], "value": 8032.8692898613335, "unit": "score"}], "name": "dromaeo_css", "value": 7482.569196537034, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 110.0, 111.0, 111.0, 111.0, 111.0, 110.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 121.0, 158.0, 117.0, 118.0, 118.0, 115.0, 150.0, 116.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 159.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 110.0, 75.0, 76.0, 76.0, 76.0, 96.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 130.0, 81.0, 82.0, 81.0, 105.0, 82.0, 81.0, 108.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 48.0, 49.0, 50.0, 50.0, 48.0, 49.0, 49.0, 47.0], "value": 48.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 60.0, 69.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 73.0, 78.0, 72.0, 73.0, 72.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 123.0, 130.0, 121.0, 122.0, 120.0, 130.0, 159.0, 121.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 156.0, 154.0, 155.0, 158.0, 154.0, 152.0, 156.0, 151.0, 158.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 62.0, 62.0, 63.0, 61.0, 65.0, 61.0, 63.0, 60.0, 62.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1456.7, "alertThreshold": 2.0}]} 07:31:03 INFO - Return code: 0 07:31:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:31:03 INFO - # TBPL SUCCESS # 07:31:03 INFO - Running post-action listener: _resource_record_post_action 07:31:03 INFO - [mozharness: 2016-11-14 15:31:03.185140Z] Finished run-tests step (success) 07:31:03 INFO - Running post-run listener: _resource_record_post_run 07:31:03 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 357543936; Read time: 0; Write time: 253816 07:31:03 INFO - TinderboxPrint: CPU usage
12.9% 07:31:03 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:31:03 INFO - TinderboxPrint: I/O write bytes / time
357,543,936 / 253,816 07:31:03 INFO - TinderboxPrint: CPU idle
8,264.1 (87.1%) 07:31:03 INFO - TinderboxPrint: CPU user
1,182.1 (12.5%) 07:31:03 INFO - TinderboxPrint: Swap in / out
0 / 0 07:31:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 111300608; Read time: 0; Write time: 92008 07:31:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 246243328; Read time: 0; Write time: 161808 07:31:03 INFO - Running post-run listener: _upload_blobber_files 07:31:03 INFO - Blob upload gear active. 07:31:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:31:03 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:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:31:04 INFO - (blobuploader) - INFO - Open directory for files ... 07:31:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:31:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:31:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:05 INFO - (blobuploader) - INFO - Done attempting. 07:31:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:31:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:31:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:06 INFO - (blobuploader) - INFO - Done attempting. 07:31:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:31:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:31:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:09 INFO - (blobuploader) - INFO - Done attempting. 07:31:09 INFO - (blobuploader) - INFO - Iteration through files over. 07:31:09 INFO - Return code: 0 07:31:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:31:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:31:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/171b1bc918ae3c3d890e4d9cfa2ad7f60f38c6fd52e5e28c1c83ef97c94c96c67e55643cae96079d468c251cd0cdaf5da8604a4dd929c098b661213fa9d06bd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7871b7612c468b4502c8af6174c06b3270c4971acbb1fbecf5dbe67ce4f319b02770d3e3f337b04d3fddbc6e606cc932391cc5dbd346386f460921b01f0dc884", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dc0fe87e617f1ce54aa3edb2972b7efd590b7e46cf46460902cb5148b64a5e1b5a95b2def2522e2619878ef446afb0b6c017562fb3bac4f576a0a31a9bd0389"} 07:31:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:31:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:31:09 INFO - Contents: 07:31:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/171b1bc918ae3c3d890e4d9cfa2ad7f60f38c6fd52e5e28c1c83ef97c94c96c67e55643cae96079d468c251cd0cdaf5da8604a4dd929c098b661213fa9d06bd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7871b7612c468b4502c8af6174c06b3270c4971acbb1fbecf5dbe67ce4f319b02770d3e3f337b04d3fddbc6e606cc932391cc5dbd346386f460921b01f0dc884", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dc0fe87e617f1ce54aa3edb2972b7efd590b7e46cf46460902cb5148b64a5e1b5a95b2def2522e2619878ef446afb0b6c017562fb3bac4f576a0a31a9bd0389"} 07:31:09 INFO - Running post-run listener: copy_logs_to_upload_dir 07:31:09 INFO - Copying logs to upload dir... 07:31:09 INFO - mkdir: /builds/slave/test/build/upload/logs 07:31:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.465557 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-14 07:31:09.842756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:31:09.846594) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/171b1bc918ae3c3d890e4d9cfa2ad7f60f38c6fd52e5e28c1c83ef97c94c96c67e55643cae96079d468c251cd0cdaf5da8604a4dd929c098b661213fa9d06bd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7871b7612c468b4502c8af6174c06b3270c4971acbb1fbecf5dbe67ce4f319b02770d3e3f337b04d3fddbc6e606cc932391cc5dbd346386f460921b01f0dc884", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dc0fe87e617f1ce54aa3edb2972b7efd590b7e46cf46460902cb5148b64a5e1b5a95b2def2522e2619878ef446afb0b6c017562fb3bac4f576a0a31a9bd0389"} build_url:https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011470 build_url: 'https://queue.taskcluster.net/v1/task/fUTohLACRWiVwkChiTzxtA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/171b1bc918ae3c3d890e4d9cfa2ad7f60f38c6fd52e5e28c1c83ef97c94c96c67e55643cae96079d468c251cd0cdaf5da8604a4dd929c098b661213fa9d06bd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7871b7612c468b4502c8af6174c06b3270c4971acbb1fbecf5dbe67ce4f319b02770d3e3f337b04d3fddbc6e606cc932391cc5dbd346386f460921b01f0dc884", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dc0fe87e617f1ce54aa3edb2972b7efd590b7e46cf46460902cb5148b64a5e1b5a95b2def2522e2619878ef446afb0b6c017562fb3bac4f576a0a31a9bd0389"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:31:09.872950) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:31:09.873320) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1479136235.820604-202305507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:31:09.957479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:31:09.958028) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:31:09.958514) ========= ========= Total master_lag: 0.18 =========