builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1484714431.16 results: success (0) buildid: 20170117184445 builduid: 76fdbdb295af43f6be54db27036d959d revision: 5bf843087b55bcdeab912ac01cd5596673071f69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:31.160733) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:31.161181) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:31.161451) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:31.175529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:31.175793) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-17 20:40:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2017-01-17 20:40:31 (112 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.379078 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:31.569525) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:31.570022) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016041 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:31.620308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:31.620672) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5bf843087b55bcdeab912ac01cd5596673071f69 --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-beta --rev 5bf843087b55bcdeab912ac01cd5596673071f69 --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=e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-17 20:40:31,983 truncating revision to first 12 chars 2017-01-17 20:40:31,983 Setting DEBUG logging. 2017-01-17 20:40:31,983 attempt 1/10 2017-01-17 20:40:31,983 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5bf843087b55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-17 20:40:32,297 unpacking tar archive at: mozilla-beta-5bf843087b55/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636727 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:32.270496) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:32.270815) ========= script_repo_revision: 5bf843087b55bcdeab912ac01cd5596673071f69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:32.271194) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:32.271458) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 20:40:32.279439) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-01-17 20:40:32.279716) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:40:32 INFO - MultiFileLogger online at 20170117 20:40:32 in /builds/slave/test 20:40:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:40:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:40:32 INFO - {'append_to_log': False, 20:40:32 INFO - 'base_work_dir': '/builds/slave/test', 20:40:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:40:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:40:32 INFO - 'branch': 'Mozilla-Beta', 20:40:32 INFO - 'buildbot_json_path': 'buildprops.json', 20:40:32 INFO - 'config_files': ('talos/linux_config.py',), 20:40:32 INFO - 'default_actions': ('clobber', 20:40:32 INFO - 'read-buildbot-config', 20:40:32 INFO - 'download-and-extract', 20:40:32 INFO - 'populate-webroot', 20:40:32 INFO - 'create-virtualenv', 20:40:32 INFO - 'install', 20:40:32 INFO - 'run-tests'), 20:40:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:40:32 INFO - 'download_minidump_stackwalk': True, 20:40:32 INFO - 'download_symbols': 'ondemand', 20:40:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:40:32 INFO - 'tooltool.py': '/tools/tooltool.py', 20:40:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:40:32 INFO - '/tools/misc-python/virtualenv.py')}, 20:40:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:40:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:40:32 INFO - 'installer_path': 'installer.exe', 20:40:32 INFO - 'log_level': 'info', 20:40:32 INFO - 'log_name': 'talos', 20:40:32 INFO - 'log_to_console': True, 20:40:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:40:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:40:32 INFO - 'opt_config_files': (), 20:40:32 INFO - 'pip_index': False, 20:40:32 INFO - 'sps_profile': False, 20:40:32 INFO - 'sps_profile_interval': 0, 20:40:32 INFO - 'suite': 'dromaeojs', 20:40:32 INFO - 'system_bits': '32', 20:40:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:40:32 INFO - 'title': 'talos-linux64-ix-006', 20:40:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:40:32 INFO - 'use_talos_json': True, 20:40:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:40:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:40:32 INFO - 'work_dir': 'build'} 20:40:32 INFO - [mozharness: 2017-01-18 04:40:32.733765Z] Running clobber step. 20:40:32 INFO - Running pre-action listener: _resource_record_pre_action 20:40:32 INFO - Running main action method: clobber 20:40:32 INFO - rmtree: /builds/slave/test/build 20:40:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:40:33 INFO - Running post-action listener: _resource_record_post_action 20:40:33 INFO - [mozharness: 2017-01-18 04:40:33.814204Z] Finished clobber step (success) 20:40:33 INFO - [mozharness: 2017-01-18 04:40:33.814304Z] Running read-buildbot-config step. 20:40:33 INFO - Running pre-action listener: _resource_record_pre_action 20:40:33 INFO - Running main action method: read_buildbot_config 20:40:33 INFO - Using buildbot properties: 20:40:33 INFO - { 20:40:33 INFO - "project": "", 20:40:33 INFO - "product": "firefox", 20:40:33 INFO - "script_repo_revision": "production", 20:40:33 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 20:40:33 INFO - "repository": "", 20:40:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 20:40:33 INFO - "buildid": "20170117184445", 20:40:33 INFO - "pgo_build": "True", 20:40:33 INFO - "basedir": "/builds/slave/test", 20:40:33 INFO - "buildnumber": 514, 20:40:33 INFO - "slavename": "talos-linux64-ix-006", 20:40:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:40:33 INFO - "platform": "ubuntu64_hw", 20:40:33 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 20:40:33 INFO - "branch": "mozilla-beta", 20:40:33 INFO - "repo_path": "releases/mozilla-beta", 20:40:33 INFO - "revision": "5bf843087b55bcdeab912ac01cd5596673071f69", 20:40:33 INFO - "stage_platform": "linux64-pgo", 20:40:33 INFO - "builduid": "76fdbdb295af43f6be54db27036d959d", 20:40:33 INFO - "slavebuilddir": "test" 20:40:33 INFO - } 20:40:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 20:40:33 INFO - Running post-action listener: _resource_record_post_action 20:40:33 INFO - [mozharness: 2017-01-18 04:40:33.816734Z] Finished read-buildbot-config step (success) 20:40:33 INFO - [mozharness: 2017-01-18 04:40:33.816824Z] Running download-and-extract step. 20:40:33 INFO - Running pre-action listener: _resource_record_pre_action 20:40:33 INFO - Running main action method: download_and_extract 20:40:33 INFO - mkdir: /builds/slave/test/build/tests 20:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:33 INFO - trying https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 20:40:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 20:40:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:40:34 INFO - Downloaded 1327 bytes. 20:40:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 20:40:34 INFO - Using the following test package requirements: 20:40:34 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 20:40:34 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 20:40:34 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 20:40:34 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 20:40:34 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 20:40:34 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 20:40:34 INFO - u'jsshell-linux-x86_64.zip'], 20:40:34 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 20:40:34 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 20:40:34 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 20:40:34 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 20:40:34 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 20:40:34 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 20:40:34 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 20:40:34 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 20:40:34 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 20:40:34 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 20:40:34 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 20:40:34 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:40:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 20:40:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:40:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 20:40:34 INFO - Expected file size: 21973000 20:40:39 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:40:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 20:40:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:40:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 20:40:39 INFO - Expected file size: 21973000 20:40:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 20:40:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:40:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 20:40:44 INFO - Expected file size: 14414089 20:40:45 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')]} 20:40:45 INFO - trying https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 20:40:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 20:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:40:46 INFO - Downloaded 57060754 bytes. 20:40:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 20:40:46 INFO - mkdir: /builds/slave/test/properties 20:40:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:40:46 INFO - Writing to file /builds/slave/test/properties/build_url 20:40:46 INFO - Contents: 20:40:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 20:40:47 INFO - Running post-action listener: _resource_record_post_action 20:40:47 INFO - Running post-action listener: set_extra_try_arguments 20:40:47 INFO - [mozharness: 2017-01-18 04:40:47.104927Z] Finished download-and-extract step (success) 20:40:47 INFO - [mozharness: 2017-01-18 04:40:47.105146Z] Running populate-webroot step. 20:40:47 INFO - Running pre-action listener: _resource_record_pre_action 20:40:47 INFO - Running main action method: populate_webroot 20:40:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:40:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:40:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:40:47 INFO - '--tppagecycles', 20:40:47 INFO - '7'], 20:40:47 INFO - 'tests': ['tsvgm']}}, 20:40:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:40:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:40:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:40:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:40:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:47 INFO - 'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:40:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:40:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:47 INFO - 'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['damp', 'tps']}, 20:40:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:47 INFO - 'tests': ['damp', 'tps']}, 20:40:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['dromaeo_dom']}, 20:40:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:40:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['basic_compositor_video']}, 20:40:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:40:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['a11yr', 20:40:47 INFO - 'ts_paint', 20:40:47 INFO - 'tpaint', 20:40:47 INFO - 'sessionrestore', 20:40:47 INFO - 'sessionrestore_no_auto_restore', 20:40:47 INFO - 'tabpaint']}, 20:40:47 INFO - 'other-e10s': {'tests': ['a11yr', 20:40:47 INFO - 'ts_paint', 20:40:47 INFO - 'tpaint', 20:40:47 INFO - 'sessionrestore', 20:40:47 INFO - 'sessionrestore_no_auto_restore', 20:40:47 INFO - 'tabpaint']}, 20:40:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:40:47 INFO - 'ts_paint', 20:40:47 INFO - 'tpaint', 20:40:47 INFO - 'sessionrestore', 20:40:47 INFO - 'sessionrestore_no_auto_restore', 20:40:47 INFO - 'tabpaint']}, 20:40:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:40:47 INFO - 'ts_paint', 20:40:47 INFO - 'tpaint', 20:40:47 INFO - 'sessionrestore', 20:40:47 INFO - 'sessionrestore_no_auto_restore', 20:40:47 INFO - 'tabpaint']}, 20:40:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['a11yr', 20:40:47 INFO - 'ts_paint', 20:40:47 INFO - 'tpaint', 20:40:47 INFO - 'sessionrestore', 20:40:47 INFO - 'sessionrestore_no_auto_restore', 20:40:47 INFO - 'tabpaint']}, 20:40:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['a11yr', 20:40:47 INFO - 'ts_paint', 20:40:47 INFO - 'tpaint', 20:40:47 INFO - 'sessionrestore', 20:40:47 INFO - 'sessionrestore_no_auto_restore', 20:40:47 INFO - 'tabpaint']}, 20:40:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['tsvgx', 20:40:47 INFO - 'tsvgr_opacity', 20:40:47 INFO - 'tart', 20:40:47 INFO - 'tscrollx', 20:40:47 INFO - 'cart']}, 20:40:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:40:47 INFO - 'tsvgr_opacity', 20:40:47 INFO - 'tart', 20:40:47 INFO - 'tscrollx', 20:40:47 INFO - 'cart']}, 20:40:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:47 INFO - 'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['tp5o']}, 20:40:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:47 INFO - 'tests': ['tp5o']}, 20:40:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:47 INFO - 'talos_options': ['--disable-e10s', 20:40:47 INFO - '--xperf_path', 20:40:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:40:47 INFO - 'tests': ['tp5n']}, 20:40:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:47 INFO - 'talos_options': ['--xperf_path', 20:40:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:40:47 INFO - 'tests': ['tp5n']}}, 20:40:47 INFO - 'talos.zip': {'path': '', 20:40:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:40:47 INFO - Running post-action listener: _resource_record_post_action 20:40:47 INFO - [mozharness: 2017-01-18 04:40:47.127196Z] Finished populate-webroot step (success) 20:40:47 INFO - [mozharness: 2017-01-18 04:40:47.127289Z] Running create-virtualenv step. 20:40:47 INFO - Running pre-action listener: _resource_record_pre_action 20:40:47 INFO - Running main action method: create_virtualenv 20:40:47 INFO - Creating virtualenv /builds/slave/test/build/venv 20:40:47 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 20:40:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:40:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:40:47 INFO - Using real prefix '/usr' 20:40:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:40:47 INFO - Installing distribute.............................................................................................................................................................................................done. 20:40:49 INFO - Installing pip.................done. 20:40:49 INFO - Return code: 0 20:40:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:40: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')]} 20:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40: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')]} 20:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:49 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 0x7f1baadcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5af60>, '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 0x1d5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', '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 20:40:49 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 20:40:49 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 20:40:49 INFO - Using env: {'DISPLAY': ':0', 20:40:49 INFO - 'HOME': '/home/cltbld', 20:40:49 INFO - 'LANG': 'en_US.UTF-8', 20:40:49 INFO - 'LANGUAGE': 'en_US:en', 20:40:49 INFO - 'LOGNAME': 'cltbld', 20:40:49 INFO - 'MAIL': '/var/mail/cltbld', 20:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:49 INFO - 'MOZ_NO_REMOTE': '1', 20:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:49 INFO - 'NO_EM_RESTART': '1', 20:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:49 INFO - 'PWD': '/builds/slave/test', 20:40:49 INFO - 'SHELL': '/bin/bash', 20:40:49 INFO - 'SHLVL': '1', 20:40:49 INFO - 'TERM': 'linux', 20:40:49 INFO - 'TMOUT': '86400', 20:40:49 INFO - 'USER': 'cltbld', 20:40:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', 20:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:49 INFO - '_': '/tools/buildbot/bin/python'} 20:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:49 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 20:40:49 INFO - Cleaning up... 20:40:49 INFO - Return code: 0 20:40:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:40: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')]} 20:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40: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')]} 20:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:49 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 0x7f1baadcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5af60>, '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 0x1d5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', '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 20:40:49 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 20:40:49 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 20:40:49 INFO - Using env: {'DISPLAY': ':0', 20:40:49 INFO - 'HOME': '/home/cltbld', 20:40:49 INFO - 'LANG': 'en_US.UTF-8', 20:40:49 INFO - 'LANGUAGE': 'en_US:en', 20:40:49 INFO - 'LOGNAME': 'cltbld', 20:40:49 INFO - 'MAIL': '/var/mail/cltbld', 20:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:49 INFO - 'MOZ_NO_REMOTE': '1', 20:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:49 INFO - 'NO_EM_RESTART': '1', 20:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:49 INFO - 'PWD': '/builds/slave/test', 20:40:49 INFO - 'SHELL': '/bin/bash', 20:40:49 INFO - 'SHLVL': '1', 20:40:49 INFO - 'TERM': 'linux', 20:40:49 INFO - 'TMOUT': '86400', 20:40:49 INFO - 'USER': 'cltbld', 20:40:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', 20:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:49 INFO - '_': '/tools/buildbot/bin/python'} 20:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:50 INFO - Downloading/unpacking psutil>=3.1.1 20:40:50 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 20:40:50 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 20:40:50 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 20:40:50 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 20:40:50 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 20:40:50 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 20:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:40:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:40:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:40:52 INFO - Installing collected packages: psutil 20:40:52 INFO - Running setup.py install for psutil 20:40:52 INFO - building 'psutil._psutil_linux' extension 20:40:52 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 20:40:52 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 20:40:52 INFO - building 'psutil._psutil_posix' extension 20:40:52 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 20:40:52 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 20:40:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:40:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:40:52 INFO - Successfully installed psutil 20:40:52 INFO - Cleaning up... 20:40:52 INFO - Return code: 0 20:40:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:40:52 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')]} 20:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:52 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')]} 20:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:52 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 0x7f1baadcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5af60>, '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 0x1d5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', '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 20:40:52 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 20:40:52 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 20:40:52 INFO - Using env: {'DISPLAY': ':0', 20:40:52 INFO - 'HOME': '/home/cltbld', 20:40:52 INFO - 'LANG': 'en_US.UTF-8', 20:40:52 INFO - 'LANGUAGE': 'en_US:en', 20:40:52 INFO - 'LOGNAME': 'cltbld', 20:40:52 INFO - 'MAIL': '/var/mail/cltbld', 20:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:52 INFO - 'MOZ_NO_REMOTE': '1', 20:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:52 INFO - 'NO_EM_RESTART': '1', 20:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:52 INFO - 'PWD': '/builds/slave/test', 20:40:52 INFO - 'SHELL': '/bin/bash', 20:40:52 INFO - 'SHLVL': '1', 20:40:52 INFO - 'TERM': 'linux', 20:40:52 INFO - 'TMOUT': '86400', 20:40:52 INFO - 'USER': 'cltbld', 20:40:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', 20:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:52 INFO - '_': '/tools/buildbot/bin/python'} 20:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:40:55 INFO - Installing collected packages: mozsystemmonitor 20:40:55 INFO - Running setup.py install for mozsystemmonitor 20:40:55 INFO - Successfully installed mozsystemmonitor 20:40:55 INFO - Cleaning up... 20:40:55 INFO - Return code: 0 20:40:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:55 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 0x7f1baadcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5af60>, '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 0x1d5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', '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 20:40:55 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 20:40:55 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 20:40:55 INFO - Using env: {'DISPLAY': ':0', 20:40:55 INFO - 'HOME': '/home/cltbld', 20:40:55 INFO - 'LANG': 'en_US.UTF-8', 20:40:55 INFO - 'LANGUAGE': 'en_US:en', 20:40:55 INFO - 'LOGNAME': 'cltbld', 20:40:55 INFO - 'MAIL': '/var/mail/cltbld', 20:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:55 INFO - 'MOZ_NO_REMOTE': '1', 20:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:55 INFO - 'NO_EM_RESTART': '1', 20:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:55 INFO - 'PWD': '/builds/slave/test', 20:40:55 INFO - 'SHELL': '/bin/bash', 20:40:55 INFO - 'SHLVL': '1', 20:40:55 INFO - 'TERM': 'linux', 20:40:55 INFO - 'TMOUT': '86400', 20:40:55 INFO - 'USER': 'cltbld', 20:40:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', 20:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:55 INFO - '_': '/tools/buildbot/bin/python'} 20:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:55 INFO - Downloading/unpacking jsonschema==2.5.1 20:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:40:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:40: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 20:40: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 20:40: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 20:40: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 20:40: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 20:40: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 20:40:57 INFO - Downloading functools32-3.2.3-2.tar.gz 20:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:40:57 INFO - warning: no files found matching '*.txt' 20:40:57 INFO - no previously-included directories found matching 'build' 20:40:57 INFO - no previously-included directories found matching 'dist' 20:40:57 INFO - no previously-included directories found matching '.git*' 20:40:57 INFO - Installing collected packages: jsonschema, functools32 20:40:57 INFO - Running setup.py install for functools32 20:40:58 INFO - warning: no files found matching '*.txt' 20:40:58 INFO - no previously-included directories found matching 'build' 20:40:58 INFO - no previously-included directories found matching 'dist' 20:40:58 INFO - no previously-included directories found matching '.git*' 20:40:58 INFO - Successfully installed jsonschema functools32 20:40:58 INFO - Cleaning up... 20:40:58 INFO - Return code: 0 20:40:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:58 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 0x7f1baadcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5af60>, '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 0x1d5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', '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 20:40:58 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 20:40:58 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 20:40:58 INFO - Using env: {'DISPLAY': ':0', 20:40:58 INFO - 'HOME': '/home/cltbld', 20:40:58 INFO - 'LANG': 'en_US.UTF-8', 20:40:58 INFO - 'LANGUAGE': 'en_US:en', 20:40:58 INFO - 'LOGNAME': 'cltbld', 20:40:58 INFO - 'MAIL': '/var/mail/cltbld', 20:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:58 INFO - 'MOZ_NO_REMOTE': '1', 20:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:58 INFO - 'NO_EM_RESTART': '1', 20:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:58 INFO - 'PWD': '/builds/slave/test', 20:40:58 INFO - 'SHELL': '/bin/bash', 20:40:58 INFO - 'SHLVL': '1', 20:40:58 INFO - 'TERM': 'linux', 20:40:58 INFO - 'TMOUT': '86400', 20:40:58 INFO - 'USER': 'cltbld', 20:40:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', 20:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:58 INFO - '_': '/tools/buildbot/bin/python'} 20:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:40:58 INFO - Cleaning up... 20:40:58 INFO - Return code: 0 20:40:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:58 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 0x7f1baadcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5af60>, '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 0x1d5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', '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 20:40:58 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 20:40:58 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 20:40:58 INFO - Using env: {'DISPLAY': ':0', 20:40:58 INFO - 'HOME': '/home/cltbld', 20:40:58 INFO - 'LANG': 'en_US.UTF-8', 20:40:58 INFO - 'LANGUAGE': 'en_US:en', 20:40:58 INFO - 'LOGNAME': 'cltbld', 20:40:58 INFO - 'MAIL': '/var/mail/cltbld', 20:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:58 INFO - 'MOZ_NO_REMOTE': '1', 20:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:58 INFO - 'NO_EM_RESTART': '1', 20:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:58 INFO - 'PWD': '/builds/slave/test', 20:40:58 INFO - 'SHELL': '/bin/bash', 20:40:58 INFO - 'SHLVL': '1', 20:40:58 INFO - 'TERM': 'linux', 20:40:58 INFO - 'TMOUT': '86400', 20:40:58 INFO - 'USER': 'cltbld', 20:40:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', 20:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:58 INFO - '_': '/tools/buildbot/bin/python'} 20:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:58 INFO - Downloading/unpacking blobuploader==1.2.4 20:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:00 INFO - Downloading blobuploader-1.2.4.tar.gz 20:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:41:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:41:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:41: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 20:41: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 20:41: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 20:41: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 20:41: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 20:41: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 20:41:01 INFO - Downloading docopt-0.6.1.tar.gz 20:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:41:01 INFO - Installing collected packages: blobuploader, requests, docopt 20:41:01 INFO - Running setup.py install for blobuploader 20:41:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:41:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:41:01 INFO - Running setup.py install for requests 20:41:01 INFO - Running setup.py install for docopt 20:41:01 INFO - Successfully installed blobuploader requests docopt 20:41:01 INFO - Cleaning up... 20:41:01 INFO - Return code: 0 20:41:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:41:01 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')]} 20:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:01 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')]} 20:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:01 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 0x7f1baadcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5af60>, '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 0x1d5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', '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 20:41:01 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 20:41:01 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 20:41:01 INFO - Using env: {'DISPLAY': ':0', 20:41:01 INFO - 'HOME': '/home/cltbld', 20:41:01 INFO - 'LANG': 'en_US.UTF-8', 20:41:01 INFO - 'LANGUAGE': 'en_US:en', 20:41:01 INFO - 'LOGNAME': 'cltbld', 20:41:01 INFO - 'MAIL': '/var/mail/cltbld', 20:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:01 INFO - 'MOZ_NO_REMOTE': '1', 20:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:01 INFO - 'NO_EM_RESTART': '1', 20:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:01 INFO - 'PWD': '/builds/slave/test', 20:41:01 INFO - 'SHELL': '/bin/bash', 20:41:01 INFO - 'SHLVL': '1', 20:41:01 INFO - 'TERM': 'linux', 20:41:01 INFO - 'TMOUT': '86400', 20:41:01 INFO - 'USER': 'cltbld', 20:41:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', 20:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:01 INFO - '_': '/tools/buildbot/bin/python'} 20:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:41:02 INFO - Running setup.py (path:/tmp/pip-77plde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:41:02 INFO - Running setup.py (path:/tmp/pip-JyQVHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:41:02 INFO - Running setup.py (path:/tmp/pip-0Y_Egj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:41:02 INFO - Running setup.py (path:/tmp/pip-oNKlKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:41:02 INFO - Running setup.py (path:/tmp/pip-g6PRDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:41:02 INFO - Running setup.py (path:/tmp/pip-YScDCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:41:02 INFO - Running setup.py (path:/tmp/pip-A1_1G4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:41:02 INFO - Running setup.py (path:/tmp/pip-BpRpdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:41:02 INFO - Running setup.py (path:/tmp/pip-2Teqzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:41:02 INFO - Running setup.py (path:/tmp/pip-g8UDnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:41:02 INFO - Running setup.py (path:/tmp/pip-nF9fhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:41:02 INFO - Running setup.py (path:/tmp/pip-8ZoEMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:41:03 INFO - Running setup.py (path:/tmp/pip-imKCdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:41:03 INFO - Running setup.py (path:/tmp/pip-wfrkWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:41:03 INFO - Running setup.py (path:/tmp/pip-0qC4BL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:41:03 INFO - Running setup.py (path:/tmp/pip-akXZUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:41:03 INFO - Running setup.py (path:/tmp/pip-uB_Hst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:41:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:41:03 INFO - Running setup.py install for manifestparser 20:41:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:41:03 INFO - Running setup.py install for mozcrash 20:41:03 INFO - Running setup.py install for mozdebug 20:41:03 INFO - Running setup.py install for mozdevice 20:41:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:41:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:41:03 INFO - Running setup.py install for mozfile 20:41:03 INFO - Running setup.py install for mozhttpd 20:41:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Running setup.py install for mozinfo 20:41:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Running setup.py install for mozInstall 20:41:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Running setup.py install for mozleak 20:41:04 INFO - Running setup.py install for mozlog 20:41:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Running setup.py install for moznetwork 20:41:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Running setup.py install for mozprocess 20:41:04 INFO - Running setup.py install for mozprofile 20:41:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Running setup.py install for mozrunner 20:41:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Running setup.py install for mozscreenshot 20:41:05 INFO - Running setup.py install for moztest 20:41:05 INFO - Running setup.py install for mozversion 20:41:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:41:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:41:05 INFO - Cleaning up... 20:41:05 INFO - Return code: 0 20:41:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:05 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 0x7f1baadcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5af60>, '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 0x1d5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', '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 20:41:05 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 20:41:05 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 20:41:05 INFO - Using env: {'DISPLAY': ':0', 20:41:05 INFO - 'HOME': '/home/cltbld', 20:41:05 INFO - 'LANG': 'en_US.UTF-8', 20:41:05 INFO - 'LANGUAGE': 'en_US:en', 20:41:05 INFO - 'LOGNAME': 'cltbld', 20:41:05 INFO - 'MAIL': '/var/mail/cltbld', 20:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:05 INFO - 'MOZ_NO_REMOTE': '1', 20:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:05 INFO - 'NO_EM_RESTART': '1', 20:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:05 INFO - 'PWD': '/builds/slave/test', 20:41:05 INFO - 'SHELL': '/bin/bash', 20:41:05 INFO - 'SHLVL': '1', 20:41:05 INFO - 'TERM': 'linux', 20:41:05 INFO - 'TMOUT': '86400', 20:41:05 INFO - 'USER': 'cltbld', 20:41:05 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', 20:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:05 INFO - '_': '/tools/buildbot/bin/python'} 20:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:41:05 INFO - Running setup.py (path:/tmp/pip-3hHo1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:41:05 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)) 20:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:41:05 INFO - Running setup.py (path:/tmp/pip-lCIpgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:41:05 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)) 20:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:41:05 INFO - Running setup.py (path:/tmp/pip-AwuuxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:41:05 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)) 20:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:41:05 INFO - Running setup.py (path:/tmp/pip-4pzplP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:41:05 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)) 20:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:41:05 INFO - Running setup.py (path:/tmp/pip-DohHlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:41:05 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)) 20:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:41:05 INFO - Running setup.py (path:/tmp/pip-3oPHck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:41:05 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)) 20:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:41:05 INFO - Running setup.py (path:/tmp/pip-M2cx3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:41:06 INFO - Running setup.py (path:/tmp/pip-W1ibcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:41:06 INFO - Running setup.py (path:/tmp/pip-fpwwkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:41:06 INFO - Running setup.py (path:/tmp/pip-abgQRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:41:06 INFO - Running setup.py (path:/tmp/pip-AfX1Cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:41:06 INFO - Running setup.py (path:/tmp/pip-dPQb5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:41:06 INFO - Running setup.py (path:/tmp/pip-Lf3Atb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:41:06 INFO - Running setup.py (path:/tmp/pip-NZi4XH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:41:06 INFO - Running setup.py (path:/tmp/pip-_VG9To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:41:06 INFO - Running setup.py (path:/tmp/pip-e1HpzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:41:06 INFO - Running setup.py (path:/tmp/pip-ALBX6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:41:06 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)) 20:41:06 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)) 20:41:06 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)) 20:41:06 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)) 20:41:06 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)) 20:41:06 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)) 20:41:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:41:06 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 20:41:06 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 20:41:06 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 20:41:06 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 20:41:06 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 20:41:06 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 20:41:08 INFO - Downloading blessings-1.6.tar.gz 20:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:41:08 INFO - Installing collected packages: blessings 20:41:08 INFO - Running setup.py install for blessings 20:41:08 INFO - Successfully installed blessings 20:41:08 INFO - Cleaning up... 20:41:09 INFO - Return code: 0 20:41:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:41:09 INFO - Reading from file tmpfile_stdout 20:41:09 INFO - Current package versions: 20:41:09 INFO - argparse == 1.2.1 20:41:09 INFO - blessings == 1.6 20:41:09 INFO - blobuploader == 1.2.4 20:41:09 INFO - docopt == 0.6.1 20:41:09 INFO - functools32 == 3.2.3-2 20:41:09 INFO - jsonschema == 2.5.1 20:41:09 INFO - manifestparser == 1.1 20:41:09 INFO - mozInstall == 1.12 20:41:09 INFO - mozcrash == 0.17 20:41:09 INFO - mozdebug == 0.1 20:41:09 INFO - mozdevice == 0.48 20:41:09 INFO - mozfile == 1.2 20:41:09 INFO - mozhttpd == 0.7 20:41:09 INFO - mozinfo == 0.9 20:41:09 INFO - mozleak == 0.1 20:41:09 INFO - mozlog == 3.4 20:41:09 INFO - moznetwork == 0.27 20:41:09 INFO - mozprocess == 0.23 20:41:09 INFO - mozprofile == 0.28 20:41:09 INFO - mozrunner == 6.12 20:41:09 INFO - mozscreenshot == 0.1 20:41:09 INFO - mozsystemmonitor == 0.3 20:41:09 INFO - moztest == 0.7 20:41:09 INFO - mozversion == 1.4 20:41:09 INFO - psutil == 3.1.1 20:41:09 INFO - requests == 1.2.3 20:41:09 INFO - wsgiref == 0.1.2 20:41:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:41: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')]} 20:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41: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')]} 20:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:09 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 0x7f1baadcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5af60>, '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 0x1d5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', '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 20:41:09 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 20:41:09 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 20:41:09 INFO - Using env: {'DISPLAY': ':0', 20:41:09 INFO - 'HOME': '/home/cltbld', 20:41:09 INFO - 'LANG': 'en_US.UTF-8', 20:41:09 INFO - 'LANGUAGE': 'en_US:en', 20:41:09 INFO - 'LOGNAME': 'cltbld', 20:41:09 INFO - 'MAIL': '/var/mail/cltbld', 20:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:09 INFO - 'MOZ_NO_REMOTE': '1', 20:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:09 INFO - 'NO_EM_RESTART': '1', 20:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:09 INFO - 'PWD': '/builds/slave/test', 20:41:09 INFO - 'SHELL': '/bin/bash', 20:41:09 INFO - 'SHLVL': '1', 20:41:09 INFO - 'TERM': 'linux', 20:41:09 INFO - 'TMOUT': '86400', 20:41:09 INFO - 'USER': 'cltbld', 20:41:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', 20:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:09 INFO - '_': '/tools/buildbot/bin/python'} 20:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 INFO - Cleaning up... 20:41:09 INFO - Return code: 0 20:41:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:41: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')]} 20:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41: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')]} 20:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:09 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 0x7f1baadcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5af60>, '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 0x1d5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', '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 20:41:09 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 20:41:09 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 20:41:09 INFO - Using env: {'DISPLAY': ':0', 20:41:09 INFO - 'HOME': '/home/cltbld', 20:41:09 INFO - 'LANG': 'en_US.UTF-8', 20:41:09 INFO - 'LANGUAGE': 'en_US:en', 20:41:09 INFO - 'LOGNAME': 'cltbld', 20:41:09 INFO - 'MAIL': '/var/mail/cltbld', 20:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:09 INFO - 'MOZ_NO_REMOTE': '1', 20:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:09 INFO - 'NO_EM_RESTART': '1', 20:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:09 INFO - 'PWD': '/builds/slave/test', 20:41:09 INFO - 'SHELL': '/bin/bash', 20:41:09 INFO - 'SHLVL': '1', 20:41:09 INFO - 'TERM': 'linux', 20:41:09 INFO - 'TMOUT': '86400', 20:41:09 INFO - 'USER': 'cltbld', 20:41:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', 20:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:09 INFO - '_': '/tools/buildbot/bin/python'} 20:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:41:09 INFO - Cleaning up... 20:41:09 INFO - Return code: 0 20:41:09 INFO - Running post-action listener: _resource_record_post_action 20:41:09 INFO - Running post-action listener: _start_resource_monitoring 20:41:09 INFO - Starting resource monitoring. 20:41:09 INFO - [mozharness: 2017-01-18 04:41:09.706292Z] Finished create-virtualenv step (success) 20:41:09 INFO - [mozharness: 2017-01-18 04:41:09.706783Z] Running install step. 20:41:09 INFO - Running pre-action listener: _resource_record_pre_action 20:41:09 INFO - Running main action method: install 20:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:41:09 INFO - Reading from file tmpfile_stdout 20:41:09 INFO - Detecting whether we're running mozinstall >=1.0... 20:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:41:09 INFO - Reading from file tmpfile_stdout 20:41:09 INFO - Output received: 20:41:09 INFO - Usage: mozinstall [options] installer 20:41:09 INFO - Options: 20:41:09 INFO - -h, --help show this help message and exit 20:41:09 INFO - -d DEST, --destination=DEST 20:41:09 INFO - Directory to install application into. [default: 20:41:09 INFO - "/builds/slave/test"] 20:41:09 INFO - --app=APP Application being installed. [default: firefox] 20:41:09 INFO - mkdir: /builds/slave/test/build/application 20:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:41:23 INFO - Reading from file tmpfile_stdout 20:41:23 INFO - Output received: 20:41:23 INFO - /builds/slave/test/build/application/firefox/firefox 20:41:23 INFO - Running post-action listener: _resource_record_post_action 20:41:23 INFO - [mozharness: 2017-01-18 04:41:23.506091Z] Finished install step (success) 20:41:23 INFO - [mozharness: 2017-01-18 04:41:23.506371Z] Running run-tests step. 20:41:23 INFO - Running pre-action listener: _resource_record_pre_action 20:41:23 INFO - Running main action method: run_tests 20:41:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:41:23 INFO - Python 2.7.3 20:41:23 INFO - Return code: 0 20:41:23 INFO - grabbing minidump binary from tooltool 20:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:23 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 0x1d5af60>, '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 0x1d5bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:41:23 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 20:41:23 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 20:41:23 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 20:41:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:41:23 INFO - Return code: 0 20:41:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:41:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:41:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:41:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:41:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:41:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 20:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 20:41:23 INFO - Using env: {'DISPLAY': ':0', 20:41:23 INFO - 'HOME': '/home/cltbld', 20:41:23 INFO - 'LANG': 'en_US.UTF-8', 20:41:23 INFO - 'LANGUAGE': 'en_US:en', 20:41:23 INFO - 'LOGNAME': 'cltbld', 20:41:23 INFO - 'MAIL': '/var/mail/cltbld', 20:41:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:41:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:23 INFO - 'MOZ_NO_REMOTE': '1', 20:41:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:23 INFO - 'NO_EM_RESTART': '1', 20:41:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:23 INFO - 'PWD': '/builds/slave/test', 20:41:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:41:23 INFO - 'SHELL': '/bin/bash', 20:41:23 INFO - 'SHLVL': '1', 20:41:23 INFO - 'TERM': 'linux', 20:41:23 INFO - 'TMOUT': '86400', 20:41:23 INFO - 'USER': 'cltbld', 20:41:23 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612', 20:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:23 INFO - '_': '/tools/buildbot/bin/python'} 20:41:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 20:41:23 INFO - mozversion application_buildid: 20170117184445 20:41:23 INFO - mozversion application_changeset: 5bf843087b55bcdeab912ac01cd5596673071f69 20:41:23 INFO - mozversion application_display_name: Firefox 20:41:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:41:23 INFO - mozversion application_name: Firefox 20:41:23 INFO - mozversion application_remotingname: firefox 20:41:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:41:23 INFO - mozversion application_vendor: Mozilla 20:41:23 INFO - mozversion application_version: 51.0 20:41:23 INFO - mozversion platform_buildid: 20170117184445 20:41:23 INFO - mozversion platform_changeset: 5bf843087b55bcdeab912ac01cd5596673071f69 20:41:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:41:23 INFO - mozversion platform_version: 51.0 20:41:23 INFO - using testdate: 1484714483 20:41:23 INFO - actual date: 1484714483 20:41:23 INFO - starting webserver on 'localhost:39056' 20:41:23 INFO - SUITE-START | Running 2 tests 20:41:23 INFO - TEST-START | dromaeo_css 20:41:23 INFO - operating with platform_type : linux_ 20:41:23 INFO - Initialising browser for dromaeo_css test... 20:41:23 INFO - TEST-INFO | started process 9461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDNEPQj/profile http://localhost:39056/getInfo.html) 20:41:27 INFO - PROCESS | 9461 | __metrics Screen width/height:1600/1200 20:41:27 INFO - PROCESS | 9461 | colorDepth:24 20:41:27 INFO - PROCESS | 9461 | Browser inner width/height: 1024/697 20:41:27 INFO - PROCESS | 9461 | __metrics 20:41:28 INFO - PROCESS | 9461 | 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" 20:41:28 INFO - PROCESS | 9461 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:41:28 INFO - PROCESS | 9461 | console.error: PushService: 20:41:28 INFO - PROCESS | 9461 | stateChangeProcessEnqueue: Error transitioning state 20:41:28 INFO - PROCESS | 9461 | UnknownError 20:41:29 INFO - TEST-INFO | 9461: exit 0 20:41:29 INFO - Browser initialized. 20:41:29 INFO - Running cycle 1/1 for dromaeo_css test... 20:41:29 INFO - TEST-INFO | started process 9552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDNEPQj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:41:41 INFO - PROCESS | 9552 | RSS: Main: 143888384 20:41:41 INFO - PROCESS | 9552 | 20:42:32 INFO - PROCESS | 9552 | 1484714552086 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] 20:44:40 INFO - PROCESS | 9552 | Cycle 1(1): loaded http://localhost:39056/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39056/tests/dromaeo/cssquery-ext.html) 20:44:42 INFO - PROCESS | 9552 | RSS: Main: 275468288 20:44:42 INFO - PROCESS | 9552 | 20:47:44 INFO - PROCESS | 9552 | Cycle 1(1): loaded http://localhost:39056/tests/dromaeo/cssquery-ext.html (next: http://localhost:39056/tests/dromaeo/cssquery-jquery.html) 20:47:45 INFO - PROCESS | 9552 | RSS: Main: 231911424 20:47:45 INFO - PROCESS | 9552 | 20:50:47 INFO - PROCESS | 9552 | Cycle 1(1): loaded http://localhost:39056/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39056/tests/dromaeo/cssquery-mootools.html) 20:50:47 INFO - PROCESS | 9552 | RSS: Main: 176324608 20:50:47 INFO - PROCESS | 9552 | 20:53:49 INFO - PROCESS | 9552 | Cycle 1(1): loaded http://localhost:39056/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39056/tests/dromaeo/cssquery-prototype.html) 20:53:50 INFO - PROCESS | 9552 | RSS: Main: 176197632 20:53:50 INFO - PROCESS | 9552 | 20:56:52 INFO - PROCESS | 9552 | Cycle 1(1): loaded http://localhost:39056/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39056/tests/dromaeo/cssquery-yui.html) 20:56:53 INFO - PROCESS | 9552 | RSS: Main: 176009216 20:56:53 INFO - PROCESS | 9552 | 20:59:55 INFO - PROCESS | 9552 | Cycle 1(1): loaded http://localhost:39056/tests/dromaeo/cssquery-yui.html (next: http://localhost:39056/tests/dromaeo/cssquery-dojo.html) 20:59:56 INFO - PROCESS | 9552 | RSS: Main: 259977216 20:59:56 INFO - PROCESS | 9552 | 20:59:56 INFO - PROCESS | 9552 | __start_tp_report 20:59:56 INFO - PROCESS | 9552 | _x_x_mozilla_page_load 20:59:56 INFO - PROCESS | 9552 | _x_x_mozilla_page_load_details 20:59:56 INFO - PROCESS | 9552 | |i|pagename|runs| 20:59:56 INFO - PROCESS | 9552 | |0;dojo.html;3098.271906102066;3138.262508310547;3153.369326134772;3162.683731626836;3180.5229215617655;5503.11950087986;5583.5254003409655;5608.214849921004;5609.691466969315;5635.577331700123;5559.916601250984;5604.831855044345;5611.270534830476;5622.465865742758;5623.775048998045;5029.094762942669;5050;5087.186050231963;5122.334096567441;5122.6158038147105;4943.283223932528;4954.752262386866;5106.336176297076;5163.63854530183;5197.1424714922;4989.75051247438;5009.298698182258;5018.272350509174;5054.064997975368;5055.848324550269;5086.491350864921;5104.923426148593;5163.277141200235;5173.3533308336455;5193.766280517386;4823.5176482351835;5059;5076.466970968069;5109.4379618241965;5138.10083235436;5421.674699518042;5453.100238460689;5534.05920993428;5546.417626149237;5566.832995010156;5972.761089556412;5975.312839023524;5990.071538911432;5991.970040149815;5994.790182343597;5697.4587414195585;5959.165716799652;6035.879282414371;6047.304559975615;6047.334793172748;5373.650712703701;5513.862153446196;5564.749586268627;5574.777008919679;5658.519025882846;6116.877662446726;6116.938830611637;6127.2647282325515;6127.295361033449;6130.29501607312;5899.616524925866;5903.26209223847;5914.9112763308585;5915.822525324247;5916.763329466773;5625.803096891671;5709.8287051388525;5722.027255366597;5839.036558967723;5842.269716285465;5764.279465066867;5788.507976822018;5795.072788353843;5795.623284486495;5802.448767367094;5767.077267637158;5818.679972601548;5836.095405212199;5916.2013128228;5916.319623243296;4541.613962813198;4545.38637283969;4546.113507866001;4548.295014272727;4554.590086892195;4042.5148982121746;4047.595240475988;4050;4059.7767122807936;4065.7357271777832;5446.400895901447;5487.890242195213;5499.615026948075;5505;5562.888742225214;5966.134910438049;5968.492678122321;5968.791092311748;5970.880582388328;5971.104334349882;5590.5248053915875;5633.0705433603;5636.210930469738;5640.097584386478;5648.491635752802;5009.524095210949;5078.289039534468;5126.743662816844;5178.326817513699;5183.118869792144;6192.659403732838;6196.721147548371;6204.13142160089;6206.937930620636;6209.5032397408095;6012.368701286302;6019.849503762266;6020.096985452217;6023.48800351975;6055.424734650377;5900.5574581907385;5943.316518600416;6058.394160583906;6061.7575296987625;6176.629402235881;5880.764769409176;5917.467427931507;5927;5953.880922381441;5968;5931.110333450017;5975.37258587842;5992.340842507234;5996.730147143477;6005.819825405245;5606.24315717373;5648.435156484319;5751.597388182787;5800.8259752207505;5906.055031194988;5886.882262354815;5889;5891;5906.497947674324;5919.230500034968;5809.796657116981;5810.157527158453;5810.854728631818;5814.156947242542;5815.41845815415;5565.5825813063375;5619.634723742944;5761.56788240892;5896.734646940984;5912.911306330322;5634;5691.686957217393;5728;5728.79949201776;5773.942260577341 20:59:56 INFO - PROCESS | 9552 | |1;ext.html;583.2913010692012;614.6435067660756;650.4568685147905;652.4649787174517;669.9229588597312;34279;34901.47647785282;36693;45521.317180242324;46681.766591167;46096.53903460965;46470.30294545584;46562.06875862481;46578.30132548015;46582.301265481045;9172.633094676205;9320.8601870972;9330;9332.720018399425;9338.673146439876;8557.828843423127;8805.691800786974;9166.54167291636;10769.569217231301;11087.445627718622;11235.943820280887;11315.151363647718;11316.434178291094;11317.886821131808;11319.490622921947;11056.281341712764;11066.28069175501;11089.778204435946;11122.944385278022;11127.387993660346;10878.184136189817;10936.945315273453;10938.070264027567;10944.616938407196;10947.781044379068;44080.338794918105;44125.3381199279;44315.113697726185;44511.77744111259;44564;3834.501514803058;4017;4156.43888075109;4235.576442355739;4351.173277077345;33065.834670826494;33130;33178.33643327144;33182;33290.833545832356;4594.150082234797;4634.128185404822;4680.438347398334;4704.694194877322;4820.638452116105;348767;350202.248988756;351949;353095;355009;38484.61515384867;60542.394576054554;61143.38856611377;61276.38723612707;61386;39031.609683902796;41081.589184107776;41193.79403103025;41397.1720565587;41421.79289103535;15878.44425445127;15967.562919337315;16009.359625615078;16038.839611603735;16044.679106417807;12911.5480958166;13132.080754347104;13225.140365876186;13225.801612975813;13227.007974401959;8699.564571845702;9229.584668689926;9427.952860235655;9430.622775089058;9596.952015240018;3638.43604241343;3674.9632503675157;3680.5031320771354;3688.944665830015;3750.268697603941;988.7923536057365;1014.4369874719454;1074.3178081917881;1083.6803143072812;1160.4139909345727;32798.50802237968;33282;33343;33508.664913351044;33625.49561756576;1102.4928532874808;1121.5738019552682;1190.7499425120648;1198.6934241676615;1227.4599176362372;16438.178091095397;16714.4149954751;16999.915000425168;17023.31906723742;17420.390286339916;544706;549352;549368;552713;553176;59089.40910590925;59482.10776838351;59526.70236648876;59596.70201648964;59624;1315.4869600855675;1342.7851543752952;1377.3801789194902;1382.384838746748;1416.7449859025473;31599.84200078985;33075.50386744249;34891.47662785111;35180.47229291512;35468.29063418769;55453;56466;56548.7172564151;56609.71695141498;56642.716786415804;492992;502350;503826;505826;507141;39871;41096.38355424611;43513.56486435095;45939.54060459352;47166.29250561176;50127.74936125296;50352.49647503478;50570.24144637907;50762.2385664208;51691;42879.785601071795;42996.140077197655;43231.78384108059;43583.56416435922;44728;42692;43713.78143109264;43889.561104388544;43943.121137577706;44652.33021504615;43030.13939721251;43642.781786092135;44021.77989110034;44142.11715765602;44322.335164971904;35928.64071359357;38752.80623596864;39518.60481395264;39713.991636542545;39729.40405893972;29045.12864614065;29403.558946616246;29446.705532945252;29615.25961850971;29853.402931941673 20:59:56 INFO - PROCESS | 9552 | |2;jquery.html;412.1900465585127;423.2297219061306;426.185984769091;429.35382249714183;448.7262769710476;18938.905305473472;20023.299184528525;20618.793812061893;20895.268665596668;21172;16293.02241865489;18982.905085474587;19598.31405900794;19795.406137815888;19927.800721992775;5172.250023746555;5392.164214546732;5394.8921021579545;5395.892082158354;5401.351837779453;3929.3909444036076;4046.3930410438525;5312.096943519592;5383.596230282725;5384.138537833947;5717.485426311631;5818.301803783531;5824.184614154022;5824.883502329972;5839.941600584004;5588;5796.913046304308;5804.158397032428;5809.6804675742815;5953.017752070903;5745.339285982082;5752.913706294409;5754.050581654022;5755.395683453219;5761.107028410603;12956.416961236768;12963.351832408436;12971.221726696429;12989.87010129896;13013.284269365182;2484.2795589279267;2675.906343277976;2724.6049322848075;2787.623670804456;3057.6330840299306;10030.34802737827;10449.425281609585;10613.84079238812;10802;10870.239083264096;1953.4042117154263;1999.6500612392917;2028.756549214089;2032.8373730101557;2033.196887229536;77316.92993719345;84627.57686211591;85379;86648.56675716644;91251;11774;11902.464389102512;12044.33756143403;12158.939205303917;12316.445759940645;17087.572810679583;17098.487045388658;17153.228104735317;17162.22769975354;17163.485095446908;8507.744767656981;8534.359923005675;8539;8562.614682339185;8632.482051076955;7940.563269020144;8060.267042585872;8095.919040809635;8152.592370381576;8359.373047021498;5063.544281014726;5151.2530683050745;5154.664946778523;5202.24567437727;5282.683039017595;2077.200277893022;2100.5273813391864;2152.784721527835;2176.434127126958;2211.6240239159383;940.4404379394249;969.680005598151;1007.4156988946394;1010.3382284603449;1057.476549108181;19139.425817225507;19623.607527849363;19679.40961771149;19737.703934440993;19880.50298742543;970.0493516354013;1004.8794144702537;1010.4139599032543;1016.2885979814159;1033.6692258477215;11018.228723989405;11348.602798901999;11525.135614828921;11549.36478493674;12124.878751212551;465563;466759;488400;526116;530111;100603.49698251608;100657;101234;104988.47505762575;105512;1051.2956319265957;1077.5420446310286;1087.6247694545368;1090.6346373964811;1096.090245096568;17663.82336176622;18860.434186974413;19207.231710731416;19309.613807724047;19601.80398196057;41907.37138942979;44197.337039943784;44453.77773111243;44515.77742111269;45377.319340209266;58262;58302.12546811886;58641;59490;60328.698356507935;8848.469091854251;8869.246114080375;8967.282617390723;9045.276377889884;9663.855042174233;7521.360684341892;11719.355435451133;12690.619281421572;12832.29422381778;13342.19946803195;11967.880321196677;12344.691382715504;12513;12516.249025058525;12562.371881406076;12208.633740987785;12271.631851044483;12284.0786940978;12393.380330983595;12713.36433178356;11993.280403175837;12356.320402377956;12576.930960868063;12581.433835477608;12622;8726.956365218133;8898.55507224649;8925.196732294125;9131.863022054542;9561.282903782105;9123.087691230823;12017.939910300393;12343.259404435763;12393.814092788434;12490.188137771016 20:59:56 INFO - PROCESS | 9552 | |3;mootools.html;1362.6048445950676;1522.3834347089428;1523.8019057522524;1714.939977100801;1813.8186181381855;7710.460267781257;8769.166929141737;9078.273738100952;9093.090690930912;9360.953195234015;9125.954370228155;9210.815783684338;9217.631294748218;9231.769205769859;9244.214241789456;2407.1454633605035;2429.538387706339;2431.088341871798;2431.9392015199583;2436.1717016214484;2342.8711420871846;2382.5592265430864;2385.3678775124604;2387.6299173628117;2388.3073908566494;2352.9647055294186;2354.0348457132577;2370.8103351731907;2381.833271670984;2382.059086660768;2232.1964092926532;2240.0591751464344;2248.291788086756;2250.874562718641;2313.9421514462106;2273.943151421211;2275.328778010491;2279.2136712834044;2281.840271181018;2282.281081459335;8863.379563430562;9148.725538233864;9216.907830921738;9234.353595248336;9242.815143697155;5314.707691076989;5532.75102620379;5538.086215774392;5552.91670624941;5562.7774889004395;3410.0392274442297;3422.5037369581273;3435.4331535296647;3459.809710465923;3488.8255587220538;1230.1819290172025;1245.906557008228;1265.3483456020158;1281.218456741387;1292.8642492538243;12300.138990270685;12389.876101239053;12406.503739850485;12411.75176496465;12415.379231038502;4397.560243975641;4574.153781550423;4664.113818374498;4749.833755818529;4777.784999675023;9459.52702364879;9508.477033763209;9511.524423778783;9523.90476095244;9526.571304291323;5365.946340536545;5395.514403703685;5400.432954539717;5401.8109366172785;5407.459254074561;4378.0806030733265;4511.075229577928;4949;5065.924011139836;5099.59203263738;4109.97945010273;4113.341865301538;4189.49726032878;4218.978905105455;4219.746815191098;1204.9939750301191;1229.416027386984;1235.7590269897464;1238.5726924211133;1247.5945317771761;884.6284560484612;987.9703608891745;995.6664517386612;1003.1272792670424;1019.6176433837311;5891.646501209942;5973.522118230531;6079.483243924227;6161.568690191733;6163.476104531075;487.8463284065508;488.0531768369352;490.69822059433903;493.7777999900059;498.6858279284028;4282.443282373334;4320.222359975234;4361.5856493633055;4423.491298500714;4584.037352156018;11376;11433;11551.88448115508;11558.537658493735;11569.132315076404;11440.485178167002;11463.598774042868;11473.196876218584;11496.367699776592;11499.252548584314;8077.555734434545;8403.579821008925;8418.621162047722;8506.31949444043;8588.52763098023;6240.719167637558;6306.621602703853;6327.683615819283;6452.7741529048135;6469.838254043687;10441.582336706446;10540.262181647211;10712;10783.460826958777;10864.511097000495;10562.207834412604;10929;10941.343519388862;10970.067544258827;11016.339019658846;8137.918620813716;8302.294304984143;8361;8408.2432581068;8415.873761893454;8840.778980525281;8864.468131912106;8930.687425940321;8958.641654333753;8962;8100.87848682282;8124;8149.6332665031405;8205.302549283138;8302.460340077876;7934.722284720007;8004.759857204293;8014.318782903519;8041.959790201012;8054.194580541899;6950.16598008222;6972.895406568804;6976.267491913276;7056.435485161277;7097.574145551283;5436.972815135899;5451.536619387238;5464.06700781793;5504.9174262385295;5629.634073785191;5378.623496355218;5531.679120681664;5536.667799932017;5537;5541.418151094238 20:59:56 INFO - PROCESS | 9552 | |4;prototype.html;336.89219449776067;342.72924389732106;343.510497541004;349.1637528120154;350.2364844638688;5481.205225242343;5503.7798488060525;5505.861658854455;5522.66863988161;5552.417560995117;5428.782848686048;5464.26232458619;5481.917771233435;5484.698341591211;5485.6434331768505;4088.918221635573;4156.854510092147;4186.476690413699;4228.577142285762;4324.54592267812;4267.14657068586;4281.272183728774;4296.183725092238;4297.312430011199;4330.805113769872;4244.469441319835;4257.76582287974;4264.978675106636;4265.7014009019385;4276.273033584298;4061.7969101544954;4245.978770106145;4253.276942919681;4275.6745408923025;4293.3989241506215;3744.2698673758628;3756.6243375662216;3758.4362345648096;3761.6990640748672;3765.362067500646;5340.25236466895;5358.758855851496;5377.75800088993;5390.56875449967;5401.918971215435;4627.629789616823;4834.758262086882;4918.754062296906;4924.409070911478;4928.926066109011;5645;5707;5714.085746280575;5714.942850571482;5724.341700704389;4114.382842573608;4122.958770412318;4124.422236102436;4131.442255295527;4143.97928010361;5788.942110578882;5901.822945311605;5926.466618004357;5953.34513203543;5968.538247816256;4213.1784302060805;4213.97893010533;4215.831366745296;4216.30430978885;4224.66202703783;4282.314829627245;4302.65578753699;4317.913641727211;4327.32926396409;4328.783560821947;4718.31584420264;4821.879453013633;4859.781309841065;4905.656604037755;4910.607151427948;5724;5730.389854391707;5745.052066408995;5749.154168686443;5751.798687045934;1444.6821699226152;1465.501729412005;1468.3906178935836;1468.4052958551804;1470.6985068061235;885.856114631299;931.6971984105193;937.381328323317;939.8026414452904;966.1401352796017;5413.53984911287;5569.470900264469;5573.331200255914;5579.358373786985;5583.609147359727;5888.882222355614;5915.615484993462;5921.496672782861;5940.138679891392;5944.762209511571;5449;5508.394076651565;5536.972315138479;5564.638298510584;5578.832635020955;3085.5988721466065;3091.92270193247;3094.4275309067893;3140.7016333448287;3146.7325277351224;5775.48020678141;5998.610090344201;6067.302260240041;6080.513558915276;6081.239845019372;6034.336223015464;6041.607295525777;6071;6081.685481412641;6098.603590766586;6101.725422356005;6114.5414093942245;6116.235470566179;6121.540884433685;6139.907901381483;5696.1455781633085;5919.230500034968;5932.733027013708;5968.731407086605;5975.133605627247;5829.183914251923;5832.416758324133;5834.94165058344;5868.354481007001;5871.7651293947765;5793.36273009977;6042.335343112166;6104.298005729398;6120.173776540289;6137.478314343331;4236.940764808798;4245.61789438952;4251.9787401062795;4253.425787518645;4273.380359847867;5891.646501209942;5903.321118071477;5930.318013428511;5938.8218353449465;5943.23639507631;5681.9431805681415;5773.307203135482;5790.536757059509;5808.186853840381;5820.9813282676205;5743.770249189985;5774.162746401832;5779.826605201851;5790.565707572033;5796.449337312949;5336.439673834191;5723;5734.34055083654;5738.196652468741;5745.913811292918;5368.597355198453;5750.367459579359;5811.854703632443;5815.273090863642;5823.194809609035;5677.672154416669;5690.886182276414;5714.9142762857755;5718.313802343745;5719.342275638355 20:59:56 INFO - PROCESS | 9552 | |5;yui.html;748.8951546783451;781.3397678961279;793.1869833420747;817.9100298967113;851.068080451905;16823.57941051473;17191.570210744736;17646.470605881826;17689.027103509317;17847.82152178478;16023.759643605355;16281.83718162818;16297.266623001964;16326.34694612217;16328.428505002328;725.310954593136;741.2735519191195;844.5608283692476;848.2577744473585;858.3819649852096;855.9957200214021;874.615169325498;877.2105105405122;877.4998250996935;877.6138499060424;912.2428384440898;917.0645941140033;917.7797328641145;918.4030380252823;918.4489306416131;902.747230775384;909.5043201455189;911.289194428347;911.589784596934;911.7766147293955;672.7477196051481;673.0577191931286;674.0159367323713;674.0260323832065;674.0260323832065;16337.428190013292;16383.09892955887;16447;16482.670346593;16499.752503712454;16745.83254167455;17031.82968170327;17325.393611223673;17428.912855435767;17897.19462624185;12360.320182389965;12379.814302785466;12462.379890614162;12467.501299947991;12800.679983000406;4163.084121493267;4196.3705444183315;4234.597713217239;4268.935965960513;4306.892327691833;71019.64490177568;73854.26145738582;85202;85487.57256213741;85565.57217213936;11951.282923024646;12080.758384832254;12182.269063856196;12389.318587477776;12409.06931980105;22046.88976555107;22149.778502214773;22180.223692170697;22193.11227550912;22205.111795528323;9239.769005774775;9262.120098590623;9283.25733941283;9384.718458446258;9462.52687365629;4944.406671199407;4964.950350496449;4970.62720295972;5112.233165025276;5319.547838433699;3747.4940882980995;3880.4373365861793;3884.7086468514976;3889.922201555953;3891.805409729502;576.711644177911;650.4633677216316;653.8986457099157;655.465795376776;655.4821690864164;646.8382904273932;663.2405895249912;739.971439698819;806.3992325717378;833.1335411172435;10417.374957502574;11074.169437292074;11111.666650000512;11269.71825704364;11549.249298795552;627.4102343796816;700.9824754381079;701.4353445476338;780.469280889001;795.8607243732439;5179.223116532475;5232.9125815768875;5240.187770895517;5334.17320315344;5346.385165705916;66923.61072974448;68410;68461.65769171123;70042;127447;108240;108692.82614347669;110339;110752.4462377683;114134.42932785283;61900.38099618946;68330.65834670795;95496;98444.50777746209;100820;9715.36850104741;9969.50152492387;10179.338343007681;10212.795744084928;10269.486525673836;55090.72454637862;55682.72158639181;56990.715046424506;57022.7148864253;58737.41262587319;75159;81425;83467;84676;84747.5762621183;12598.3070931096;12847.164934279243;13104.082714210295;13240.801387978996;13272.27002514871;14416.351264192926;14462.20457874785;14530.782038269223;15329.156896370361;15744.134072626115;13102.279374634105;13757.518486852912;13804.516841910485;13808.240546770025;14182.290885455479;13588.86411135876;13762.449502019806;13806.585802425943;13911.721765564835;14174.29128543548;10017.59929602837;13607.387667554785;14324.57026289213;14525.932029865078;15104.848951510783;11228.55085796559;11437.370944598128;11869.406529673655;12149.81775273354;12523.37383130858;12325.383730813603;12717.936410317889;12816.551420700604;13065.934670326587;13174.868251317364 20:59:56 INFO - PROCESS | 9552 | __end_tp_report 20:59:56 INFO - PROCESS | 9552 | __start_cc_report 20:59:56 INFO - PROCESS | 9552 | _x_x_mozilla_cycle_collect,1123 20:59:56 INFO - PROCESS | 9552 | __end_cc_report 20:59:56 INFO - PROCESS | 9552 | __startTimestamp1484715596012__endTimestamp 20:59:56 INFO - PROCESS | 9552 | 20:59:56 INFO - PROCESS | 9552 | ------- Summary: start ------- 20:59:56 INFO - PROCESS | 9552 | Number of tests: 6 20:59:56 INFO - PROCESS | 9552 | 20:59:56 INFO - PROCESS | 9552 | [#0] dojo.html Cycles:165 Average:5515.38 Median:5697.46 stddev:632.81 (11.1%) stddev-sans-first:605.68 20:59:56 INFO - PROCESS | 9552 | Values: 3098.3 3138.3 3153.4 3162.7 3180.5 5503.1 5583.5 5608.2 5609.7 5635.6 5559.9 5604.8 5611.3 5622.5 5623.8 5029.1 5050.0 5087.2 5122.3 5122.6 4943.3 4954.8 5106.3 5163.6 5197.1 4989.8 5009.3 5018.3 5054.1 5055.8 5086.5 5104.9 5163.3 5173.4 5193.8 4823.5 5059.0 5076.5 5109.4 5138.1 5421.7 5453.1 5534.1 5546.4 5566.8 5972.8 5975.3 5990.1 5992.0 5994.8 5697.5 5959.2 6035.9 6047.3 6047.3 5373.7 5513.9 5564.7 5574.8 5658.5 6116.9 6116.9 6127.3 6127.3 6130.3 5899.6 5903.3 5914.9 5915.8 5916.8 5625.8 5709.8 5722.0 5839.0 5842.3 5764.3 5788.5 5795.1 5795.6 5802.4 5767.1 5818.7 5836.1 5916.2 5916.3 4541.6 4545.4 4546.1 4548.3 4554.6 4042.5 4047.6 4050.0 4059.8 4065.7 5446.4 5487.9 5499.6 5505.0 5562.9 5966.1 5968.5 5968.8 5970.9 5971.1 5590.5 5633.1 5636.2 5640.1 5648.5 5009.5 5078.3 5126.7 5178.3 5183.1 6192.7 6196.7 6204.1 6206.9 6209.5 6012.4 6019.8 6020.1 6023.5 6055.4 5900.6 5943.3 6058.4 6061.8 6176.6 5880.8 5917.5 5927.0 5953.9 5968.0 5931.1 5975.4 5992.3 5996.7 6005.8 5606.2 5648.4 5751.6 5800.8 5906.1 5886.9 5889.0 5891.0 5906.5 5919.2 5809.8 5810.2 5810.9 5814.2 5815.4 5565.6 5619.6 5761.6 5896.7 5912.9 5634.0 5691.7 5728.0 5728.8 5773.9 20:59:56 INFO - PROCESS | 9552 | 20:59:56 INFO - PROCESS | 9552 | [#1] ext.html Cycles:180 Average:62946.59 Median:41145.09 stddev:126256.79 (306.9%) stddev-sans-first:126524.15 20:59:56 INFO - PROCESS | 9552 | Values: 583.3 614.6 650.5 652.5 669.9 34279.0 34901.5 36693.0 45521.3 46681.8 46096.5 46470.3 46562.1 46578.3 46582.3 9172.6 9320.9 9330.0 9332.7 9338.7 8557.8 8805.7 9166.5 10769.6 11087.4 11235.9 11315.2 11316.4 11317.9 11319.5 11056.3 11066.3 11089.8 11122.9 11127.4 10878.2 10936.9 10938.1 10944.6 10947.8 44080.3 44125.3 44315.1 44511.8 44564.0 3834.5 4017.0 4156.4 4235.6 4351.2 33065.8 33130.0 33178.3 33182.0 33290.8 4594.2 4634.1 4680.4 4704.7 4820.6 348767.0 350202.2 351949.0 353095.0 355009.0 38484.6 60542.4 61143.4 61276.4 61386.0 39031.6 41081.6 41193.8 41397.2 41421.8 15878.4 15967.6 16009.4 16038.8 16044.7 12911.5 13132.1 13225.1 13225.8 13227.0 8699.6 9229.6 9428.0 9430.6 9597.0 3638.4 3675.0 3680.5 3688.9 3750.3 988.8 1014.4 1074.3 1083.7 1160.4 32798.5 33282.0 33343.0 33508.7 33625.5 1102.5 1121.6 1190.7 1198.7 1227.5 16438.2 16714.4 16999.9 17023.3 17420.4 544706.0 549352.0 549368.0 552713.0 553176.0 59089.4 59482.1 59526.7 59596.7 59624.0 1315.5 1342.8 1377.4 1382.4 1416.7 31599.8 33075.5 34891.5 35180.5 35468.3 55453.0 56466.0 56548.7 56609.7 56642.7 492992.0 502350.0 503826.0 505826.0 507141.0 39871.0 41096.4 43513.6 45939.5 47166.3 50127.7 50352.5 50570.2 50762.2 51691.0 42879.8 42996.1 43231.8 43583.6 44728.0 42692.0 43713.8 43889.6 43943.1 44652.3 43030.1 43642.8 44021.8 44142.1 44322.3 35928.6 38752.8 39518.6 39714.0 39729.4 29045.1 29403.6 29446.7 29615.3 29853.4 20:59:56 INFO - PROCESS | 9552 | 20:59:56 INFO - PROCESS | 9552 | [#2] jquery.html Cycles:180 Average:29625.30 Median:11636.26 stddev:82118.90 (705.7%) stddev-sans-first:82319.97 20:59:56 INFO - PROCESS | 9552 | Values: 412.2 423.2 426.2 429.4 448.7 18938.9 20023.3 20618.8 20895.3 21172.0 16293.0 18982.9 19598.3 19795.4 19927.8 5172.3 5392.2 5394.9 5395.9 5401.4 3929.4 4046.4 5312.1 5383.6 5384.1 5717.5 5818.3 5824.2 5824.9 5839.9 5588.0 5796.9 5804.2 5809.7 5953.0 5745.3 5752.9 5754.1 5755.4 5761.1 12956.4 12963.4 12971.2 12989.9 13013.3 2484.3 2675.9 2724.6 2787.6 3057.6 10030.3 10449.4 10613.8 10802.0 10870.2 1953.4 1999.7 2028.8 2032.8 2033.2 77316.9 84627.6 85379.0 86648.6 91251.0 11774.0 11902.5 12044.3 12158.9 12316.4 17087.6 17098.5 17153.2 17162.2 17163.5 8507.7 8534.4 8539.0 8562.6 8632.5 7940.6 8060.3 8095.9 8152.6 8359.4 5063.5 5151.3 5154.7 5202.2 5282.7 2077.2 2100.5 2152.8 2176.4 2211.6 940.4 969.7 1007.4 1010.3 1057.5 19139.4 19623.6 19679.4 19737.7 19880.5 970.0 1004.9 1010.4 1016.3 1033.7 11018.2 11348.6 11525.1 11549.4 12124.9 465563.0 466759.0 488400.0 526116.0 530111.0 100603.5 100657.0 101234.0 104988.5 105512.0 1051.3 1077.5 1087.6 1090.6 1096.1 17663.8 18860.4 19207.2 19309.6 19601.8 41907.4 44197.3 44453.8 44515.8 45377.3 58262.0 58302.1 58641.0 59490.0 60328.7 8848.5 8869.2 8967.3 9045.3 9663.9 7521.4 11719.4 12690.6 12832.3 13342.2 11967.9 12344.7 12513.0 12516.2 12562.4 12208.6 12271.6 12284.1 12393.4 12713.4 11993.3 12356.3 12576.9 12581.4 12622.0 8727.0 8898.6 8925.2 9131.9 9561.3 9123.1 12017.9 12343.3 12393.8 12490.2 20:59:56 INFO - PROCESS | 9552 | 20:59:56 INFO - PROCESS | 9552 | [#3] mootools.html Cycles:180 Average:5983.60 Median:489.38 stddev:3429.83 (700.9%) stddev-sans-first:3421.87 20:59:56 INFO - PROCESS | 9552 | Values: 1362.6 1522.4 1523.8 1714.9 1813.8 7710.5 8769.2 9078.3 9093.1 9361.0 9126.0 9210.8 9217.6 9231.8 9244.2 2407.1 2429.5 2431.1 2431.9 2436.2 2342.9 2382.6 2385.4 2387.6 2388.3 2353.0 2354.0 2370.8 2381.8 2382.1 2232.2 2240.1 2248.3 2250.9 2313.9 2273.9 2275.3 2279.2 2281.8 2282.3 8863.4 9148.7 9216.9 9234.4 9242.8 5314.7 5532.8 5538.1 5552.9 5562.8 3410.0 3422.5 3435.4 3459.8 3488.8 1230.2 1245.9 1265.3 1281.2 1292.9 12300.1 12389.9 12406.5 12411.8 12415.4 4397.6 4574.2 4664.1 4749.8 4777.8 9459.5 9508.5 9511.5 9523.9 9526.6 5365.9 5395.5 5400.4 5401.8 5407.5 4378.1 4511.1 4949.0 5065.9 5099.6 4110.0 4113.3 4189.5 4219.0 4219.7 1205.0 1229.4 1235.8 1238.6 1247.6 884.6 988.0 995.7 1003.1 1019.6 5891.6 5973.5 6079.5 6161.6 6163.5 487.8 488.1 490.7 493.8 498.7 4282.4 4320.2 4361.6 4423.5 4584.0 11376.0 11433.0 11551.9 11558.5 11569.1 11440.5 11463.6 11473.2 11496.4 11499.3 8077.6 8403.6 8418.6 8506.3 8588.5 6240.7 6306.6 6327.7 6452.8 6469.8 10441.6 10540.3 10712.0 10783.5 10864.5 10562.2 10929.0 10941.3 10970.1 11016.3 8137.9 8302.3 8361.0 8408.2 8415.9 8840.8 8864.5 8930.7 8958.6 8962.0 8100.9 8124.0 8149.6 8205.3 8302.5 7934.7 8004.8 8014.3 8042.0 8054.2 6950.2 6972.9 6976.3 7056.4 7097.6 5437.0 5451.5 5464.1 5504.9 5629.6 5378.6 5531.7 5536.7 5537.0 5541.4 20:59:56 INFO - PROCESS | 9552 | 20:59:56 INFO - PROCESS | 9552 | [#4] prototype.html Cycles:180 Average:4844.53 Median:5558.53 stddev:1430.42 (25.7%) stddev-sans-first:1393.84 20:59:56 INFO - PROCESS | 9552 | Values: 336.9 342.7 343.5 349.2 350.2 5481.2 5503.8 5505.9 5522.7 5552.4 5428.8 5464.3 5481.9 5484.7 5485.6 4088.9 4156.9 4186.5 4228.6 4324.5 4267.1 4281.3 4296.2 4297.3 4330.8 4244.5 4257.8 4265.0 4265.7 4276.3 4061.8 4246.0 4253.3 4275.7 4293.4 3744.3 3756.6 3758.4 3761.7 3765.4 5340.3 5358.8 5377.8 5390.6 5401.9 4627.6 4834.8 4918.8 4924.4 4928.9 5645.0 5707.0 5714.1 5714.9 5724.3 4114.4 4123.0 4124.4 4131.4 4144.0 5788.9 5901.8 5926.5 5953.3 5968.5 4213.2 4214.0 4215.8 4216.3 4224.7 4282.3 4302.7 4317.9 4327.3 4328.8 4718.3 4821.9 4859.8 4905.7 4910.6 5724.0 5730.4 5745.1 5749.2 5751.8 1444.7 1465.5 1468.4 1468.4 1470.7 885.9 931.7 937.4 939.8 966.1 5413.5 5569.5 5573.3 5579.4 5583.6 5888.9 5915.6 5921.5 5940.1 5944.8 5449.0 5508.4 5537.0 5564.6 5578.8 3085.6 3091.9 3094.4 3140.7 3146.7 5775.5 5998.6 6067.3 6080.5 6081.2 6034.3 6041.6 6071.0 6081.7 6098.6 6101.7 6114.5 6116.2 6121.5 6139.9 5696.1 5919.2 5932.7 5968.7 5975.1 5829.2 5832.4 5834.9 5868.4 5871.8 5793.4 6042.3 6104.3 6120.2 6137.5 4236.9 4245.6 4252.0 4253.4 4273.4 5891.6 5903.3 5930.3 5938.8 5943.2 5681.9 5773.3 5790.5 5808.2 5821.0 5743.8 5774.2 5779.8 5790.6 5796.4 5336.4 5723.0 5734.3 5738.2 5745.9 5368.6 5750.4 5811.9 5815.3 5823.2 5677.7 5690.9 5714.9 5718.3 5719.3 20:59:56 INFO - PROCESS | 9552 | 20:59:56 INFO - PROCESS | 9552 | [#5] yui.html Cycles:180 Average:21067.00 Median:4179.73 stddev:29297.95 (701.0%) stddev-sans-first:29340.41 20:59:56 INFO - PROCESS | 9552 | Values: 748.9 781.3 793.2 817.9 851.1 16823.6 17191.6 17646.5 17689.0 17847.8 16023.8 16281.8 16297.3 16326.3 16328.4 725.3 741.3 844.6 848.3 858.4 856.0 874.6 877.2 877.5 877.6 912.2 917.1 917.8 918.4 918.4 902.7 909.5 911.3 911.6 911.8 672.7 673.1 674.0 674.0 674.0 16337.4 16383.1 16447.0 16482.7 16499.8 16745.8 17031.8 17325.4 17428.9 17897.2 12360.3 12379.8 12462.4 12467.5 12800.7 4163.1 4196.4 4234.6 4268.9 4306.9 71019.6 73854.3 85202.0 85487.6 85565.6 11951.3 12080.8 12182.3 12389.3 12409.1 22046.9 22149.8 22180.2 22193.1 22205.1 9239.8 9262.1 9283.3 9384.7 9462.5 4944.4 4965.0 4970.6 5112.2 5319.5 3747.5 3880.4 3884.7 3889.9 3891.8 576.7 650.5 653.9 655.5 655.5 646.8 663.2 740.0 806.4 833.1 10417.4 11074.2 11111.7 11269.7 11549.2 627.4 701.0 701.4 780.5 795.9 5179.2 5232.9 5240.2 5334.2 5346.4 66923.6 68410.0 68461.7 70042.0 127447.0 108240.0 108692.8 110339.0 110752.4 114134.4 61900.4 68330.7 95496.0 98444.5 100820.0 9715.4 9969.5 10179.3 10212.8 10269.5 55090.7 55682.7 56990.7 57022.7 58737.4 75159.0 81425.0 83467.0 84676.0 84747.6 12598.3 12847.2 13104.1 13240.8 13272.3 14416.4 14462.2 14530.8 15329.2 15744.1 13102.3 13757.5 13804.5 13808.2 14182.3 13588.9 13762.4 13806.6 13911.7 14174.3 10017.6 13607.4 14324.6 14525.9 15104.8 11228.6 11437.4 11869.4 12149.8 12523.4 12325.4 12717.9 12816.6 13065.9 13174.9 20:59:56 INFO - PROCESS | 9552 | -------- Summary: end -------- 20:59:56 INFO - PROCESS | 9552 | 20:59:56 INFO - TEST-INFO | 9552: exit 0 20:59:56 INFO - TEST-OK | dromaeo_css | took 1112951ms 20:59:56 INFO - TEST-START | kraken 20:59:56 INFO - operating with platform_type : linux_ 20:59:56 INFO - Initialising browser for kraken test... 20:59:56 INFO - TEST-INFO | started process 9857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmofd13/profile http://localhost:39056/getInfo.html) 21:00:00 INFO - PROCESS | 9857 | __metrics Screen width/height:1600/1200 21:00:00 INFO - PROCESS | 9857 | colorDepth:24 21:00:00 INFO - PROCESS | 9857 | Browser inner width/height: 1024/697 21:00:00 INFO - PROCESS | 9857 | __metrics 21:00:01 INFO - PROCESS | 9857 | 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" 21:00:01 INFO - PROCESS | 9857 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:00:01 INFO - PROCESS | 9857 | console.error: PushService: 21:00:01 INFO - PROCESS | 9857 | stateChangeProcessEnqueue: Error transitioning state 21:00:01 INFO - PROCESS | 9857 | UnknownError 21:00:02 INFO - TEST-INFO | 9857: exit 0 21:00:02 INFO - Browser initialized. 21:00:02 INFO - Running cycle 1/1 for kraken test... 21:00:02 INFO - TEST-INFO | started process 9952 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmofd13/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:00:13 INFO - PROCESS | 9952 | RSS: Main: 143597568 21:00:13 INFO - PROCESS | 9952 | 21:00:16 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39056/tests/kraken/driver.html?testName=audio-beat-detection) 21:00:17 INFO - PROCESS | 9952 | RSS: Main: 186445824 21:00:17 INFO - PROCESS | 9952 | 21:00:19 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39056/tests/kraken/driver.html?testName=audio-dft) 21:00:20 INFO - PROCESS | 9952 | RSS: Main: 174940160 21:00:20 INFO - PROCESS | 9952 | 21:00:23 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39056/tests/kraken/driver.html?testName=audio-fft) 21:00:23 INFO - PROCESS | 9952 | RSS: Main: 265940992 21:00:23 INFO - PROCESS | 9952 | 21:00:25 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39056/tests/kraken/driver.html?testName=audio-oscillator) 21:00:26 INFO - PROCESS | 9952 | RSS: Main: 172883968 21:00:26 INFO - PROCESS | 9952 | 21:00:28 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39056/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:00:29 INFO - PROCESS | 9952 | RSS: Main: 174043136 21:00:29 INFO - PROCESS | 9952 | 21:00:32 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39056/tests/kraken/driver.html?testName=imaging-darkroom) 21:00:32 INFO - PROCESS | 9952 | RSS: Main: 210112512 21:00:32 INFO - PROCESS | 9952 | 21:00:35 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39056/tests/kraken/driver.html?testName=imaging-desaturate) 21:00:36 INFO - PROCESS | 9952 | RSS: Main: 209485824 21:00:36 INFO - PROCESS | 9952 | 21:00:39 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39056/tests/kraken/driver.html?testName=json-parse-financial) 21:00:39 INFO - PROCESS | 9952 | RSS: Main: 208855040 21:00:39 INFO - PROCESS | 9952 | 21:00:41 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39056/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:00:41 INFO - PROCESS | 9952 | RSS: Main: 170442752 21:00:41 INFO - PROCESS | 9952 | 21:00:43 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39056/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:00:44 INFO - PROCESS | 9952 | RSS: Main: 178561024 21:00:44 INFO - PROCESS | 9952 | 21:00:46 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39056/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:00:46 INFO - PROCESS | 9952 | RSS: Main: 187469824 21:00:46 INFO - PROCESS | 9952 | 21:00:49 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:00:49 INFO - PROCESS | 9952 | RSS: Main: 195973120 21:00:49 INFO - PROCESS | 9952 | 21:00:52 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:00:53 INFO - PROCESS | 9952 | RSS: Main: 192847872 21:00:53 INFO - PROCESS | 9952 | 21:00:54 INFO - PROCESS | 9952 | Cycle 1(1): loaded http://localhost:39056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39056/tests/kraken/driver.html?testName=ai-astar) 21:00:55 INFO - PROCESS | 9952 | RSS: Main: 244396032 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | __start_tp_report 21:00:55 INFO - PROCESS | 9952 | _x_x_mozilla_page_load 21:00:55 INFO - PROCESS | 9952 | _x_x_mozilla_page_load_details 21:00:55 INFO - PROCESS | 9952 | |i|pagename|runs| 21:00:55 INFO - PROCESS | 9952 | |0;ai-astar;111;109;111;109;110;112;109;109;110;109 21:00:55 INFO - PROCESS | 9952 | |1;audio-beat-detection;141;115;116;162;122;123;124;117;150;121 21:00:55 INFO - PROCESS | 9952 | |2;audio-dft;159;160;161;161;160;162;159;161;160;160 21:00:55 INFO - PROCESS | 9952 | |3;audio-fft;75;76;75;104;75;76;74;75;100;75 21:00:55 INFO - PROCESS | 9952 | |4;audio-oscillator;81;81;121;82;81;81;98;81;82;102 21:00:55 INFO - PROCESS | 9952 | |5;imaging-gaussian-blur;116;117;116;117;116;117;116;116;116;117 21:00:55 INFO - PROCESS | 9952 | |6;imaging-darkroom;148;145;146;145;147;147;146;146;146;146 21:00:55 INFO - PROCESS | 9952 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;94;95 21:00:55 INFO - PROCESS | 9952 | |8;json-parse-financial;51;51;51;48;49;48;50;52;50;48 21:00:55 INFO - PROCESS | 9952 | |9;json-stringify-tinderbox;57;57;57;57;58;57;57;58;57;57 21:00:55 INFO - PROCESS | 9952 | |10;stanford-crypto-aes;74;73;72;78;73;81;74;74;73;73 21:00:55 INFO - PROCESS | 9952 | |11;stanford-crypto-ccm;136;130;123;121;128;117;118;118;162;125 21:00:55 INFO - PROCESS | 9952 | |12;stanford-crypto-pbkdf2;153;156;154;153;153;152;149;152;154;149 21:00:55 INFO - PROCESS | 9952 | |13;stanford-crypto-sha256-iterative;62;66;66;62;62;64;66;62;61;61 21:00:55 INFO - PROCESS | 9952 | __end_tp_report 21:00:55 INFO - PROCESS | 9952 | __start_cc_report 21:00:55 INFO - PROCESS | 9952 | _x_x_mozilla_cycle_collect,1599 21:00:55 INFO - PROCESS | 9952 | __end_cc_report 21:00:55 INFO - PROCESS | 9952 | __startTimestamp1484715655106__endTimestamp 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | ------- Summary: start ------- 21:00:55 INFO - PROCESS | 9952 | Number of tests: 14 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:1.10 (1.0%) stddev-sans-first:1.09 21:00:55 INFO - PROCESS | 9952 | Values: 111.0 109.0 111.0 109.0 110.0 112.0 109.0 109.0 110.0 109.0 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:123.50 stddev:16.18 (13.1%) stddev-sans-first:16.58 21:00:55 INFO - PROCESS | 9952 | Values: 141.0 115.0 116.0 162.0 122.0 123.0 124.0 117.0 150.0 121.0 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 21:00:55 INFO - PROCESS | 9952 | Values: 159.0 160.0 161.0 161.0 160.0 162.0 159.0 161.0 160.0 160.0 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:11.38 (15.2%) stddev-sans-first:11.90 21:00:55 INFO - PROCESS | 9952 | Values: 75.0 76.0 75.0 104.0 75.0 76.0 74.0 75.0 100.0 75.0 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:81.00 stddev:13.71 (16.9%) stddev-sans-first:14.23 21:00:55 INFO - PROCESS | 9952 | Values: 81.0 81.0 121.0 82.0 81.0 81.0 98.0 81.0 82.0 102.0 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 21:00:55 INFO - PROCESS | 9952 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 116.0 117.0 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 21:00:55 INFO - PROCESS | 9952 | Values: 148.0 145.0 146.0 145.0 147.0 147.0 146.0 146.0 146.0 146.0 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 21:00:55 INFO - PROCESS | 9952 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:50.50 stddev:1.48 (2.9%) stddev-sans-first:1.50 21:00:55 INFO - PROCESS | 9952 | Values: 51.0 51.0 51.0 48.0 49.0 48.0 50.0 52.0 50.0 48.0 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 21:00:55 INFO - PROCESS | 9952 | Values: 57.0 57.0 57.0 57.0 58.0 57.0 57.0 58.0 57.0 57.0 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:2.80 (3.8%) stddev-sans-first:2.96 21:00:55 INFO - PROCESS | 9952 | Values: 74.0 73.0 72.0 78.0 73.0 81.0 74.0 74.0 73.0 73.0 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:126.50 stddev:13.45 (10.6%) stddev-sans-first:13.93 21:00:55 INFO - PROCESS | 9952 | Values: 136.0 130.0 123.0 121.0 128.0 117.0 118.0 118.0 162.0 125.0 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:153.00 stddev:2.17 (1.4%) stddev-sans-first:2.30 21:00:55 INFO - PROCESS | 9952 | Values: 153.0 156.0 154.0 153.0 153.0 152.0 149.0 152.0 154.0 149.0 21:00:55 INFO - PROCESS | 9952 | 21:00:55 INFO - PROCESS | 9952 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:2.10 (3.3%) stddev-sans-first:2.18 21:00:55 INFO - PROCESS | 9952 | Values: 62.0 66.0 66.0 62.0 62.0 64.0 66.0 62.0 61.0 61.0 21:00:55 INFO - PROCESS | 9952 | -------- Summary: end -------- 21:00:55 INFO - PROCESS | 9952 | 21:00:56 INFO - TEST-INFO | 9952: exit 0 21:00:56 INFO - TEST-OK | kraken | took 59313ms 21:00:56 INFO - SUITE-END | took 1172s 21:00:56 INFO - Completed test suite (00:19:32) 21:00:56 INFO - javascript benchmark 21:00:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3098.271906102066, 3138.262508310547, 3153.369326134772, 3162.683731626836, 3180.5229215617655, 5503.11950087986, 5583.5254003409655, 5608.214849921004, 5609.691466969315, 5635.577331700123, 5559.916601250984, 5604.831855044345, 5611.270534830476, 5622.465865742758, 5623.775048998045, 5029.094762942669, 5050.0, 5087.186050231963, 5122.334096567441, 5122.6158038147105, 4943.283223932528, 4954.752262386866, 5106.336176297076, 5163.63854530183, 5197.1424714922, 4989.75051247438, 5009.298698182258, 5018.272350509174, 5054.064997975368, 5055.848324550269, 5086.491350864921, 5104.923426148593, 5163.277141200235, 5173.3533308336455, 5193.766280517386, 4823.5176482351835, 5059.0, 5076.466970968069, 5109.4379618241965, 5138.10083235436, 5421.674699518042, 5453.100238460689, 5534.05920993428, 5546.417626149237, 5566.832995010156, 5972.761089556412, 5975.312839023524, 5990.071538911432, 5991.970040149815, 5994.790182343597, 5697.4587414195585, 5959.165716799652, 6035.879282414371, 6047.304559975615, 6047.334793172748, 5373.650712703701, 5513.862153446196, 5564.749586268627, 5574.777008919679, 5658.519025882846, 6116.877662446726, 6116.938830611637, 6127.2647282325515, 6127.295361033449, 6130.29501607312, 5899.616524925866, 5903.26209223847, 5914.9112763308585, 5915.822525324247, 5916.763329466773, 5625.803096891671, 5709.8287051388525, 5722.027255366597, 5839.036558967723, 5842.269716285465, 5764.279465066867, 5788.507976822018, 5795.072788353843, 5795.623284486495, 5802.448767367094, 5767.077267637158, 5818.679972601548, 5836.095405212199, 5916.2013128228, 5916.319623243296, 4541.613962813198, 4545.38637283969, 4546.113507866001, 4548.295014272727, 4554.590086892195, 4042.5148982121746, 4047.595240475988, 4050.0, 4059.7767122807936, 4065.7357271777832, 5446.400895901447, 5487.890242195213, 5499.615026948075, 5505.0, 5562.888742225214, 5966.134910438049, 5968.492678122321, 5968.791092311748, 5970.880582388328, 5971.104334349882, 5590.5248053915875, 5633.0705433603, 5636.210930469738, 5640.097584386478, 5648.491635752802, 5009.524095210949, 5078.289039534468, 5126.743662816844, 5178.326817513699, 5183.118869792144, 6192.659403732838, 6196.721147548371, 6204.13142160089, 6206.937930620636, 6209.5032397408095, 6012.368701286302, 6019.849503762266, 6020.096985452217, 6023.48800351975, 6055.424734650377, 5900.5574581907385, 5943.316518600416, 6058.394160583906, 6061.7575296987625, 6176.629402235881, 5880.764769409176, 5917.467427931507, 5927.0, 5953.880922381441, 5968.0, 5931.110333450017, 5975.37258587842, 5992.340842507234, 5996.730147143477, 6005.819825405245, 5606.24315717373, 5648.435156484319, 5751.597388182787, 5800.8259752207505, 5906.055031194988, 5886.882262354815, 5889.0, 5891.0, 5906.497947674324, 5919.230500034968, 5809.796657116981, 5810.157527158453, 5810.854728631818, 5814.156947242542, 5815.41845815415, 5565.5825813063375, 5619.634723742944, 5761.56788240892, 5896.734646940984, 5912.911306330322, 5634.0, 5691.686957217393, 5728.0, 5728.79949201776, 5773.942260577341], "value": 5471.861010194778, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.2913010692012, 614.6435067660756, 650.4568685147905, 652.4649787174517, 669.9229588597312, 34279.0, 34901.47647785282, 36693.0, 45521.317180242324, 46681.766591167, 46096.53903460965, 46470.30294545584, 46562.06875862481, 46578.30132548015, 46582.301265481045, 9172.633094676205, 9320.8601870972, 9330.0, 9332.720018399425, 9338.673146439876, 8557.828843423127, 8805.691800786974, 9166.54167291636, 10769.569217231301, 11087.445627718622, 11235.943820280887, 11315.151363647718, 11316.434178291094, 11317.886821131808, 11319.490622921947, 11056.281341712764, 11066.28069175501, 11089.778204435946, 11122.944385278022, 11127.387993660346, 10878.184136189817, 10936.945315273453, 10938.070264027567, 10944.616938407196, 10947.781044379068, 44080.338794918105, 44125.3381199279, 44315.113697726185, 44511.77744111259, 44564.0, 3834.501514803058, 4017.0, 4156.43888075109, 4235.576442355739, 4351.173277077345, 33065.834670826494, 33130.0, 33178.33643327144, 33182.0, 33290.833545832356, 4594.150082234797, 4634.128185404822, 4680.438347398334, 4704.694194877322, 4820.638452116105, 348767.0, 350202.248988756, 351949.0, 353095.0, 355009.0, 38484.61515384867, 60542.394576054554, 61143.38856611377, 61276.38723612707, 61386.0, 39031.609683902796, 41081.589184107776, 41193.79403103025, 41397.1720565587, 41421.79289103535, 15878.44425445127, 15967.562919337315, 16009.359625615078, 16038.839611603735, 16044.679106417807, 12911.5480958166, 13132.080754347104, 13225.140365876186, 13225.801612975813, 13227.007974401959, 8699.564571845702, 9229.584668689926, 9427.952860235655, 9430.622775089058, 9596.952015240018, 3638.43604241343, 3674.9632503675157, 3680.5031320771354, 3688.944665830015, 3750.268697603941, 988.7923536057365, 1014.4369874719454, 1074.3178081917881, 1083.6803143072812, 1160.4139909345727, 32798.50802237968, 33282.0, 33343.0, 33508.664913351044, 33625.49561756576, 1102.4928532874808, 1121.5738019552682, 1190.7499425120648, 1198.6934241676615, 1227.4599176362372, 16438.178091095397, 16714.4149954751, 16999.915000425168, 17023.31906723742, 17420.390286339916, 544706.0, 549352.0, 549368.0, 552713.0, 553176.0, 59089.40910590925, 59482.10776838351, 59526.70236648876, 59596.70201648964, 59624.0, 1315.4869600855675, 1342.7851543752952, 1377.3801789194902, 1382.384838746748, 1416.7449859025473, 31599.84200078985, 33075.50386744249, 34891.47662785111, 35180.47229291512, 35468.29063418769, 55453.0, 56466.0, 56548.7172564151, 56609.71695141498, 56642.716786415804, 492992.0, 502350.0, 503826.0, 505826.0, 507141.0, 39871.0, 41096.38355424611, 43513.56486435095, 45939.54060459352, 47166.29250561176, 50127.74936125296, 50352.49647503478, 50570.24144637907, 50762.2385664208, 51691.0, 42879.785601071795, 42996.140077197655, 43231.78384108059, 43583.56416435922, 44728.0, 42692.0, 43713.78143109264, 43889.561104388544, 43943.121137577706, 44652.33021504615, 43030.13939721251, 43642.781786092135, 44021.77989110034, 44142.11715765602, 44322.335164971904, 35928.64071359357, 38752.80623596864, 39518.60481395264, 39713.991636542545, 39729.40405893972, 29045.12864614065, 29403.558946616246, 29446.705532945252, 29615.25961850971, 29853.402931941673], "value": 20445.5089852289, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.1900465585127, 423.2297219061306, 426.185984769091, 429.35382249714183, 448.7262769710476, 18938.905305473472, 20023.299184528525, 20618.793812061893, 20895.268665596668, 21172.0, 16293.02241865489, 18982.905085474587, 19598.31405900794, 19795.406137815888, 19927.800721992775, 5172.250023746555, 5392.164214546732, 5394.8921021579545, 5395.892082158354, 5401.351837779453, 3929.3909444036076, 4046.3930410438525, 5312.096943519592, 5383.596230282725, 5384.138537833947, 5717.485426311631, 5818.301803783531, 5824.184614154022, 5824.883502329972, 5839.941600584004, 5588.0, 5796.913046304308, 5804.158397032428, 5809.6804675742815, 5953.017752070903, 5745.339285982082, 5752.913706294409, 5754.050581654022, 5755.395683453219, 5761.107028410603, 12956.416961236768, 12963.351832408436, 12971.221726696429, 12989.87010129896, 13013.284269365182, 2484.2795589279267, 2675.906343277976, 2724.6049322848075, 2787.623670804456, 3057.6330840299306, 10030.34802737827, 10449.425281609585, 10613.84079238812, 10802.0, 10870.239083264096, 1953.4042117154263, 1999.6500612392917, 2028.756549214089, 2032.8373730101557, 2033.196887229536, 77316.92993719345, 84627.57686211591, 85379.0, 86648.56675716644, 91251.0, 11774.0, 11902.464389102512, 12044.33756143403, 12158.939205303917, 12316.445759940645, 17087.572810679583, 17098.487045388658, 17153.228104735317, 17162.22769975354, 17163.485095446908, 8507.744767656981, 8534.359923005675, 8539.0, 8562.614682339185, 8632.482051076955, 7940.563269020144, 8060.267042585872, 8095.919040809635, 8152.592370381576, 8359.373047021498, 5063.544281014726, 5151.2530683050745, 5154.664946778523, 5202.24567437727, 5282.683039017595, 2077.200277893022, 2100.5273813391864, 2152.784721527835, 2176.434127126958, 2211.6240239159383, 940.4404379394249, 969.680005598151, 1007.4156988946394, 1010.3382284603449, 1057.476549108181, 19139.425817225507, 19623.607527849363, 19679.40961771149, 19737.703934440993, 19880.50298742543, 970.0493516354013, 1004.8794144702537, 1010.4139599032543, 1016.2885979814159, 1033.6692258477215, 11018.228723989405, 11348.602798901999, 11525.135614828921, 11549.36478493674, 12124.878751212551, 465563.0, 466759.0, 488400.0, 526116.0, 530111.0, 100603.49698251608, 100657.0, 101234.0, 104988.47505762575, 105512.0, 1051.2956319265957, 1077.5420446310286, 1087.6247694545368, 1090.6346373964811, 1096.090245096568, 17663.82336176622, 18860.434186974413, 19207.231710731416, 19309.613807724047, 19601.80398196057, 41907.37138942979, 44197.337039943784, 44453.77773111243, 44515.77742111269, 45377.319340209266, 58262.0, 58302.12546811886, 58641.0, 59490.0, 60328.698356507935, 8848.469091854251, 8869.246114080375, 8967.282617390723, 9045.276377889884, 9663.855042174233, 7521.360684341892, 11719.355435451133, 12690.619281421572, 12832.29422381778, 13342.19946803195, 11967.880321196677, 12344.691382715504, 12513.0, 12516.249025058525, 12562.371881406076, 12208.633740987785, 12271.631851044483, 12284.0786940978, 12393.380330983595, 12713.36433178356, 11993.280403175837, 12356.320402377956, 12576.930960868063, 12581.433835477608, 12622.0, 8726.956365218133, 8898.55507224649, 8925.196732294125, 9131.863022054542, 9561.282903782105, 9123.087691230823, 12017.939910300393, 12343.259404435763, 12393.814092788434, 12490.188137771016], "value": 9404.05234767813, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.6048445950676, 1522.3834347089428, 1523.8019057522524, 1714.939977100801, 1813.8186181381855, 7710.460267781257, 8769.166929141737, 9078.273738100952, 9093.090690930912, 9360.953195234015, 9125.954370228155, 9210.815783684338, 9217.631294748218, 9231.769205769859, 9244.214241789456, 2407.1454633605035, 2429.538387706339, 2431.088341871798, 2431.9392015199583, 2436.1717016214484, 2342.8711420871846, 2382.5592265430864, 2385.3678775124604, 2387.6299173628117, 2388.3073908566494, 2352.9647055294186, 2354.0348457132577, 2370.8103351731907, 2381.833271670984, 2382.059086660768, 2232.1964092926532, 2240.0591751464344, 2248.291788086756, 2250.874562718641, 2313.9421514462106, 2273.943151421211, 2275.328778010491, 2279.2136712834044, 2281.840271181018, 2282.281081459335, 8863.379563430562, 9148.725538233864, 9216.907830921738, 9234.353595248336, 9242.815143697155, 5314.707691076989, 5532.75102620379, 5538.086215774392, 5552.91670624941, 5562.7774889004395, 3410.0392274442297, 3422.5037369581273, 3435.4331535296647, 3459.809710465923, 3488.8255587220538, 1230.1819290172025, 1245.906557008228, 1265.3483456020158, 1281.218456741387, 1292.8642492538243, 12300.138990270685, 12389.876101239053, 12406.503739850485, 12411.75176496465, 12415.379231038502, 4397.560243975641, 4574.153781550423, 4664.113818374498, 4749.833755818529, 4777.784999675023, 9459.52702364879, 9508.477033763209, 9511.524423778783, 9523.90476095244, 9526.571304291323, 5365.946340536545, 5395.514403703685, 5400.432954539717, 5401.8109366172785, 5407.459254074561, 4378.0806030733265, 4511.075229577928, 4949.0, 5065.924011139836, 5099.59203263738, 4109.97945010273, 4113.341865301538, 4189.49726032878, 4218.978905105455, 4219.746815191098, 1204.9939750301191, 1229.416027386984, 1235.7590269897464, 1238.5726924211133, 1247.5945317771761, 884.6284560484612, 987.9703608891745, 995.6664517386612, 1003.1272792670424, 1019.6176433837311, 5891.646501209942, 5973.522118230531, 6079.483243924227, 6161.568690191733, 6163.476104531075, 487.8463284065508, 488.0531768369352, 490.69822059433903, 493.7777999900059, 498.6858279284028, 4282.443282373334, 4320.222359975234, 4361.5856493633055, 4423.491298500714, 4584.037352156018, 11376.0, 11433.0, 11551.88448115508, 11558.537658493735, 11569.132315076404, 11440.485178167002, 11463.598774042868, 11473.196876218584, 11496.367699776592, 11499.252548584314, 8077.555734434545, 8403.579821008925, 8418.621162047722, 8506.31949444043, 8588.52763098023, 6240.719167637558, 6306.621602703853, 6327.683615819283, 6452.7741529048135, 6469.838254043687, 10441.582336706446, 10540.262181647211, 10712.0, 10783.460826958777, 10864.511097000495, 10562.207834412604, 10929.0, 10941.343519388862, 10970.067544258827, 11016.339019658846, 8137.918620813716, 8302.294304984143, 8361.0, 8408.2432581068, 8415.873761893454, 8840.778980525281, 8864.468131912106, 8930.687425940321, 8958.641654333753, 8962.0, 8100.87848682282, 8124.0, 8149.6332665031405, 8205.302549283138, 8302.460340077876, 7934.722284720007, 8004.759857204293, 8014.318782903519, 8041.959790201012, 8054.194580541899, 6950.16598008222, 6972.895406568804, 6976.267491913276, 7056.435485161277, 7097.574145551283, 5436.972815135899, 5451.536619387238, 5464.06700781793, 5504.9174262385295, 5629.634073785191, 5378.623496355218, 5531.679120681664, 5536.667799932017, 5537.0, 5541.418151094238], "value": 4698.737366460837, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.89219449776067, 342.72924389732106, 343.510497541004, 349.1637528120154, 350.2364844638688, 5481.205225242343, 5503.7798488060525, 5505.861658854455, 5522.66863988161, 5552.417560995117, 5428.782848686048, 5464.26232458619, 5481.917771233435, 5484.698341591211, 5485.6434331768505, 4088.918221635573, 4156.854510092147, 4186.476690413699, 4228.577142285762, 4324.54592267812, 4267.14657068586, 4281.272183728774, 4296.183725092238, 4297.312430011199, 4330.805113769872, 4244.469441319835, 4257.76582287974, 4264.978675106636, 4265.7014009019385, 4276.273033584298, 4061.7969101544954, 4245.978770106145, 4253.276942919681, 4275.6745408923025, 4293.3989241506215, 3744.2698673758628, 3756.6243375662216, 3758.4362345648096, 3761.6990640748672, 3765.362067500646, 5340.25236466895, 5358.758855851496, 5377.75800088993, 5390.56875449967, 5401.918971215435, 4627.629789616823, 4834.758262086882, 4918.754062296906, 4924.409070911478, 4928.926066109011, 5645.0, 5707.0, 5714.085746280575, 5714.942850571482, 5724.341700704389, 4114.382842573608, 4122.958770412318, 4124.422236102436, 4131.442255295527, 4143.97928010361, 5788.942110578882, 5901.822945311605, 5926.466618004357, 5953.34513203543, 5968.538247816256, 4213.1784302060805, 4213.97893010533, 4215.831366745296, 4216.30430978885, 4224.66202703783, 4282.314829627245, 4302.65578753699, 4317.913641727211, 4327.32926396409, 4328.783560821947, 4718.31584420264, 4821.879453013633, 4859.781309841065, 4905.656604037755, 4910.607151427948, 5724.0, 5730.389854391707, 5745.052066408995, 5749.154168686443, 5751.798687045934, 1444.6821699226152, 1465.501729412005, 1468.3906178935836, 1468.4052958551804, 1470.6985068061235, 885.856114631299, 931.6971984105193, 937.381328323317, 939.8026414452904, 966.1401352796017, 5413.53984911287, 5569.470900264469, 5573.331200255914, 5579.358373786985, 5583.609147359727, 5888.882222355614, 5915.615484993462, 5921.496672782861, 5940.138679891392, 5944.762209511571, 5449.0, 5508.394076651565, 5536.972315138479, 5564.638298510584, 5578.832635020955, 3085.5988721466065, 3091.92270193247, 3094.4275309067893, 3140.7016333448287, 3146.7325277351224, 5775.48020678141, 5998.610090344201, 6067.302260240041, 6080.513558915276, 6081.239845019372, 6034.336223015464, 6041.607295525777, 6071.0, 6081.685481412641, 6098.603590766586, 6101.725422356005, 6114.5414093942245, 6116.235470566179, 6121.540884433685, 6139.907901381483, 5696.1455781633085, 5919.230500034968, 5932.733027013708, 5968.731407086605, 5975.133605627247, 5829.183914251923, 5832.416758324133, 5834.94165058344, 5868.354481007001, 5871.7651293947765, 5793.36273009977, 6042.335343112166, 6104.298005729398, 6120.173776540289, 6137.478314343331, 4236.940764808798, 4245.61789438952, 4251.9787401062795, 4253.425787518645, 4273.380359847867, 5891.646501209942, 5903.321118071477, 5930.318013428511, 5938.8218353449465, 5943.23639507631, 5681.9431805681415, 5773.307203135482, 5790.536757059509, 5808.186853840381, 5820.9813282676205, 5743.770249189985, 5774.162746401832, 5779.826605201851, 5790.565707572033, 5796.449337312949, 5336.439673834191, 5723.0, 5734.34055083654, 5738.196652468741, 5745.913811292918, 5368.597355198453, 5750.367459579359, 5811.854703632443, 5815.273090863642, 5823.194809609035, 5677.672154416669, 5690.886182276414, 5714.9142762857755, 5718.313802343745, 5719.342275638355], "value": 4384.649284534198, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.8951546783451, 781.3397678961279, 793.1869833420747, 817.9100298967113, 851.068080451905, 16823.57941051473, 17191.570210744736, 17646.470605881826, 17689.027103509317, 17847.82152178478, 16023.759643605355, 16281.83718162818, 16297.266623001964, 16326.34694612217, 16328.428505002328, 725.310954593136, 741.2735519191195, 844.5608283692476, 848.2577744473585, 858.3819649852096, 855.9957200214021, 874.615169325498, 877.2105105405122, 877.4998250996935, 877.6138499060424, 912.2428384440898, 917.0645941140033, 917.7797328641145, 918.4030380252823, 918.4489306416131, 902.747230775384, 909.5043201455189, 911.289194428347, 911.589784596934, 911.7766147293955, 672.7477196051481, 673.0577191931286, 674.0159367323713, 674.0260323832065, 674.0260323832065, 16337.428190013292, 16383.09892955887, 16447.0, 16482.670346593, 16499.752503712454, 16745.83254167455, 17031.82968170327, 17325.393611223673, 17428.912855435767, 17897.19462624185, 12360.320182389965, 12379.814302785466, 12462.379890614162, 12467.501299947991, 12800.679983000406, 4163.084121493267, 4196.3705444183315, 4234.597713217239, 4268.935965960513, 4306.892327691833, 71019.64490177568, 73854.26145738582, 85202.0, 85487.57256213741, 85565.57217213936, 11951.282923024646, 12080.758384832254, 12182.269063856196, 12389.318587477776, 12409.06931980105, 22046.88976555107, 22149.778502214773, 22180.223692170697, 22193.11227550912, 22205.111795528323, 9239.769005774775, 9262.120098590623, 9283.25733941283, 9384.718458446258, 9462.52687365629, 4944.406671199407, 4964.950350496449, 4970.62720295972, 5112.233165025276, 5319.547838433699, 3747.4940882980995, 3880.4373365861793, 3884.7086468514976, 3889.922201555953, 3891.805409729502, 576.711644177911, 650.4633677216316, 653.8986457099157, 655.465795376776, 655.4821690864164, 646.8382904273932, 663.2405895249912, 739.971439698819, 806.3992325717378, 833.1335411172435, 10417.374957502574, 11074.169437292074, 11111.666650000512, 11269.71825704364, 11549.249298795552, 627.4102343796816, 700.9824754381079, 701.4353445476338, 780.469280889001, 795.8607243732439, 5179.223116532475, 5232.9125815768875, 5240.187770895517, 5334.17320315344, 5346.385165705916, 66923.61072974448, 68410.0, 68461.65769171123, 70042.0, 127447.0, 108240.0, 108692.82614347669, 110339.0, 110752.4462377683, 114134.42932785283, 61900.38099618946, 68330.65834670795, 95496.0, 98444.50777746209, 100820.0, 9715.36850104741, 9969.50152492387, 10179.338343007681, 10212.795744084928, 10269.486525673836, 55090.72454637862, 55682.72158639181, 56990.715046424506, 57022.7148864253, 58737.41262587319, 75159.0, 81425.0, 83467.0, 84676.0, 84747.5762621183, 12598.3070931096, 12847.164934279243, 13104.082714210295, 13240.801387978996, 13272.27002514871, 14416.351264192926, 14462.20457874785, 14530.782038269223, 15329.156896370361, 15744.134072626115, 13102.279374634105, 13757.518486852912, 13804.516841910485, 13808.240546770025, 14182.290885455479, 13588.86411135876, 13762.449502019806, 13806.585802425943, 13911.721765564835, 14174.29128543548, 10017.59929602837, 13607.387667554785, 14324.57026289213, 14525.932029865078, 15104.848951510783, 11228.55085796559, 11437.370944598128, 11869.406529673655, 12149.81775273354, 12523.37383130858, 12325.383730813603, 12717.936410317889, 12816.551420700604, 13065.934670326587, 13174.868251317364], "value": 7968.992065797714, "unit": "score"}], "name": "dromaeo_css", "value": 7462.800628196137, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 111.0, 109.0, 110.0, 112.0, 109.0, 109.0, 110.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 115.0, 116.0, 162.0, 122.0, 123.0, 124.0, 117.0, 150.0, 121.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 161.0, 161.0, 160.0, 162.0, 159.0, 161.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 104.0, 75.0, 76.0, 74.0, 75.0, 100.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 121.0, 82.0, 81.0, 81.0, 98.0, 81.0, 82.0, 102.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 146.0, 145.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 48.0, 49.0, 48.0, 50.0, 52.0, 50.0, 48.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 58.0, 57.0, 57.0, 58.0, 57.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 78.0, 73.0, 81.0, 74.0, 74.0, 73.0, 73.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 130.0, 123.0, 121.0, 128.0, 117.0, 118.0, 118.0, 162.0, 125.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 156.0, 154.0, 153.0, 153.0, 152.0, 149.0, 152.0, 154.0, 149.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 66.0, 62.0, 62.0, 64.0, 66.0, 62.0, 61.0, 61.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1451.3999999999999, "alertThreshold": 2.0}]} 21:00:56 INFO - Return code: 0 21:00:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:00:56 INFO - # TBPL SUCCESS # 21:00:56 INFO - Running post-action listener: _resource_record_post_action 21:00:56 INFO - [mozharness: 2017-01-18 05:00:56.402726Z] Finished run-tests step (success) 21:00:56 INFO - Running post-run listener: _resource_record_post_run 21:00:56 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 1867776; Write bytes: 310464512; Read time: 428; Write time: 214644 21:00:56 INFO - TinderboxPrint: CPU usage
12.9% 21:00:56 INFO - TinderboxPrint: I/O read bytes / time
1,867,776 / 428 21:00:56 INFO - TinderboxPrint: I/O write bytes / time
310,464,512 / 214,644 21:00:56 INFO - TinderboxPrint: CPU idle
8,246.1 (87.1%) 21:00:56 INFO - TinderboxPrint: CPU user
1,179.6 (12.5%) 21:00:56 INFO - TinderboxPrint: Swap in / out
0 / 0 21:00:56 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100409344; Read time: 0; Write time: 95520 21:00:56 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 210055168; Read time: 12; Write time: 119124 21:00:57 INFO - Running post-run listener: _upload_blobber_files 21:00:57 INFO - Blob upload gear active. 21:00:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:00:57 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 21:00:57 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:00:57 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:00:57 INFO - (blobuploader) - INFO - Open directory for files ... 21:00:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:00:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:00:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:01:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:01:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:01:00 INFO - (blobuploader) - INFO - Done attempting. 21:01:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:01:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:01:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:01:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:01:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:01:01 INFO - (blobuploader) - INFO - Done attempting. 21:01:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:01:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:01:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:01:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:01:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:01:02 INFO - (blobuploader) - INFO - Done attempting. 21:01:02 INFO - (blobuploader) - INFO - Iteration through files over. 21:01:02 INFO - Return code: 0 21:01:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:01:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:01:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/831ea6ca4cce8b0892e33e1349b1867fedc37fb294ad13d58d03c21929077e34e3e1fb99a95f51a3a077c3e1aeac91574a76daab9c0ab7a2c5a7c2451b12b22b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/788b0532829150533b860196bf8527666cba90d171a7426290a86c87743b2422f506e48ca4efc19579b0be9b101d9d71a0d6e6c84f60c53234525866d2e9ec5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/308e226ea65bb8e5e1b8e0a6f5490fce94213833f346cb8f5c8a78500c4ee45ea9323ceb877c997cc96be0590b206c029acfd48b419eb6c0422fc003258f7b07"} 21:01:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:01:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:01:02 INFO - Contents: 21:01:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/831ea6ca4cce8b0892e33e1349b1867fedc37fb294ad13d58d03c21929077e34e3e1fb99a95f51a3a077c3e1aeac91574a76daab9c0ab7a2c5a7c2451b12b22b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/788b0532829150533b860196bf8527666cba90d171a7426290a86c87743b2422f506e48ca4efc19579b0be9b101d9d71a0d6e6c84f60c53234525866d2e9ec5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/308e226ea65bb8e5e1b8e0a6f5490fce94213833f346cb8f5c8a78500c4ee45ea9323ceb877c997cc96be0590b206c029acfd48b419eb6c0422fc003258f7b07"} 21:01:02 INFO - Running post-run listener: copy_logs_to_upload_dir 21:01:02 INFO - Copying logs to upload dir... 21:01:02 INFO - mkdir: /builds/slave/test/build/upload/logs 21:01:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.896548 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-01-17 21:01:02.194891) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 21:01:02.199078) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612 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-Beta/sha512/831ea6ca4cce8b0892e33e1349b1867fedc37fb294ad13d58d03c21929077e34e3e1fb99a95f51a3a077c3e1aeac91574a76daab9c0ab7a2c5a7c2451b12b22b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/788b0532829150533b860196bf8527666cba90d171a7426290a86c87743b2422f506e48ca4efc19579b0be9b101d9d71a0d6e6c84f60c53234525866d2e9ec5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/308e226ea65bb8e5e1b8e0a6f5490fce94213833f346cb8f5c8a78500c4ee45ea9323ceb877c997cc96be0590b206c029acfd48b419eb6c0422fc003258f7b07"} build_url:https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/Rf4r-ngaQrGg4mfw-gMv4A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/831ea6ca4cce8b0892e33e1349b1867fedc37fb294ad13d58d03c21929077e34e3e1fb99a95f51a3a077c3e1aeac91574a76daab9c0ab7a2c5a7c2451b12b22b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/788b0532829150533b860196bf8527666cba90d171a7426290a86c87743b2422f506e48ca4efc19579b0be9b101d9d71a0d6e6c84f60c53234525866d2e9ec5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/308e226ea65bb8e5e1b8e0a6f5490fce94213833f346cb8f5c8a78500c4ee45ea9323ceb877c997cc96be0590b206c029acfd48b419eb6c0422fc003258f7b07"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 21:01:02.224859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 21:01:02.225198) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1484714430.570321-2038467612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 21:01:02.310726) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 21:01:02.311050) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 21:01:02.311360) ========= ========= Total master_lag: 0.18 =========