builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1476922241.87 results: success (0) buildid: 20161019142722 builduid: f796e3a919b94dd1bb5097fde56bd5d7 revision: f9f623c85158de2792a8da1026fb5a2b57d7519d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:41.873416) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:41.873935) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:41.874250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:41.888790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:41.889131) ========= 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=0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 17:10:42-- 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% 67.1M=0s 2016-10-19 17:10:42 (67.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103742 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:42.007082) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:42.007441) ========= 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=0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014878 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:42.057244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:42.057662) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f9f623c85158de2792a8da1026fb5a2b57d7519d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f9f623c85158de2792a8da1026fb5a2b57d7519d --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=0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 17:10:42,437 truncating revision to first 12 chars 2016-10-19 17:10:42,437 Setting DEBUG logging. 2016-10-19 17:10:42,437 attempt 1/10 2016-10-19 17:10:42,437 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f9f623c85158?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 17:10:42,880 unpacking tar archive at: mozilla-aurora-f9f623c85158/testing/mozharness/ program finished with exit code 0 elapsedTime=0.772519 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:42.843780) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:42.844123) ========= script_repo_revision: f9f623c85158de2792a8da1026fb5a2b57d7519d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:42.844541) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:42.844816) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 17:10:42.855507) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-19 17:10:42.855878) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:10:43 INFO - MultiFileLogger online at 20161019 17:10:43 in /builds/slave/test 17:10:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:10:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:10:43 INFO - {'append_to_log': False, 17:10:43 INFO - 'base_work_dir': '/builds/slave/test', 17:10:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:10:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:10:43 INFO - 'branch': 'Mozilla-Aurora', 17:10:43 INFO - 'buildbot_json_path': 'buildprops.json', 17:10:43 INFO - 'config_files': ('talos/linux_config.py',), 17:10:43 INFO - 'default_actions': ('clobber', 17:10:43 INFO - 'read-buildbot-config', 17:10:43 INFO - 'download-and-extract', 17:10:43 INFO - 'populate-webroot', 17:10:43 INFO - 'create-virtualenv', 17:10:43 INFO - 'install', 17:10:43 INFO - 'run-tests'), 17:10:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:10:43 INFO - 'download_minidump_stackwalk': True, 17:10:43 INFO - 'download_symbols': 'ondemand', 17:10:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:10:43 INFO - 'tooltool.py': '/tools/tooltool.py', 17:10:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:10:43 INFO - '/tools/misc-python/virtualenv.py')}, 17:10:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:10:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:10:43 INFO - 'installer_path': 'installer.exe', 17:10:43 INFO - 'log_level': 'info', 17:10:43 INFO - 'log_name': 'talos', 17:10:43 INFO - 'log_to_console': True, 17:10:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:10:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:10:43 INFO - 'opt_config_files': (), 17:10:43 INFO - 'pip_index': False, 17:10:43 INFO - 'sps_profile': False, 17:10:43 INFO - 'sps_profile_interval': 0, 17:10:43 INFO - 'suite': 'dromaeojs', 17:10:43 INFO - 'system_bits': '32', 17:10:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:10:43 INFO - 'title': 'talos-linux64-ix-058', 17:10:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:10:43 INFO - 'use_talos_json': True, 17:10:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:10:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:10:43 INFO - 'work_dir': 'build'} 17:10:43 INFO - [mozharness: 2016-10-20 00:10:43.330430Z] Running clobber step. 17:10:43 INFO - Running pre-action listener: _resource_record_pre_action 17:10:43 INFO - Running main action method: clobber 17:10:43 INFO - rmtree: /builds/slave/test/build 17:10:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:10:43 INFO - Running post-action listener: _resource_record_post_action 17:10:43 INFO - [mozharness: 2016-10-20 00:10:43.800143Z] Finished clobber step (success) 17:10:43 INFO - [mozharness: 2016-10-20 00:10:43.800244Z] Running read-buildbot-config step. 17:10:43 INFO - Running pre-action listener: _resource_record_pre_action 17:10:43 INFO - Running main action method: read_buildbot_config 17:10:43 INFO - Using buildbot properties: 17:10:43 INFO - { 17:10:43 INFO - "project": "", 17:10:43 INFO - "product": "firefox", 17:10:43 INFO - "script_repo_revision": "production", 17:10:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:10:43 INFO - "repository": "", 17:10:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:10:43 INFO - "buildid": "20161019142722", 17:10:43 INFO - "pgo_build": "True", 17:10:43 INFO - "basedir": "/builds/slave/test", 17:10:43 INFO - "buildnumber": 530, 17:10:43 INFO - "slavename": "talos-linux64-ix-058", 17:10:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:10:43 INFO - "platform": "ubuntu64_hw", 17:10:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:10:43 INFO - "branch": "mozilla-aurora", 17:10:43 INFO - "repo_path": "releases/mozilla-aurora", 17:10:43 INFO - "revision": "f9f623c85158de2792a8da1026fb5a2b57d7519d", 17:10:43 INFO - "stage_platform": "linux64-pgo", 17:10:43 INFO - "builduid": "f796e3a919b94dd1bb5097fde56bd5d7", 17:10:43 INFO - "slavebuilddir": "test" 17:10:43 INFO - } 17:10:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 17:10:43 INFO - Running post-action listener: _resource_record_post_action 17:10:43 INFO - [mozharness: 2016-10-20 00:10:43.802762Z] Finished read-buildbot-config step (success) 17:10:43 INFO - [mozharness: 2016-10-20 00:10:43.802859Z] Running download-and-extract step. 17:10:43 INFO - Running pre-action listener: _resource_record_pre_action 17:10:43 INFO - Running main action method: download_and_extract 17:10:43 INFO - mkdir: /builds/slave/test/build/tests 17:10:43 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')]} 17:10:43 INFO - trying https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 17:10:43 INFO - Downloading https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 17:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:10:44 INFO - Downloaded 1361 bytes. 17:10:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 17:10:44 INFO - Using the following test package requirements: 17:10:44 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 17:10:44 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:10:44 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:10:44 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'jsshell-linux-x86_64.zip'], 17:10:44 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:10:44 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 17:10:44 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:10:44 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:10:44 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:10:44 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:10:44 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:10:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 17:10:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:10:44 INFO - Fetch https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 17:10:44 INFO - Expected file size: 21907925 17:10:49 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:10:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 17:10:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:10:49 INFO - Fetch https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 17:10:49 INFO - Expected file size: 21907925 17:10:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 17:10:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:10:54 INFO - Fetch https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 17:10:54 INFO - Expected file size: 14414081 17:10: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')]} 17:10:55 INFO - trying https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 17:10:55 INFO - Downloading https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 17:10:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:10:56 INFO - Downloaded 63989889 bytes. 17:10:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 17:10:56 INFO - mkdir: /builds/slave/test/properties 17:10:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:10:56 INFO - Writing to file /builds/slave/test/properties/build_url 17:10:56 INFO - Contents: 17:10:56 INFO - build_url:https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 17:10:57 INFO - Running post-action listener: _resource_record_post_action 17:10:57 INFO - Running post-action listener: set_extra_try_arguments 17:10:57 INFO - [mozharness: 2016-10-20 00:10:57.402803Z] Finished download-and-extract step (success) 17:10:57 INFO - [mozharness: 2016-10-20 00:10:57.403030Z] Running populate-webroot step. 17:10:57 INFO - Running pre-action listener: _resource_record_pre_action 17:10:57 INFO - Running main action method: populate_webroot 17:10:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:10:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:10:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:10:57 INFO - '--tppagecycles', 17:10:57 INFO - '7'], 17:10:57 INFO - 'tests': ['tsvgm']}}, 17:10:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:10:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:10:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:10:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:10:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:10:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:10:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:57 INFO - 'talos_options': ['--disable-e10s'], 17:10:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:57 INFO - 'talos_options': ['--disable-e10s'], 17:10:57 INFO - 'tests': ['damp', 'tps']}, 17:10:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:57 INFO - 'tests': ['damp', 'tps']}, 17:10:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:10:57 INFO - 'tests': ['dromaeo_dom']}, 17:10:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:10:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:10:57 INFO - 'tests': ['basic_compositor_video']}, 17:10:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:10:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:10:57 INFO - 'tests': ['a11yr', 17:10:57 INFO - 'ts_paint', 17:10:57 INFO - 'tpaint', 17:10:57 INFO - 'sessionrestore', 17:10:57 INFO - 'sessionrestore_no_auto_restore', 17:10:57 INFO - 'tabpaint']}, 17:10:57 INFO - 'other-e10s': {'tests': ['a11yr', 17:10:57 INFO - 'ts_paint', 17:10:57 INFO - 'tpaint', 17:10:57 INFO - 'sessionrestore', 17:10:57 INFO - 'sessionrestore_no_auto_restore', 17:10:57 INFO - 'tabpaint']}, 17:10:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:10:57 INFO - 'ts_paint', 17:10:57 INFO - 'tpaint', 17:10:57 INFO - 'sessionrestore', 17:10:57 INFO - 'sessionrestore_no_auto_restore', 17:10:57 INFO - 'tabpaint']}, 17:10:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:10:57 INFO - 'ts_paint', 17:10:57 INFO - 'tpaint', 17:10:57 INFO - 'sessionrestore', 17:10:57 INFO - 'sessionrestore_no_auto_restore', 17:10:57 INFO - 'tabpaint']}, 17:10:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:10:57 INFO - 'tests': ['a11yr', 17:10:57 INFO - 'ts_paint', 17:10:57 INFO - 'tpaint', 17:10:57 INFO - 'sessionrestore', 17:10:57 INFO - 'sessionrestore_no_auto_restore', 17:10:57 INFO - 'tabpaint']}, 17:10:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:10:57 INFO - 'tests': ['a11yr', 17:10:57 INFO - 'ts_paint', 17:10:57 INFO - 'tpaint', 17:10:57 INFO - 'sessionrestore', 17:10:57 INFO - 'sessionrestore_no_auto_restore', 17:10:57 INFO - 'tabpaint']}, 17:10:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:10:57 INFO - 'tests': ['tsvgx', 17:10:57 INFO - 'tsvgr_opacity', 17:10:57 INFO - 'tart', 17:10:57 INFO - 'tscrollx', 17:10:57 INFO - 'cart']}, 17:10:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:10:57 INFO - 'tsvgr_opacity', 17:10:57 INFO - 'tart', 17:10:57 INFO - 'tscrollx', 17:10:57 INFO - 'cart']}, 17:10:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:57 INFO - 'talos_options': ['--disable-e10s'], 17:10:57 INFO - 'tests': ['tp5o']}, 17:10:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:57 INFO - 'tests': ['tp5o']}, 17:10:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:57 INFO - 'talos_options': ['--disable-e10s', 17:10:57 INFO - '--xperf_path', 17:10:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:57 INFO - 'tests': ['tp5n']}, 17:10:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:57 INFO - 'talos_options': ['--xperf_path', 17:10:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:57 INFO - 'tests': ['tp5n']}}, 17:10:57 INFO - 'talos.zip': {'path': '', 17:10:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:10:57 INFO - Running post-action listener: _resource_record_post_action 17:10:57 INFO - [mozharness: 2016-10-20 00:10:57.424955Z] Finished populate-webroot step (success) 17:10:57 INFO - [mozharness: 2016-10-20 00:10:57.425052Z] Running create-virtualenv step. 17:10:57 INFO - Running pre-action listener: _resource_record_pre_action 17:10:57 INFO - Running main action method: create_virtualenv 17:10:57 INFO - Creating virtualenv /builds/slave/test/build/venv 17:10:57 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 17:10:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:10:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:10:57 INFO - Using real prefix '/usr' 17:10:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:10:58 INFO - Installing distribute.............................................................................................................................................................................................done. 17:11:00 INFO - Installing pip.................done. 17:11:00 INFO - Return code: 0 17:11:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:00 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 0x7f6023fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, '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 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, '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': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', '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 17:11:00 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 17:11:00 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 17:11:00 INFO - Using env: {'DISPLAY': ':0', 17:11:00 INFO - 'HOME': '/home/cltbld', 17:11:00 INFO - 'LANG': 'en_US.UTF-8', 17:11:00 INFO - 'LANGUAGE': 'en_US:en', 17:11:00 INFO - 'LOGNAME': 'cltbld', 17:11:00 INFO - 'MAIL': '/var/mail/cltbld', 17:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:00 INFO - 'MOZ_NO_REMOTE': '1', 17:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:00 INFO - 'NO_EM_RESTART': '1', 17:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:00 INFO - 'PWD': '/builds/slave/test', 17:11:00 INFO - 'SHELL': '/bin/bash', 17:11:00 INFO - 'SHLVL': '1', 17:11:00 INFO - 'TERM': 'linux', 17:11:00 INFO - 'TMOUT': '86400', 17:11:00 INFO - 'USER': 'cltbld', 17:11:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', 17:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:00 INFO - '_': '/tools/buildbot/bin/python'} 17:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:00 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 17:11:00 INFO - Cleaning up... 17:11:00 INFO - Return code: 0 17:11:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:00 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 0x7f6023fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, '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 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, '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': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', '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 17:11:00 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 17:11:00 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 17:11:00 INFO - Using env: {'DISPLAY': ':0', 17:11:00 INFO - 'HOME': '/home/cltbld', 17:11:00 INFO - 'LANG': 'en_US.UTF-8', 17:11:00 INFO - 'LANGUAGE': 'en_US:en', 17:11:00 INFO - 'LOGNAME': 'cltbld', 17:11:00 INFO - 'MAIL': '/var/mail/cltbld', 17:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:00 INFO - 'MOZ_NO_REMOTE': '1', 17:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:00 INFO - 'NO_EM_RESTART': '1', 17:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:00 INFO - 'PWD': '/builds/slave/test', 17:11:00 INFO - 'SHELL': '/bin/bash', 17:11:00 INFO - 'SHLVL': '1', 17:11:00 INFO - 'TERM': 'linux', 17:11:00 INFO - 'TMOUT': '86400', 17:11:00 INFO - 'USER': 'cltbld', 17:11:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', 17:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:00 INFO - '_': '/tools/buildbot/bin/python'} 17:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:00 INFO - Downloading/unpacking psutil>=3.1.1 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:11:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:02 INFO - Installing collected packages: psutil 17:11:02 INFO - Running setup.py install for psutil 17:11:02 INFO - building 'psutil._psutil_linux' extension 17:11:02 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 17:11:02 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 17:11:02 INFO - building 'psutil._psutil_posix' extension 17:11:02 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 17:11:02 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 17:11:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:02 INFO - Successfully installed psutil 17:11:02 INFO - Cleaning up... 17:11:03 INFO - Return code: 0 17:11:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:11:03 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')]} 17:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:03 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')]} 17:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:03 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 0x7f6023fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, '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 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, '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': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', '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 17:11:03 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 17:11:03 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 17:11:03 INFO - Using env: {'DISPLAY': ':0', 17:11:03 INFO - 'HOME': '/home/cltbld', 17:11:03 INFO - 'LANG': 'en_US.UTF-8', 17:11:03 INFO - 'LANGUAGE': 'en_US:en', 17:11:03 INFO - 'LOGNAME': 'cltbld', 17:11:03 INFO - 'MAIL': '/var/mail/cltbld', 17:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:03 INFO - 'MOZ_NO_REMOTE': '1', 17:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:03 INFO - 'NO_EM_RESTART': '1', 17:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:03 INFO - 'PWD': '/builds/slave/test', 17:11:03 INFO - 'SHELL': '/bin/bash', 17:11:03 INFO - 'SHLVL': '1', 17:11:03 INFO - 'TERM': 'linux', 17:11:03 INFO - 'TMOUT': '86400', 17:11:03 INFO - 'USER': 'cltbld', 17:11:03 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', 17:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:03 INFO - '_': '/tools/buildbot/bin/python'} 17:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:11:03 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 17:11:03 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 17:11:03 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 17:11:03 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 17:11:03 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 17:11:03 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 17:11:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:11:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:11:05 INFO - Installing collected packages: mozsystemmonitor 17:11:05 INFO - Running setup.py install for mozsystemmonitor 17:11:05 INFO - Successfully installed mozsystemmonitor 17:11:05 INFO - Cleaning up... 17:11:05 INFO - Return code: 0 17:11:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:11: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')]} 17:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11: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')]} 17:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6023fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, '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 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, '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': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', '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 17:11:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:11:05 INFO - Using env: {'DISPLAY': ':0', 17:11:05 INFO - 'HOME': '/home/cltbld', 17:11:05 INFO - 'LANG': 'en_US.UTF-8', 17:11:05 INFO - 'LANGUAGE': 'en_US:en', 17:11:05 INFO - 'LOGNAME': 'cltbld', 17:11:05 INFO - 'MAIL': '/var/mail/cltbld', 17:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:05 INFO - 'MOZ_NO_REMOTE': '1', 17:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:05 INFO - 'NO_EM_RESTART': '1', 17:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:05 INFO - 'PWD': '/builds/slave/test', 17:11:05 INFO - 'SHELL': '/bin/bash', 17:11:05 INFO - 'SHLVL': '1', 17:11:05 INFO - 'TERM': 'linux', 17:11:05 INFO - 'TMOUT': '86400', 17:11:05 INFO - 'USER': 'cltbld', 17:11:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', 17:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:05 INFO - '_': '/tools/buildbot/bin/python'} 17:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:05 INFO - Downloading/unpacking jsonschema==2.5.1 17:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:11:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:11:07 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 17:11:07 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 17:11:07 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 17:11:07 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 17:11:07 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 17:11:07 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 17:11:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:11:07 INFO - warning: no files found matching '*.txt' 17:11:07 INFO - no previously-included directories found matching 'build' 17:11:07 INFO - no previously-included directories found matching 'dist' 17:11:07 INFO - no previously-included directories found matching '.git*' 17:11:07 INFO - Installing collected packages: jsonschema, functools32 17:11:07 INFO - Running setup.py install for functools32 17:11:07 INFO - warning: no files found matching '*.txt' 17:11:07 INFO - no previously-included directories found matching 'build' 17:11:07 INFO - no previously-included directories found matching 'dist' 17:11:07 INFO - no previously-included directories found matching '.git*' 17:11:07 INFO - Successfully installed jsonschema functools32 17:11:07 INFO - Cleaning up... 17:11:08 INFO - Return code: 0 17:11:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:11:08 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')]} 17:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:08 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')]} 17:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:08 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 0x7f6023fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, '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 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, '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': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', '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 17:11:08 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 17:11:08 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 17:11:08 INFO - Using env: {'DISPLAY': ':0', 17:11:08 INFO - 'HOME': '/home/cltbld', 17:11:08 INFO - 'LANG': 'en_US.UTF-8', 17:11:08 INFO - 'LANGUAGE': 'en_US:en', 17:11:08 INFO - 'LOGNAME': 'cltbld', 17:11:08 INFO - 'MAIL': '/var/mail/cltbld', 17:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:08 INFO - 'MOZ_NO_REMOTE': '1', 17:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:08 INFO - 'NO_EM_RESTART': '1', 17:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:08 INFO - 'PWD': '/builds/slave/test', 17:11:08 INFO - 'SHELL': '/bin/bash', 17:11:08 INFO - 'SHLVL': '1', 17:11:08 INFO - 'TERM': 'linux', 17:11:08 INFO - 'TMOUT': '86400', 17:11:08 INFO - 'USER': 'cltbld', 17:11:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', 17:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:08 INFO - '_': '/tools/buildbot/bin/python'} 17:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:11:08 INFO - Cleaning up... 17:11:08 INFO - Return code: 0 17:11:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:11:08 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')]} 17:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:08 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')]} 17:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:08 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 0x7f6023fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, '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 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, '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': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', '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 17:11:08 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 17:11:08 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 17:11:08 INFO - Using env: {'DISPLAY': ':0', 17:11:08 INFO - 'HOME': '/home/cltbld', 17:11:08 INFO - 'LANG': 'en_US.UTF-8', 17:11:08 INFO - 'LANGUAGE': 'en_US:en', 17:11:08 INFO - 'LOGNAME': 'cltbld', 17:11:08 INFO - 'MAIL': '/var/mail/cltbld', 17:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:08 INFO - 'MOZ_NO_REMOTE': '1', 17:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:08 INFO - 'NO_EM_RESTART': '1', 17:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:08 INFO - 'PWD': '/builds/slave/test', 17:11:08 INFO - 'SHELL': '/bin/bash', 17:11:08 INFO - 'SHLVL': '1', 17:11:08 INFO - 'TERM': 'linux', 17:11:08 INFO - 'TMOUT': '86400', 17:11:08 INFO - 'USER': 'cltbld', 17:11:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', 17:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:08 INFO - '_': '/tools/buildbot/bin/python'} 17:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:08 INFO - Downloading/unpacking blobuploader==1.2.4 17:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:10 INFO - Downloading blobuploader-1.2.4.tar.gz 17:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:11:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:11:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:11 INFO - Downloading docopt-0.6.1.tar.gz 17:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:11:11 INFO - Installing collected packages: blobuploader, requests, docopt 17:11:11 INFO - Running setup.py install for blobuploader 17:11:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:11:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:11:11 INFO - Running setup.py install for requests 17:11:11 INFO - Running setup.py install for docopt 17:11:11 INFO - Successfully installed blobuploader requests docopt 17:11:11 INFO - Cleaning up... 17:11:11 INFO - Return code: 0 17:11:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:11 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')]} 17:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:11 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')]} 17:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:11 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 0x7f6023fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, '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 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, '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': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', '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 17:11:11 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 17:11:11 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 17:11:11 INFO - Using env: {'DISPLAY': ':0', 17:11:11 INFO - 'HOME': '/home/cltbld', 17:11:11 INFO - 'LANG': 'en_US.UTF-8', 17:11:11 INFO - 'LANGUAGE': 'en_US:en', 17:11:11 INFO - 'LOGNAME': 'cltbld', 17:11:11 INFO - 'MAIL': '/var/mail/cltbld', 17:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:11 INFO - 'MOZ_NO_REMOTE': '1', 17:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:11 INFO - 'NO_EM_RESTART': '1', 17:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:11 INFO - 'PWD': '/builds/slave/test', 17:11:11 INFO - 'SHELL': '/bin/bash', 17:11:11 INFO - 'SHLVL': '1', 17:11:11 INFO - 'TERM': 'linux', 17:11:11 INFO - 'TMOUT': '86400', 17:11:11 INFO - 'USER': 'cltbld', 17:11:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', 17:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:11 INFO - '_': '/tools/buildbot/bin/python'} 17:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:12 INFO - Running setup.py (path:/tmp/pip-cZb7Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:12 INFO - Running setup.py (path:/tmp/pip-DuyYcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:12 INFO - Running setup.py (path:/tmp/pip-JTXJzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:12 INFO - Running setup.py (path:/tmp/pip-bd0BwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:12 INFO - Running setup.py (path:/tmp/pip-5MNdq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:12 INFO - Running setup.py (path:/tmp/pip-aJaiGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:12 INFO - Running setup.py (path:/tmp/pip-CkBTVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:12 INFO - Running setup.py (path:/tmp/pip-OT99ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:12 INFO - Running setup.py (path:/tmp/pip-Hc75zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:12 INFO - Running setup.py (path:/tmp/pip-uN7h6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:12 INFO - Running setup.py (path:/tmp/pip-5QJWa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:12 INFO - Running setup.py (path:/tmp/pip-Hz3gV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:12 INFO - Running setup.py (path:/tmp/pip-iN_Y7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:12 INFO - Running setup.py (path:/tmp/pip-_IDR5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:13 INFO - Running setup.py (path:/tmp/pip-0bRqLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:13 INFO - Running setup.py (path:/tmp/pip-uMCHci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:13 INFO - Running setup.py (path:/tmp/pip-Iw_kd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:11:13 INFO - Running setup.py install for manifestparser 17:11:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:11:13 INFO - Running setup.py install for mozcrash 17:11:13 INFO - Running setup.py install for mozdebug 17:11:13 INFO - Running setup.py install for mozdevice 17:11:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:11:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:11:13 INFO - Running setup.py install for mozfile 17:11:13 INFO - Running setup.py install for mozhttpd 17:11:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:11:13 INFO - Running setup.py install for mozinfo 17:11:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:11:14 INFO - Running setup.py install for mozInstall 17:11:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:11:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:11:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:11:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:11:14 INFO - Running setup.py install for mozleak 17:11:14 INFO - Running setup.py install for mozlog 17:11:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:11:14 INFO - Running setup.py install for moznetwork 17:11:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:11:14 INFO - Running setup.py install for mozprocess 17:11:14 INFO - Running setup.py install for mozprofile 17:11:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:11:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:11:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:11:14 INFO - Running setup.py install for mozrunner 17:11:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:11:14 INFO - Running setup.py install for mozscreenshot 17:11:14 INFO - Running setup.py install for moztest 17:11:14 INFO - Running setup.py install for mozversion 17:11:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:11:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:11:15 INFO - Cleaning up... 17:11:15 INFO - Return code: 0 17:11:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:15 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')]} 17:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:15 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')]} 17:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:15 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 0x7f6023fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, '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 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, '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': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', '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 17:11:15 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 17:11:15 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 17:11:15 INFO - Using env: {'DISPLAY': ':0', 17:11:15 INFO - 'HOME': '/home/cltbld', 17:11:15 INFO - 'LANG': 'en_US.UTF-8', 17:11:15 INFO - 'LANGUAGE': 'en_US:en', 17:11:15 INFO - 'LOGNAME': 'cltbld', 17:11:15 INFO - 'MAIL': '/var/mail/cltbld', 17:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:15 INFO - 'MOZ_NO_REMOTE': '1', 17:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:15 INFO - 'NO_EM_RESTART': '1', 17:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:15 INFO - 'PWD': '/builds/slave/test', 17:11:15 INFO - 'SHELL': '/bin/bash', 17:11:15 INFO - 'SHLVL': '1', 17:11:15 INFO - 'TERM': 'linux', 17:11:15 INFO - 'TMOUT': '86400', 17:11:15 INFO - 'USER': 'cltbld', 17:11:15 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', 17:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:15 INFO - '_': '/tools/buildbot/bin/python'} 17:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:15 INFO - Running setup.py (path:/tmp/pip-ceNdkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:15 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)) 17:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:15 INFO - Running setup.py (path:/tmp/pip-itHpjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:15 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)) 17:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:15 INFO - Running setup.py (path:/tmp/pip-uO1Ndf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:15 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)) 17:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:15 INFO - Running setup.py (path:/tmp/pip-laX9HM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:15 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)) 17:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:15 INFO - Running setup.py (path:/tmp/pip-n0PxZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:15 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)) 17:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:15 INFO - Running setup.py (path:/tmp/pip-AevY8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:15 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)) 17:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:15 INFO - Running setup.py (path:/tmp/pip-qdNRV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:15 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)) 17:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:15 INFO - Running setup.py (path:/tmp/pip-xKKYlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:15 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)) 17:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:15 INFO - Running setup.py (path:/tmp/pip-Vojp1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:15 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)) 17:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:15 INFO - Running setup.py (path:/tmp/pip-zzlGTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:16 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)) 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:16 INFO - Running setup.py (path:/tmp/pip-lXLSco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:16 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)) 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:16 INFO - Running setup.py (path:/tmp/pip-FEl1dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:16 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)) 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:16 INFO - Running setup.py (path:/tmp/pip-I6BVkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:16 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)) 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:16 INFO - Running setup.py (path:/tmp/pip-P060ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:16 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)) 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:16 INFO - Running setup.py (path:/tmp/pip-rBPBn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:16 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)) 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:16 INFO - Running setup.py (path:/tmp/pip-sGl_TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:16 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)) 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:16 INFO - Running setup.py (path:/tmp/pip-syIPZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:16 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)) 17:11:16 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)) 17:11:16 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)) 17:11:16 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)) 17:11:16 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)) 17:11:16 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)) 17:11:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:11:16 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 17:11:16 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 17:11:16 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 17:11:16 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 17:11:16 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 17:11:16 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 17:11:18 INFO - Downloading blessings-1.6.tar.gz 17:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:11:18 INFO - Installing collected packages: blessings 17:11:18 INFO - Running setup.py install for blessings 17:11:18 INFO - Successfully installed blessings 17:11:18 INFO - Cleaning up... 17:11:18 INFO - Return code: 0 17:11:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:11:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:18 INFO - Reading from file tmpfile_stdout 17:11:18 INFO - Current package versions: 17:11:18 INFO - argparse == 1.2.1 17:11:18 INFO - blessings == 1.6 17:11:18 INFO - blobuploader == 1.2.4 17:11:18 INFO - docopt == 0.6.1 17:11:18 INFO - functools32 == 3.2.3-2 17:11:18 INFO - jsonschema == 2.5.1 17:11:18 INFO - manifestparser == 1.1 17:11:18 INFO - mozInstall == 1.12 17:11:18 INFO - mozcrash == 0.17 17:11:18 INFO - mozdebug == 0.1 17:11:18 INFO - mozdevice == 0.48 17:11:18 INFO - mozfile == 1.2 17:11:18 INFO - mozhttpd == 0.7 17:11:18 INFO - mozinfo == 0.9 17:11:18 INFO - mozleak == 0.1 17:11:18 INFO - mozlog == 3.4 17:11:18 INFO - moznetwork == 0.27 17:11:18 INFO - mozprocess == 0.23 17:11:18 INFO - mozprofile == 0.28 17:11:18 INFO - mozrunner == 6.12 17:11:18 INFO - mozscreenshot == 0.1 17:11:18 INFO - mozsystemmonitor == 0.3 17:11:18 INFO - moztest == 0.7 17:11:18 INFO - mozversion == 1.4 17:11:18 INFO - psutil == 3.1.1 17:11:18 INFO - requests == 1.2.3 17:11:18 INFO - wsgiref == 0.1.2 17:11:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:18 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')]} 17:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:18 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')]} 17:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:18 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 0x7f6023fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, '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 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, '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': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', '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 17:11:18 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 17:11:18 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 17:11:18 INFO - Using env: {'DISPLAY': ':0', 17:11:18 INFO - 'HOME': '/home/cltbld', 17:11:18 INFO - 'LANG': 'en_US.UTF-8', 17:11:18 INFO - 'LANGUAGE': 'en_US:en', 17:11:18 INFO - 'LOGNAME': 'cltbld', 17:11:18 INFO - 'MAIL': '/var/mail/cltbld', 17:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:18 INFO - 'MOZ_NO_REMOTE': '1', 17:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:18 INFO - 'NO_EM_RESTART': '1', 17:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:18 INFO - 'PWD': '/builds/slave/test', 17:11:18 INFO - 'SHELL': '/bin/bash', 17:11:18 INFO - 'SHLVL': '1', 17:11:18 INFO - 'TERM': 'linux', 17:11:18 INFO - 'TMOUT': '86400', 17:11:18 INFO - 'USER': 'cltbld', 17:11:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', 17:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:18 INFO - '_': '/tools/buildbot/bin/python'} 17:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:19 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)) 17:11:19 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)) 17:11:19 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)) 17:11:19 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)) 17:11:19 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)) 17:11:19 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)) 17:11:19 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)) 17:11:19 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)) 17:11:19 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)) 17:11:19 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)) 17:11:19 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)) 17:11:19 INFO - Cleaning up... 17:11:19 INFO - Return code: 0 17:11:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6023fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, '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 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, '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': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', '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 17:11:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:11:19 INFO - Using env: {'DISPLAY': ':0', 17:11:19 INFO - 'HOME': '/home/cltbld', 17:11:19 INFO - 'LANG': 'en_US.UTF-8', 17:11:19 INFO - 'LANGUAGE': 'en_US:en', 17:11:19 INFO - 'LOGNAME': 'cltbld', 17:11:19 INFO - 'MAIL': '/var/mail/cltbld', 17:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:19 INFO - 'MOZ_NO_REMOTE': '1', 17:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:19 INFO - 'NO_EM_RESTART': '1', 17:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:19 INFO - 'PWD': '/builds/slave/test', 17:11:19 INFO - 'SHELL': '/bin/bash', 17:11:19 INFO - 'SHLVL': '1', 17:11:19 INFO - 'TERM': 'linux', 17:11:19 INFO - 'TMOUT': '86400', 17:11:19 INFO - 'USER': 'cltbld', 17:11:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', 17:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:19 INFO - '_': '/tools/buildbot/bin/python'} 17:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:11:19 INFO - Cleaning up... 17:11:19 INFO - Return code: 0 17:11:19 INFO - Running post-action listener: _resource_record_post_action 17:11:19 INFO - Running post-action listener: _start_resource_monitoring 17:11:19 INFO - Starting resource monitoring. 17:11:19 INFO - [mozharness: 2016-10-20 00:11:19.426951Z] Finished create-virtualenv step (success) 17:11:19 INFO - [mozharness: 2016-10-20 00:11:19.427626Z] Running install step. 17:11:19 INFO - Running pre-action listener: _resource_record_pre_action 17:11:19 INFO - Running main action method: install 17:11:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:19 INFO - Reading from file tmpfile_stdout 17:11:19 INFO - Detecting whether we're running mozinstall >=1.0... 17:11:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:11:19 INFO - Reading from file tmpfile_stdout 17:11:19 INFO - Output received: 17:11:19 INFO - Usage: mozinstall [options] installer 17:11:19 INFO - Options: 17:11:19 INFO - -h, --help show this help message and exit 17:11:19 INFO - -d DEST, --destination=DEST 17:11:19 INFO - Directory to install application into. [default: 17:11:19 INFO - "/builds/slave/test"] 17:11:19 INFO - --app=APP Application being installed. [default: firefox] 17:11:19 INFO - mkdir: /builds/slave/test/build/application 17:11:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:11:35 INFO - Reading from file tmpfile_stdout 17:11:35 INFO - Output received: 17:11:35 INFO - /builds/slave/test/build/application/firefox/firefox 17:11:35 INFO - Running post-action listener: _resource_record_post_action 17:11:35 INFO - [mozharness: 2016-10-20 00:11:35.718527Z] Finished install step (success) 17:11:35 INFO - [mozharness: 2016-10-20 00:11:35.718770Z] Running run-tests step. 17:11:35 INFO - Running pre-action listener: _resource_record_pre_action 17:11:35 INFO - Running main action method: run_tests 17:11:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:11:35 INFO - Python 2.7.3 17:11:35 INFO - Return code: 0 17:11:35 INFO - grabbing minidump binary from tooltool 17:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:35 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 0x2764f60>, '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 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:11:35 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 17:11:35 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 17:11:35 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 17:11:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:11:35 INFO - Return code: 0 17:11:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:11:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:11:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:11:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:11:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:11:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 17:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 17:11:35 INFO - Using env: {'DISPLAY': ':0', 17:11:35 INFO - 'HOME': '/home/cltbld', 17:11:35 INFO - 'LANG': 'en_US.UTF-8', 17:11:35 INFO - 'LANGUAGE': 'en_US:en', 17:11:35 INFO - 'LOGNAME': 'cltbld', 17:11:35 INFO - 'MAIL': '/var/mail/cltbld', 17:11:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:11:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:35 INFO - 'MOZ_NO_REMOTE': '1', 17:11:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:35 INFO - 'NO_EM_RESTART': '1', 17:11:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:35 INFO - 'PWD': '/builds/slave/test', 17:11:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:11:35 INFO - 'SHELL': '/bin/bash', 17:11:35 INFO - 'SHLVL': '1', 17:11:35 INFO - 'TERM': 'linux', 17:11:35 INFO - 'TMOUT': '86400', 17:11:35 INFO - 'USER': 'cltbld', 17:11:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347', 17:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:35 INFO - '_': '/tools/buildbot/bin/python'} 17:11:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 17:11:35 INFO - mozversion application_buildid: 20161019142722 17:11:35 INFO - mozversion application_changeset: f9f623c85158de2792a8da1026fb5a2b57d7519d 17:11:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:11:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:11:35 INFO - mozversion application_name: Firefox 17:11:35 INFO - mozversion application_remotingname: firefox-dev 17:11:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:11:35 INFO - mozversion application_vendor: Mozilla 17:11:35 INFO - mozversion application_version: 51.0a2 17:11:35 INFO - mozversion platform_buildid: 20161019142722 17:11:35 INFO - mozversion platform_changeset: f9f623c85158de2792a8da1026fb5a2b57d7519d 17:11:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:11:35 INFO - mozversion platform_version: 51.0a2 17:11:35 INFO - using testdate: 1476922295 17:11:35 INFO - actual date: 1476922295 17:11:35 INFO - starting webserver on 'localhost:36829' 17:11:35 INFO - SUITE-START | Running 2 tests 17:11:35 INFO - TEST-START | dromaeo_css 17:11:35 INFO - operating with platform_type : linux_ 17:11:35 INFO - Initialising browser for dromaeo_css test... 17:11:36 INFO - TEST-INFO | started process 30576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4BFSy3/profile http://localhost:36829/getInfo.html) 17:11:40 INFO - PROCESS | 30576 | __metrics Screen width/height:1600/1200 17:11:40 INFO - PROCESS | 30576 | colorDepth:24 17:11:40 INFO - PROCESS | 30576 | Browser inner width/height: 1024/697 17:11:40 INFO - PROCESS | 30576 | __metrics 17:11:40 INFO - PROCESS | 30576 | 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" 17:11:40 INFO - PROCESS | 30576 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:11:41 INFO - PROCESS | 30576 | console.error: PushService: 17:11:41 INFO - PROCESS | 30576 | stateChangeProcessEnqueue: Error transitioning state 17:11:41 INFO - PROCESS | 30576 | UnknownError 17:11:41 INFO - TEST-INFO | 30576: exit 0 17:11:41 INFO - Browser initialized. 17:11:41 INFO - Running cycle 1/1 for dromaeo_css test... 17:11:41 INFO - TEST-INFO | started process 30668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4BFSy3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:53 INFO - PROCESS | 30668 | RSS: Main: 144850944 17:11:53 INFO - PROCESS | 30668 | 17:12:44 INFO - PROCESS | 30668 | 1476922364611 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] 17:14:53 INFO - PROCESS | 30668 | Cycle 1(1): loaded http://localhost:36829/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36829/tests/dromaeo/cssquery-ext.html) 17:14:55 INFO - PROCESS | 30668 | RSS: Main: 272199680 17:14:55 INFO - PROCESS | 30668 | 17:17:57 INFO - PROCESS | 30668 | Cycle 1(1): loaded http://localhost:36829/tests/dromaeo/cssquery-ext.html (next: http://localhost:36829/tests/dromaeo/cssquery-jquery.html) 17:17:57 INFO - PROCESS | 30668 | RSS: Main: 235720704 17:17:57 INFO - PROCESS | 30668 | 17:20:59 INFO - PROCESS | 30668 | Cycle 1(1): loaded http://localhost:36829/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36829/tests/dromaeo/cssquery-mootools.html) 17:21:00 INFO - PROCESS | 30668 | RSS: Main: 207208448 17:21:00 INFO - PROCESS | 30668 | 17:24:02 INFO - PROCESS | 30668 | Cycle 1(1): loaded http://localhost:36829/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36829/tests/dromaeo/cssquery-prototype.html) 17:24:03 INFO - PROCESS | 30668 | RSS: Main: 205225984 17:24:03 INFO - PROCESS | 30668 | 17:27:05 INFO - PROCESS | 30668 | Cycle 1(1): loaded http://localhost:36829/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36829/tests/dromaeo/cssquery-yui.html) 17:27:06 INFO - PROCESS | 30668 | RSS: Main: 175554560 17:27:06 INFO - PROCESS | 30668 | 17:30:09 INFO - PROCESS | 30668 | Cycle 1(1): loaded http://localhost:36829/tests/dromaeo/cssquery-yui.html (next: http://localhost:36829/tests/dromaeo/cssquery-dojo.html) 17:30:09 INFO - PROCESS | 30668 | RSS: Main: 264441856 17:30:09 INFO - PROCESS | 30668 | 17:30:09 INFO - PROCESS | 30668 | __start_tp_report 17:30:09 INFO - PROCESS | 30668 | _x_x_mozilla_page_load 17:30:09 INFO - PROCESS | 30668 | _x_x_mozilla_page_load_details 17:30:09 INFO - PROCESS | 30668 | |i|pagename|runs| 17:30:09 INFO - PROCESS | 30668 | |0;dojo.html;3100.27143621249;3141.450246206913;3148.590683211181;3169.1918560767;3192.840357982102;5486.204500347452;5512.5589952803775;5534.446555344473;5547.223388725577;5552.888942221153;5564.666120032801;5616.185653080312;5623.690697011662;5628.32460104787;5633.436656334375;5033.546980771739;5050.444451110375;5083.618728595352;5109.284700141964;5131;5041.0422019816115;5089.669171503859;5131.255967884655;5134.897302053957;5140.742962851861;5006.69959802413;5012.398512178544;5041.344625198737;5060.342155519796;5073.467285934979;5073.949260507385;5074.695518268897;5135.998480296344;5143.305653736735;5163.251328557376;4845.4185497740145;5035.924461133086;5062.683702237408;5086.338775959139;5110.5911527078115;5420.159875219348;5435.239066530688;5478.479544443271;5489.615726899118;5490.203920431515;5787.479126878559;5890.145928840337;5903.439173278532;5917.733701983421;6008.459238668541;5892.351841297454;6030.517558595302;6038;6040.184575082396;6045.909311360333;5536.667799932017;5536.806211782608;5537.723113844332;5566.805161819317;5659.518940890071;6158.107074474266;6189.442950134509;6201.162843016225;6202.317745048041;6203.875922481525;5724.427557244242;5933.376995415506;5950.494207992283;5969.373215812364;5971.0744834550715;5853.414658534198;5890.175375447441;5945.464908158287;5946.554008449383;5951.226340575784;5914.8817023659285;5921.467067963904;5921.792737254175;5924.851878702981;5926.762929482858;5922.200502932135;5937.881242375129;5956.583039187215;5962.821115366546;6043.033114701627;4634.397528321297;4646.094011667692;4647.651426142985;4649.976750116295;4684.133435314409;4122.051928056564;4126.195391898551;4128.091819799639;4138.151678905817;4170.91658166841;5468.535174510132;5478.890422191614;5538.6122971391615;5545.057340252167;5568.053430916754;5970.940290597038;5975.611585246945;5977.731002104829;5979;6004.579679422399;5537.944620553743;5593.720313984366;5594.468525490072;5602.747876345574;5602.831915042555;4892.608591312686;4936;4965.4289756678445;4978.153713868651;5030.446650868402;6280.466160376419;6285.088662144055;6289.0252010938375;6301.6219026858535;6312.652804095819;6123.938760612336;6128.509719222362;6133.938660613515;6135.877282454415;6137.7851775187655;6006.489448396936;6012.518998480198;6140.293866205265;6309.463695585927;6325.335839736946;5905.91141132892;5937.732802023833;5981.7607295707685;6009.218801555945;6032.638041717335;6067;6075.483583895241;6083.726232319645;6089.786857459968;6090.969545152246;5606.607537472501;5719.742611582572;5928.525717942468;5933;5938.495227905676;5836.503897168788;5850.5904586678525;5869.207656966255;5944.4352786485215;5972.970135149297;5875.441833025856;5886.411358864079;5889.234399528034;5891.469767720926;5894.646321220741;5735.71321433935;5978.372270911492;5981.162637230704;5995.130706047686;5999.520038397005;5571.498565129158;5739.368669446441;5771.97114014444;5777.7977770777825;5832.970835145967 17:30:09 INFO - PROCESS | 30668 | |1;ext.html;579.3250862744902;609.2658346692236;642.4282388674081;654.2737561306949;662.9569078009926;34683.30633387334;46372.76813615931;46884.29673554895;46905;46942;48357.51642483574;48688;48695.51304486954;48715.26927096096;48783.51216487834;8370.53962032088;8402.15978402161;9269.490178040222;9401.294902882277;9416.81166376672;11241.550337986471;11462.369569673665;11472.139589530818;11474.139439542027;11477.655670329861;11324.207305488619;11389.943050284737;11390.772184556305;11399;11419.200655954086;8617.09520500351;8770.035296117421;8791.296696264284;10889.673309800719;11214.831777523344;10724.195685323632;11112.555497780078;11126.721831954184;11142.888571114347;11168;46292;46484.302735458994;46629.30056049162;46653.5334646656;46740.7662961683;3858.1704933439446;3925.509311336083;3948.5853985331414;4277.572242775728;4438.977805110986;35396.469052964225;35425.11437214065;35474.645253547395;35543.64456355429;35609;4640.605548528345;4695.741734204617;4706.482286948467;4829;4864.635152363551;357815;357853;358145;358300;359421;64662.35337646563;64957;65105.34894651087;65116;65190.674046629465;67139.32860671429;67221.32778672248;67381.989270161;67441;67520.66239668771;17959.102044897703;18195.545111372056;18199.181036853373;18219;18222.27110915575;12750.426230819636;12839.614811555668;12849.164804287691;13076.54232101891;13971.161730296011;19606.901965490368;19813.900930495256;19814.801851981294;19920.90039549793;19938.501537461678;5994.970025149846;6126.387361263838;6144.361007439355;6166.506679465632;6169.784057557964;1027.1577306608658;1065.4033741105006;1071.6624263357019;1097.3032124600936;1155.306815910447;33853.32293354119;34611.13472163166;34781.1304717379;34924.13409596413;35132.473012904826;1076.364944682641;1136.652558216046;1215.3133479584008;1217.6590554644713;1244.2783185752241;17550.29798808059;17711.645767084843;17820.287188512313;17883.910580447013;18583.907080464513;542133;548184;554461;566914;831332;62644;62985.05522417167;63540.36459635437;63556.68221658954;63646.68176659087;1327.422571181539;1341.5438750824767;1351.9121257118256;1399.1744870526438;1415.419677932043;33277.667223328426;34897;34921.30157396787;37405.81297093606;38087.61912380951;60679.393206067376;61240;61285.693571533644;61359.07961380493;61486.69256653688;496866;503336;503435;503447;504318;30442.39115217639;31435.84282078575;31509.212269692525;31624.525632115077;31630.683693162773;50656;51492;51873;52371;52555.47444525506;43139.352909705754;43389.34915976326;43547;43833;45004.549954500035;43718.78140609276;44561.33158002698;45130.54869451395;45296.547034529234;46071.308930366744;42779.358309626004;43717;44496.77751611221;44838;44993.32510012287;36896.44655330118;39008.804955975036;39034.53434733824;39118.87846358345;39562;28925.276868078465;29167.7083229165;29181.854090729412;29721.554176686936;29839.254018649706 17:30:09 INFO - PROCESS | 30668 | |2;jquery.html;399.6023956163618;440.1527060408713;440.8164079446687;441.2785096367438;452.75098695717367;17290.654186916254;18779.62440751184;20457.4885627859;20789.896050519725;21034.89482552585;19281.517962050955;19940.806511283747;19977.400677979684;20168.495787605316;20505.692414613794;5941.19793827832;5972.492338151263;6180.351063138373;6188.071789231606;6190;5992.760289588433;6013.428724271187;6056.666883321415;6078.969605151968;6081.574289799716;5853.239078919734;6028.125921741344;6068.0291153415465;6080.331163572004;6084.300305464884;5960.105984102376;5966.045432730764;5990.101484777297;5991.071383935497;6064.363241859607;5280.973595132;5401.837944861661;5409;5481.123020316731;5528.281323427928;14097.224652644101;14138.08102473336;14148.363323650461;14376.856231437656;14424.27878606076;2294.128231272123;2354.799842013431;2416.6012607919674;2432.391902024494;3013.6835632258517;10286.177105831515;10575;11079.335239885633;11097.611583594535;11112.722181945515;2011.7485314335709;2066.3904148276297;2090.5505316356903;2101.075526768217;2139.4330502416874;73013;85580.57209713911;91208;91818.5409072957;94440.52779736057;10087.394756314645;10461.529231184615;10539.683809485728;10606.41664708433;10712.892871071346;14404.639884002774;15223.695526089416;15344.923275383775;15400.07599544031;15908.44320448802;6377.553571249968;7911.446198766032;7941;8139.267465927976;8140.3312320974055;7308.342249197598;7369.77890663281;7552.962235188898;7705.075390953009;7772.883406748903;4719.740414277179;4840.031993601294;5125.846224613268;5173.094708426011;5260.92108618371;2038.8572799903864;2148.398448434441;2158.136745301892;2186.9343919682433;2242;902.869083982832;1005.9899401005896;1009.3943633819649;1020.3318322586383;1115.6318414923055;19846.801531984496;20090.196392144444;20251.18909757808;20351.185952562028;20476.078576464093;1017.6641708236265;1020.3265844542566;1023.2376879225025;1040.1730624153815;1072.2172813845937;10142.746431339276;10857.185711071701;10886.455677216107;10981.341119532693;11059.612913548148;524627;531775;534656;538480;546833;100250.99999999854;101825.49087254665;102416;102969.48515257526;103979.480102599;995.328153496387;1016.4307987527009;1025.8409946458312;1032.1175395037135;1033.1631378583372;16950.576235593715;17667;17941.730874037163;19258;19260.903695481993;45441.09117817691;45905.77047114743;46145.53854461547;46514.30228546507;47275.52724472711;59591.702041489516;60382.698086511045;60468.39531604628;60638.39361606327;61325.38674613197;8827.426217295855;9103.089691030844;9201.953990230273;9284.396514226553;9326.207272381653;10298.588056477956;13860.722785544434;13866.376013079234;14187.077839940372;14705.55883323502;11910.106741994558;12007.699807504881;12190.329531875832;12278.877211227773;12401.210946476624;11959.701007474883;12158;12202.511899523919;12416.56542021061;12527.56153534622;12436.813447798471;12647.747045059232;12774.744505110031;12879.162854414433;12895.613131606067;7869.645865935932;8004.199580041949;8147.470414423044;8447.239748422671;9511.143997040299;8487.8726819099;8611.827763444571;8676.349273804617;8719.727333606614;9305.302102342215 17:30:09 INFO - PROCESS | 30668 | |3;mootools.html;1379.3448112146725;1447.6236178593563;1516.2873449478745;1630.7309293966496;1812.6465339258841;8011.599420028997;8626.74119776407;9074.455532668037;9381;9383.953080234607;9330.44017358959;9409.576569054392;9411.964683884768;9413.52932353383;9448.244140468763;2519.1560827122935;2554.9744502555013;2557.9232623021244;2558.3092565007437;2564.064116597447;2457.1522824625476;2545.5545279576095;2550.681164854393;2551.8724063796735;2552.8595927223996;2516.219971808736;2523.7980961523035;2576.2142546523396;2577.755113264246;2583.870806459679;2459.8893049812714;2466.987665061672;2489.3278814720106;2540.390306326487;2548.0317479357727;2456.9017239310406;2468.469279104983;2477.467344520937;2490.302715239736;2537.2895589235045;9148.2681385489;9304;9393.107654772853;9424.575894084783;9427.858582121273;5357.571394288448;5540.695261760601;5547.306586676666;5556.361018482886;5560.277163968699;3506.6843984041557;3572.8749493767596;3590.569131704186;3611.5305010348748;3642.25333806569;1203.9097067719956;1228.7726770547388;1269.4668239339499;1276.5468258768096;1281.807728840672;12861.356932153354;12888.80666789999;12911.483540658362;12968.481260749653;12982.480700771957;4726.07103041886;4759.23852183649;4765.7140571565815;4847.95152048475;4965.851024469272;10030.498475076218;10045.397276163454;10068.44623545712;10070.798584028278;10202.28583999113;5491.890162196813;5536.529395001389;5549.056660367747;5554.861128471821;5556.638818476867;4347.413099231627;4609.700369475973;4697.647676424282;4732.574068333797;5152.252923326097;4105.548389677133;4184.4351012613515;4211.284081706117;4264.722793018444;4285.6785741068925;1275.152023904112;1295.598364507006;1308.0451270572535;1308.215070957418;1308.3262120008203;1021.8978102189722;1066.5733706517456;1070.9892901071046;1083.1930211992117;1084.2897901874285;6297.905531417033;6429.260635026938;6609.778552124902;6647.779418219528;6714.83212919681;468.9413823272091;477.3245857112217;487.5563237453971;495.56637941800926;503.84128999365083;4348.9565104349185;4413.691041627119;4414.646828253732;4477.619402350771;4484.977575112103;11472.885271147348;11754.76490470203;11839.822402663967;11858.525658973544;11864.22882512634;11008.779824403468;11462;11469.483873225558;11716;11730.530778768923;8718.389712720049;8880.200781929529;8927.732168034969;8930.687425940061;8937.150970657776;6297.842553936005;6555.70499327541;6565.409113179837;6745.123133992746;6751.122354093936;10584.788304233718;10840.024397804236;10869.29349592274;10976.890231097586;11056.889431105586;9672.129508344282;10967;10968.23222374458;11120.221584489333;11136.220464567403;7296.746342633295;8058.637361318872;8238.093809680811;8684.088170741981;8703.521306328214;9276.953615231881;9292.210162136294;9293.070692930653;9337.85993210116;9352.625894964125;7979.16218797018;8261.917380826355;8388.679471070434;8425;8498.91501085006;8197.631106600336;8229.218224268685;8355.164483551596;8360.665573376997;8467.78830529217;7680.078390593165;7790.9220907790195;7802.726904558313;7803.531788092732;7805.921940780519;5622.100463925915;5628.324601047737;5788.8552786179;5819.156222347651;5853.1220316952795;5856.502197313276;5927.081302398135;5948.256467941507;6003.219581454558;6159.29168145669 17:30:09 INFO - PROCESS | 30668 | |4;prototype.html;339.6603396603397;358.4157822748919;358.7793506993199;366.47593940664837;371.0852747976238;5513.318437876446;5561.610687251894;5567.916481252784;5580.581456390772;5588.273524441827;5205.479452054793;5337.626366154371;5352.661834541364;5461.8152738904455;5529;4325.188627392189;4333.220020396319;4336.761478118702;4344.891377715567;4346.97826510867;4330.155619654169;4340.414044104053;4343.19650864591;4348.760818155;4355.281378572532;4013.4581831452674;4106.28140075487;4251.3622956556455;4297.871063868089;4323.459567554056;4258.8509402171085;4272.252355837716;4286.03564198056;4295.398644189816;4299.140171965604;3799.2211596622624;3827.1962887793597;3836.865709700147;3842.8847134585726;3846.788426636534;5194.558462530689;5339.946600533984;5353.357597088374;5357.357117145929;5393.568514518829;4928.975355123202;4943.975280123576;4946.9010619787405;4947.109520286347;4948.406191257036;5730.570207234432;5733.226014488033;5735.913961290584;5744.310682718059;5752.741126649269;4077.5524688735663;4216.852410165629;4217.789110544491;4218.451601291843;4256.382824490432;5975.731092100866;5996.121861506458;5997.241269016301;6000.729967151445;6007.909881351783;4355.716878402894;4365.454318210223;4368;4372.650187984954;4396.868093957187;4339.783010849508;4377.978110109493;4382.298832186835;4403.251447253911;4418.293073108352;4936.802527898915;4947.960928205045;4953.578945789576;4961.7672047578735;4964.255361695702;5738.454846789548;5759.625624334405;5803.361630220672;5804.100364443518;5809.302883653989;1404.403128670311;1414.165642271065;1472.138798802691;1484.2875419798556;1496.9326380312912;958.1568219966385;995.770972676274;1005.1857995024054;1018.7147598672384;1024.329064462778;5507.339119305709;5517.751701173457;5518.068675963461;5521.723913804293;5525.950069486785;5661.2923384576925;5874.061559685294;5880.676562789087;5890.587658863924;5909.8227053188475;5401.6218864679095;5489.216004798456;5504.4495550444635;5507.531859791962;5513.283273174462;3115.190050586864;3122.469989705028;3124.6719094495206;3126.8436578171;3130.4365214261197;5856;6011.09833524966;6015.909761353583;6126.958417069109;6233.968830155911;6128.203333566607;6131.478824299896;6141.263048434216;6147.600405973598;6151.784687535915;5915.155149152913;6139.416755408319;6158.922188616974;6164.599301045418;6173.876522469525;5956.404359564009;5984.521238301013;6015.157877897185;6018.856417280703;6024.487918526975;5948;5949.791757288474;5961.076033214858;5961.823934264049;5966.522678185822;5879.794207202727;6145.66198859067;6194;6195.721192546436;6228.781992630417;4271.049279416589;4282.207791558571;4287.442632457761;4293.270144075577;4300.118475712409;5816.7024025508845;5960.850978725566;5997.580169388101;6020.819375418744;6034.63792172471;5824.621399609012;5838.131797824655;5842.874062376608;5844.970775146097;5855.268091488564;5800;5828.271466066742;5841.415858414294;5841.853953651193;5844.6785426801935;5408.782399216302;5474.315710536183;5751.683657398883;5774.249347584787;5794.942050579609;5869.295684517885;5871.563301229941;5872.236609240942;5875.911861322169;5879.824464947997;5537.889242215214;5692.971535142297;5727.31272247333;5729.3124825019595;5746.454086861741 17:30:09 INFO - PROCESS | 30668 | |5;yui.html;823.5799742131511;829.3282441222607;852.3394369363742;877.8463768840453;924.8589366605735;16775.328986840526;18122.909385453087;18150.455486335413;18155.092245387743;18168.54578635535;16289.348426062943;16363.100029498373;16520.83479165208;16526.917365413155;16557.751633725504;710.6233696141054;727.149235394587;831.2186544648011;841.0496139362511;861.5735211070497;858.3776761847641;859.7205908079868;860.7546849147994;861.4788053227801;861.543382007537;755.037327407557;904.5658084119626;906.3881879731188;906.4923642760042;906.8141031088611;766.9041369828772;885.2475395913486;902.0573500691826;915.7939463620633;918.237862574062;672.7981605518374;673.5318953327439;676.4892506157869;676.8375589858448;677.4681874728315;15829.44596939113;15856.207189640587;15916.920415397964;15921.522354329389;15947.760783588255;15374.231288435534;15676.372945082183;15732.921335393365;15740.291686874118;15986.920065399714;14197.503087391995;14251.429942802275;14262.144271343752;14414;14712.779308310384;4703.952960470386;4705.882352941169;4748.5251474852585;4802.615790736732;4822.228443449031;80434.19565804326;82458.17541824565;82919.5854020726;85428;88058.5597072017;11665.183437159318;11815.822762658567;11957.342346171044;11958.40207989597;12464.750704985849;21776.020079096477;22125.446863828533;22145;22148.114075436803;22166.445838854157;8810.339224558184;8937.329700272505;9022.593983270768;9073.364864459556;9248.722538323862;4783.617310615143;4856.368672072678;4892.8532144035735;4966.577840883565;5216.191490319006;3535.4343305071066;3672.045268230226;3689.5756987946193;3700.3339398907915;3708.369577171887;681.4616453002172;707.4163814852767;710.5985118408083;711.0969069281983;715.6457553511045;695.8817001109824;738.3650060947581;791;791.8495485857669;794.1224946434222;10517;10731;10813.18901082422;10932.234743567873;11023.669289921316;604.5375287904757;737.2406421385981;745.3738859358165;809.8461292354434;814.9022117345957;4853.854384368475;4978.8257410990445;5021.472745361758;5022.447530771612;5081.949180508148;97374;126926.36536817257;127167;131872.34063829618;132516;85803.14196858076;102780.48609756904;104732;105472;108655.45672271588;54223;84031;90686.54656726673;90768.5461572688;94158.52920735352;10457;10725.89274107249;10795.067667976968;10996.780064398507;11313.830292545783;39369;52521.21218181654;55214;55588.72205638946;56443.43556564382;55001.72499137479;76532.61733691518;77263;78030.6098469504;83718.16281837347;13391.631602853084;13674.794878077037;13900;14069.747209863122;14927.402903883723;14781;14932.30865466216;15647.139407332706;16470.505884823473;16865.747013795048;14526;14867.582636399497;15895.841041589898;16176.919115404347;16704.665906682043;15027.398904043715;15586.454474093352;15696.29366678525;15709.371625134867;16439.26023328977;13782.104163229358;14215.360308785923;14705.191214483306;14740.778888316898;14776.926115369355;11578.71053223676;11774.116941229613;11827.231229970024;12236.32700201462;12331.198472099284;11532.88467115318;12195.634130976085;12218.511259549874;12443.75112497763;12495.312757798409 17:30:09 INFO - PROCESS | 30668 | __end_tp_report 17:30:09 INFO - PROCESS | 30668 | __start_cc_report 17:30:09 INFO - PROCESS | 30668 | _x_x_mozilla_cycle_collect,996 17:30:09 INFO - PROCESS | 30668 | __end_cc_report 17:30:09 INFO - PROCESS | 30668 | __startTimestamp1476923409314__endTimestamp 17:30:09 INFO - PROCESS | 30668 | 17:30:09 INFO - PROCESS | 30668 | ------- Summary: start ------- 17:30:09 INFO - PROCESS | 30668 | Number of tests: 6 17:30:09 INFO - PROCESS | 30668 | 17:30:09 INFO - PROCESS | 30668 | [#0] dojo.html Cycles:165 Average:5553.69 Median:5777.80 stddev:650.70 (11.3%) stddev-sans-first:623.58 17:30:09 INFO - PROCESS | 30668 | Values: 3100.3 3141.5 3148.6 3169.2 3192.8 5486.2 5512.6 5534.4 5547.2 5552.9 5564.7 5616.2 5623.7 5628.3 5633.4 5033.5 5050.4 5083.6 5109.3 5131.0 5041.0 5089.7 5131.3 5134.9 5140.7 5006.7 5012.4 5041.3 5060.3 5073.5 5073.9 5074.7 5136.0 5143.3 5163.3 4845.4 5035.9 5062.7 5086.3 5110.6 5420.2 5435.2 5478.5 5489.6 5490.2 5787.5 5890.1 5903.4 5917.7 6008.5 5892.4 6030.5 6038.0 6040.2 6045.9 5536.7 5536.8 5537.7 5566.8 5659.5 6158.1 6189.4 6201.2 6202.3 6203.9 5724.4 5933.4 5950.5 5969.4 5971.1 5853.4 5890.2 5945.5 5946.6 5951.2 5914.9 5921.5 5921.8 5924.9 5926.8 5922.2 5937.9 5956.6 5962.8 6043.0 4634.4 4646.1 4647.7 4650.0 4684.1 4122.1 4126.2 4128.1 4138.2 4170.9 5468.5 5478.9 5538.6 5545.1 5568.1 5970.9 5975.6 5977.7 5979.0 6004.6 5537.9 5593.7 5594.5 5602.7 5602.8 4892.6 4936.0 4965.4 4978.2 5030.4 6280.5 6285.1 6289.0 6301.6 6312.7 6123.9 6128.5 6133.9 6135.9 6137.8 6006.5 6012.5 6140.3 6309.5 6325.3 5905.9 5937.7 5981.8 6009.2 6032.6 6067.0 6075.5 6083.7 6089.8 6091.0 5606.6 5719.7 5928.5 5933.0 5938.5 5836.5 5850.6 5869.2 5944.4 5973.0 5875.4 5886.4 5889.2 5891.5 5894.6 5735.7 5978.4 5981.2 5995.1 5999.5 5571.5 5739.4 5772.0 5777.8 5833.0 17:30:09 INFO - PROCESS | 30668 | 17:30:09 INFO - PROCESS | 30668 | [#1] ext.html Cycles:180 Average:66562.91 Median:21919.79 stddev:134184.13 (612.2%) stddev-sans-first:134469.10 17:30:09 INFO - PROCESS | 30668 | Values: 579.3 609.3 642.4 654.3 663.0 34683.3 46372.8 46884.3 46905.0 46942.0 48357.5 48688.0 48695.5 48715.3 48783.5 8370.5 8402.2 9269.5 9401.3 9416.8 11241.6 11462.4 11472.1 11474.1 11477.7 11324.2 11389.9 11390.8 11399.0 11419.2 8617.1 8770.0 8791.3 10889.7 11214.8 10724.2 11112.6 11126.7 11142.9 11168.0 46292.0 46484.3 46629.3 46653.5 46740.8 3858.2 3925.5 3948.6 4277.6 4439.0 35396.5 35425.1 35474.6 35543.6 35609.0 4640.6 4695.7 4706.5 4829.0 4864.6 357815.0 357853.0 358145.0 358300.0 359421.0 64662.4 64957.0 65105.3 65116.0 65190.7 67139.3 67221.3 67382.0 67441.0 67520.7 17959.1 18195.5 18199.2 18219.0 18222.3 12750.4 12839.6 12849.2 13076.5 13971.2 19606.9 19813.9 19814.8 19920.9 19938.5 5995.0 6126.4 6144.4 6166.5 6169.8 1027.2 1065.4 1071.7 1097.3 1155.3 33853.3 34611.1 34781.1 34924.1 35132.5 1076.4 1136.7 1215.3 1217.7 1244.3 17550.3 17711.6 17820.3 17883.9 18583.9 542133.0 548184.0 554461.0 566914.0 831332.0 62644.0 62985.1 63540.4 63556.7 63646.7 1327.4 1341.5 1351.9 1399.2 1415.4 33277.7 34897.0 34921.3 37405.8 38087.6 60679.4 61240.0 61285.7 61359.1 61486.7 496866.0 503336.0 503435.0 503447.0 504318.0 30442.4 31435.8 31509.2 31624.5 31630.7 50656.0 51492.0 51873.0 52371.0 52555.5 43139.4 43389.3 43547.0 43833.0 45004.5 43718.8 44561.3 45130.5 45296.5 46071.3 42779.4 43717.0 44496.8 44838.0 44993.3 36896.4 39008.8 39034.5 39118.9 39562.0 28925.3 29167.7 29181.9 29721.6 29839.3 17:30:09 INFO - PROCESS | 30668 | 17:30:09 INFO - PROCESS | 30668 | [#2] jquery.html Cycles:180 Average:30779.92 Median:2172.54 stddev:88423.61 (4070.1%) stddev-sans-first:88642.24 17:30:09 INFO - PROCESS | 30668 | Values: 399.6 440.2 440.8 441.3 452.8 17290.7 18779.6 20457.5 20789.9 21034.9 19281.5 19940.8 19977.4 20168.5 20505.7 5941.2 5972.5 6180.4 6188.1 6190.0 5992.8 6013.4 6056.7 6079.0 6081.6 5853.2 6028.1 6068.0 6080.3 6084.3 5960.1 5966.0 5990.1 5991.1 6064.4 5281.0 5401.8 5409.0 5481.1 5528.3 14097.2 14138.1 14148.4 14376.9 14424.3 2294.1 2354.8 2416.6 2432.4 3013.7 10286.2 10575.0 11079.3 11097.6 11112.7 2011.7 2066.4 2090.6 2101.1 2139.4 73013.0 85580.6 91208.0 91818.5 94440.5 10087.4 10461.5 10539.7 10606.4 10712.9 14404.6 15223.7 15344.9 15400.1 15908.4 6377.6 7911.4 7941.0 8139.3 8140.3 7308.3 7369.8 7553.0 7705.1 7772.9 4719.7 4840.0 5125.8 5173.1 5260.9 2038.9 2148.4 2158.1 2186.9 2242.0 902.9 1006.0 1009.4 1020.3 1115.6 19846.8 20090.2 20251.2 20351.2 20476.1 1017.7 1020.3 1023.2 1040.2 1072.2 10142.7 10857.2 10886.5 10981.3 11059.6 524627.0 531775.0 534656.0 538480.0 546833.0 100251.0 101825.5 102416.0 102969.5 103979.5 995.3 1016.4 1025.8 1032.1 1033.2 16950.6 17667.0 17941.7 19258.0 19260.9 45441.1 45905.8 46145.5 46514.3 47275.5 59591.7 60382.7 60468.4 60638.4 61325.4 8827.4 9103.1 9202.0 9284.4 9326.2 10298.6 13860.7 13866.4 14187.1 14705.6 11910.1 12007.7 12190.3 12278.9 12401.2 11959.7 12158.0 12202.5 12416.6 12527.6 12436.8 12647.7 12774.7 12879.2 12895.6 7869.6 8004.2 8147.5 8447.2 9511.1 8487.9 8611.8 8676.3 8719.7 9305.3 17:30:09 INFO - PROCESS | 30668 | 17:30:09 INFO - PROCESS | 30668 | [#3] mootools.html Cycles:180 Average:6173.24 Median:2539.32 stddev:3500.46 (137.9%) stddev-sans-first:3491.74 17:30:09 INFO - PROCESS | 30668 | Values: 1379.3 1447.6 1516.3 1630.7 1812.6 8011.6 8626.7 9074.5 9381.0 9384.0 9330.4 9409.6 9412.0 9413.5 9448.2 2519.2 2555.0 2557.9 2558.3 2564.1 2457.2 2545.6 2550.7 2551.9 2552.9 2516.2 2523.8 2576.2 2577.8 2583.9 2459.9 2467.0 2489.3 2540.4 2548.0 2456.9 2468.5 2477.5 2490.3 2537.3 9148.3 9304.0 9393.1 9424.6 9427.9 5357.6 5540.7 5547.3 5556.4 5560.3 3506.7 3572.9 3590.6 3611.5 3642.3 1203.9 1228.8 1269.5 1276.5 1281.8 12861.4 12888.8 12911.5 12968.5 12982.5 4726.1 4759.2 4765.7 4848.0 4965.9 10030.5 10045.4 10068.4 10070.8 10202.3 5491.9 5536.5 5549.1 5554.9 5556.6 4347.4 4609.7 4697.6 4732.6 5152.3 4105.5 4184.4 4211.3 4264.7 4285.7 1275.2 1295.6 1308.0 1308.2 1308.3 1021.9 1066.6 1071.0 1083.2 1084.3 6297.9 6429.3 6609.8 6647.8 6714.8 468.9 477.3 487.6 495.6 503.8 4349.0 4413.7 4414.6 4477.6 4485.0 11472.9 11754.8 11839.8 11858.5 11864.2 11008.8 11462.0 11469.5 11716.0 11730.5 8718.4 8880.2 8927.7 8930.7 8937.2 6297.8 6555.7 6565.4 6745.1 6751.1 10584.8 10840.0 10869.3 10976.9 11056.9 9672.1 10967.0 10968.2 11120.2 11136.2 7296.7 8058.6 8238.1 8684.1 8703.5 9277.0 9292.2 9293.1 9337.9 9352.6 7979.2 8261.9 8388.7 8425.0 8498.9 8197.6 8229.2 8355.2 8360.7 8467.8 7680.1 7790.9 7802.7 7803.5 7805.9 5622.1 5628.3 5788.9 5819.2 5853.1 5856.5 5927.1 5948.3 6003.2 6159.3 17:30:09 INFO - PROCESS | 30668 | 17:30:09 INFO - PROCESS | 30668 | [#4] prototype.html Cycles:180 Average:4886.71 Median:5515.54 stddev:1431.46 (26.0%) stddev-sans-first:1394.19 17:30:09 INFO - PROCESS | 30668 | Values: 339.7 358.4 358.8 366.5 371.1 5513.3 5561.6 5567.9 5580.6 5588.3 5205.5 5337.6 5352.7 5461.8 5529.0 4325.2 4333.2 4336.8 4344.9 4347.0 4330.2 4340.4 4343.2 4348.8 4355.3 4013.5 4106.3 4251.4 4297.9 4323.5 4258.9 4272.3 4286.0 4295.4 4299.1 3799.2 3827.2 3836.9 3842.9 3846.8 5194.6 5339.9 5353.4 5357.4 5393.6 4929.0 4944.0 4946.9 4947.1 4948.4 5730.6 5733.2 5735.9 5744.3 5752.7 4077.6 4216.9 4217.8 4218.5 4256.4 5975.7 5996.1 5997.2 6000.7 6007.9 4355.7 4365.5 4368.0 4372.7 4396.9 4339.8 4378.0 4382.3 4403.3 4418.3 4936.8 4948.0 4953.6 4961.8 4964.3 5738.5 5759.6 5803.4 5804.1 5809.3 1404.4 1414.2 1472.1 1484.3 1496.9 958.2 995.8 1005.2 1018.7 1024.3 5507.3 5517.8 5518.1 5521.7 5526.0 5661.3 5874.1 5880.7 5890.6 5909.8 5401.6 5489.2 5504.4 5507.5 5513.3 3115.2 3122.5 3124.7 3126.8 3130.4 5856.0 6011.1 6015.9 6127.0 6234.0 6128.2 6131.5 6141.3 6147.6 6151.8 5915.2 6139.4 6158.9 6164.6 6173.9 5956.4 5984.5 6015.2 6018.9 6024.5 5948.0 5949.8 5961.1 5961.8 5966.5 5879.8 6145.7 6194.0 6195.7 6228.8 4271.0 4282.2 4287.4 4293.3 4300.1 5816.7 5960.9 5997.6 6020.8 6034.6 5824.6 5838.1 5842.9 5845.0 5855.3 5800.0 5828.3 5841.4 5841.9 5844.7 5408.8 5474.3 5751.7 5774.2 5794.9 5869.3 5871.6 5872.2 5875.9 5879.8 5537.9 5693.0 5727.3 5729.3 5746.5 17:30:09 INFO - PROCESS | 30668 | 17:30:09 INFO - PROCESS | 30668 | [#5] yui.html Cycles:180 Average:21871.67 Median:3694.95 stddev:31123.53 (842.3%) stddev-sans-first:31170.71 17:30:09 INFO - PROCESS | 30668 | Values: 823.6 829.3 852.3 877.8 924.9 16775.3 18122.9 18150.5 18155.1 18168.5 16289.3 16363.1 16520.8 16526.9 16557.8 710.6 727.1 831.2 841.0 861.6 858.4 859.7 860.8 861.5 861.5 755.0 904.6 906.4 906.5 906.8 766.9 885.2 902.1 915.8 918.2 672.8 673.5 676.5 676.8 677.5 15829.4 15856.2 15916.9 15921.5 15947.8 15374.2 15676.4 15732.9 15740.3 15986.9 14197.5 14251.4 14262.1 14414.0 14712.8 4704.0 4705.9 4748.5 4802.6 4822.2 80434.2 82458.2 82919.6 85428.0 88058.6 11665.2 11815.8 11957.3 11958.4 12464.8 21776.0 22125.4 22145.0 22148.1 22166.4 8810.3 8937.3 9022.6 9073.4 9248.7 4783.6 4856.4 4892.9 4966.6 5216.2 3535.4 3672.0 3689.6 3700.3 3708.4 681.5 707.4 710.6 711.1 715.6 695.9 738.4 791.0 791.8 794.1 10517.0 10731.0 10813.2 10932.2 11023.7 604.5 737.2 745.4 809.8 814.9 4853.9 4978.8 5021.5 5022.4 5081.9 97374.0 126926.4 127167.0 131872.3 132516.0 85803.1 102780.5 104732.0 105472.0 108655.5 54223.0 84031.0 90686.5 90768.5 94158.5 10457.0 10725.9 10795.1 10996.8 11313.8 39369.0 52521.2 55214.0 55588.7 56443.4 55001.7 76532.6 77263.0 78030.6 83718.2 13391.6 13674.8 13900.0 14069.7 14927.4 14781.0 14932.3 15647.1 16470.5 16865.7 14526.0 14867.6 15895.8 16176.9 16704.7 15027.4 15586.5 15696.3 15709.4 16439.3 13782.1 14215.4 14705.2 14740.8 14776.9 11578.7 11774.1 11827.2 12236.3 12331.2 11532.9 12195.6 12218.5 12443.8 12495.3 17:30:09 INFO - PROCESS | 30668 | -------- Summary: end -------- 17:30:09 INFO - PROCESS | 30668 | 17:30:10 INFO - TEST-INFO | 30668: exit 0 17:30:10 INFO - TEST-OK | dromaeo_css | took 1114070ms 17:30:10 INFO - TEST-START | kraken 17:30:10 INFO - operating with platform_type : linux_ 17:30:10 INFO - Initialising browser for kraken test... 17:30:10 INFO - TEST-INFO | started process 30991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewRa65/profile http://localhost:36829/getInfo.html) 17:30:14 INFO - PROCESS | 30991 | __metrics Screen width/height:1600/1200 17:30:14 INFO - PROCESS | 30991 | colorDepth:24 17:30:14 INFO - PROCESS | 30991 | Browser inner width/height: 1024/697 17:30:14 INFO - PROCESS | 30991 | __metrics 17:30:14 INFO - PROCESS | 30991 | 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" 17:30:14 INFO - PROCESS | 30991 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:30:15 INFO - PROCESS | 30991 | console.error: PushService: 17:30:15 INFO - PROCESS | 30991 | stateChangeProcessEnqueue: Error transitioning state 17:30:15 INFO - PROCESS | 30991 | UnknownError 17:30:15 INFO - TEST-INFO | 30991: exit 0 17:30:15 INFO - Browser initialized. 17:30:15 INFO - Running cycle 1/1 for kraken test... 17:30:15 INFO - TEST-INFO | started process 31079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewRa65/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:30:27 INFO - PROCESS | 31079 | RSS: Main: 143769600 17:30:27 INFO - PROCESS | 31079 | 17:30:29 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36829/tests/kraken/driver.html?testName=audio-beat-detection) 17:30:30 INFO - PROCESS | 31079 | RSS: Main: 186011648 17:30:30 INFO - PROCESS | 31079 | 17:30:33 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36829/tests/kraken/driver.html?testName=audio-dft) 17:30:33 INFO - PROCESS | 31079 | RSS: Main: 175271936 17:30:33 INFO - PROCESS | 31079 | 17:30:36 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36829/tests/kraken/driver.html?testName=audio-fft) 17:30:37 INFO - PROCESS | 31079 | RSS: Main: 266530816 17:30:37 INFO - PROCESS | 31079 | 17:30:39 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36829/tests/kraken/driver.html?testName=audio-oscillator) 17:30:39 INFO - PROCESS | 31079 | RSS: Main: 173027328 17:30:39 INFO - PROCESS | 31079 | 17:30:42 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36829/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:30:42 INFO - PROCESS | 31079 | RSS: Main: 174923776 17:30:42 INFO - PROCESS | 31079 | 17:30:45 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36829/tests/kraken/driver.html?testName=imaging-darkroom) 17:30:46 INFO - PROCESS | 31079 | RSS: Main: 210948096 17:30:46 INFO - PROCESS | 31079 | 17:30:49 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36829/tests/kraken/driver.html?testName=imaging-desaturate) 17:30:50 INFO - PROCESS | 31079 | RSS: Main: 210042880 17:30:50 INFO - PROCESS | 31079 | 17:30:52 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36829/tests/kraken/driver.html?testName=json-parse-financial) 17:30:53 INFO - PROCESS | 31079 | RSS: Main: 209559552 17:30:53 INFO - PROCESS | 31079 | 17:30:54 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36829/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:30:55 INFO - PROCESS | 31079 | RSS: Main: 171421696 17:30:55 INFO - PROCESS | 31079 | 17:30:57 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:30:57 INFO - PROCESS | 31079 | RSS: Main: 178491392 17:30:57 INFO - PROCESS | 31079 | 17:30:59 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:31:00 INFO - PROCESS | 31079 | RSS: Main: 188432384 17:31:00 INFO - PROCESS | 31079 | 17:31:02 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:31:03 INFO - PROCESS | 31079 | RSS: Main: 196493312 17:31:03 INFO - PROCESS | 31079 | 17:31:06 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:31:06 INFO - PROCESS | 31079 | RSS: Main: 193818624 17:31:06 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36829/tests/kraken/driver.html?testName=ai-astar) 17:31:08 INFO - PROCESS | 31079 | RSS: Main: 245571584 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | __start_tp_report 17:31:08 INFO - PROCESS | 31079 | _x_x_mozilla_page_load 17:31:08 INFO - PROCESS | 31079 | _x_x_mozilla_page_load_details 17:31:08 INFO - PROCESS | 31079 | |i|pagename|runs| 17:31:08 INFO - PROCESS | 31079 | |0;ai-astar;109;113;110;110;111;110;109;110;110;110 17:31:08 INFO - PROCESS | 31079 | |1;audio-beat-detection;145;116;116;152;118;118;120;116;147;119 17:31:08 INFO - PROCESS | 31079 | |2;audio-dft;161;160;161;165;162;163;161;161;161;161 17:31:08 INFO - PROCESS | 31079 | |3;audio-fft;75;75;75;103;77;76;75;75;97;76 17:31:08 INFO - PROCESS | 31079 | |4;audio-oscillator;83;82;129;81;82;82;101;81;81;112 17:31:08 INFO - PROCESS | 31079 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;116;117;117 17:31:08 INFO - PROCESS | 31079 | |6;imaging-darkroom;147;146;147;146;146;146;146;146;146;146 17:31:08 INFO - PROCESS | 31079 | |7;imaging-desaturate;95;95;96;96;95;96;95;95;95;96 17:31:08 INFO - PROCESS | 31079 | |8;json-parse-financial;49;49;49;50;50;49;50;49;49;49 17:31:08 INFO - PROCESS | 31079 | |9;json-stringify-tinderbox;59;61;60;62;60;59;60;60;60;61 17:31:08 INFO - PROCESS | 31079 | |10;stanford-crypto-aes;74;74;73;72;71;73;74;73;72;73 17:31:08 INFO - PROCESS | 31079 | |11;stanford-crypto-ccm;124;124;118;124;132;132;119;120;158;120 17:31:08 INFO - PROCESS | 31079 | |12;stanford-crypto-pbkdf2;153;153;152;150;157;152;150;156;152;151 17:31:08 INFO - PROCESS | 31079 | |13;stanford-crypto-sha256-iterative;68;65;63;63;63;67;63;64;62;64 17:31:08 INFO - PROCESS | 31079 | __end_tp_report 17:31:08 INFO - PROCESS | 31079 | __start_cc_report 17:31:08 INFO - PROCESS | 31079 | _x_x_mozilla_cycle_collect,1622 17:31:08 INFO - PROCESS | 31079 | __end_cc_report 17:31:08 INFO - PROCESS | 31079 | __startTimestamp1476923468701__endTimestamp 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | ------- Summary: start ------- 17:31:08 INFO - PROCESS | 31079 | Number of tests: 14 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:1.14 (1.0%) stddev-sans-first:1.12 17:31:08 INFO - PROCESS | 31079 | Values: 109.0 113.0 110.0 110.0 111.0 110.0 109.0 110.0 110.0 110.0 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:119.50 stddev:14.86 (12.4%) stddev-sans-first:14.20 17:31:08 INFO - PROCESS | 31079 | Values: 145.0 116.0 116.0 152.0 118.0 118.0 120.0 116.0 147.0 119.0 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.00 stddev:1.43 (0.9%) stddev-sans-first:1.50 17:31:08 INFO - PROCESS | 31079 | Values: 161.0 160.0 161.0 165.0 162.0 163.0 161.0 161.0 161.0 161.0 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.50 stddev:10.45 (13.8%) stddev-sans-first:10.90 17:31:08 INFO - PROCESS | 31079 | Values: 75.0 75.0 75.0 103.0 77.0 76.0 75.0 75.0 97.0 76.0 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:81.50 stddev:16.97 (20.8%) stddev-sans-first:17.72 17:31:08 INFO - PROCESS | 31079 | Values: 83.0 82.0 129.0 81.0 82.0 82.0 101.0 81.0 81.0 112.0 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:31:08 INFO - PROCESS | 31079 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 17:31:08 INFO - PROCESS | 31079 | Values: 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:31:08 INFO - PROCESS | 31079 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:49.00 stddev:0.48 (1.0%) stddev-sans-first:0.50 17:31:08 INFO - PROCESS | 31079 | Values: 49.0 49.0 49.0 50.0 50.0 49.0 50.0 49.0 49.0 49.0 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 17:31:08 INFO - PROCESS | 31079 | Values: 59.0 61.0 60.0 62.0 60.0 59.0 60.0 60.0 60.0 61.0 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:0.99 (1.4%) stddev-sans-first:0.97 17:31:08 INFO - PROCESS | 31079 | Values: 74.0 74.0 73.0 72.0 71.0 73.0 74.0 73.0 72.0 73.0 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:124.00 stddev:11.93 (9.6%) stddev-sans-first:12.60 17:31:08 INFO - PROCESS | 31079 | Values: 124.0 124.0 118.0 124.0 132.0 132.0 119.0 120.0 158.0 120.0 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:152.50 stddev:2.32 (1.5%) stddev-sans-first:2.46 17:31:08 INFO - PROCESS | 31079 | Values: 153.0 153.0 152.0 150.0 157.0 152.0 150.0 156.0 152.0 151.0 17:31:08 INFO - PROCESS | 31079 | 17:31:08 INFO - PROCESS | 31079 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.93 (3.0%) stddev-sans-first:1.48 17:31:08 INFO - PROCESS | 31079 | Values: 68.0 65.0 63.0 63.0 63.0 67.0 63.0 64.0 62.0 64.0 17:31:08 INFO - PROCESS | 31079 | -------- Summary: end -------- 17:31:08 INFO - PROCESS | 31079 | 17:31:09 INFO - TEST-INFO | 31079: exit 0 17:31:09 INFO - TEST-OK | kraken | took 59768ms 17:31:09 INFO - SUITE-END | took 1173s 17:31:09 INFO - Completed test suite (00:19:33) 17:31:09 INFO - javascript benchmark 17:31:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3100.27143621249, 3141.450246206913, 3148.590683211181, 3169.1918560767, 3192.840357982102, 5486.204500347452, 5512.5589952803775, 5534.446555344473, 5547.223388725577, 5552.888942221153, 5564.666120032801, 5616.185653080312, 5623.690697011662, 5628.32460104787, 5633.436656334375, 5033.546980771739, 5050.444451110375, 5083.618728595352, 5109.284700141964, 5131.0, 5041.0422019816115, 5089.669171503859, 5131.255967884655, 5134.897302053957, 5140.742962851861, 5006.69959802413, 5012.398512178544, 5041.344625198737, 5060.342155519796, 5073.467285934979, 5073.949260507385, 5074.695518268897, 5135.998480296344, 5143.305653736735, 5163.251328557376, 4845.4185497740145, 5035.924461133086, 5062.683702237408, 5086.338775959139, 5110.5911527078115, 5420.159875219348, 5435.239066530688, 5478.479544443271, 5489.615726899118, 5490.203920431515, 5787.479126878559, 5890.145928840337, 5903.439173278532, 5917.733701983421, 6008.459238668541, 5892.351841297454, 6030.517558595302, 6038.0, 6040.184575082396, 6045.909311360333, 5536.667799932017, 5536.806211782608, 5537.723113844332, 5566.805161819317, 5659.518940890071, 6158.107074474266, 6189.442950134509, 6201.162843016225, 6202.317745048041, 6203.875922481525, 5724.427557244242, 5933.376995415506, 5950.494207992283, 5969.373215812364, 5971.0744834550715, 5853.414658534198, 5890.175375447441, 5945.464908158287, 5946.554008449383, 5951.226340575784, 5914.8817023659285, 5921.467067963904, 5921.792737254175, 5924.851878702981, 5926.762929482858, 5922.200502932135, 5937.881242375129, 5956.583039187215, 5962.821115366546, 6043.033114701627, 4634.397528321297, 4646.094011667692, 4647.651426142985, 4649.976750116295, 4684.133435314409, 4122.051928056564, 4126.195391898551, 4128.091819799639, 4138.151678905817, 4170.91658166841, 5468.535174510132, 5478.890422191614, 5538.6122971391615, 5545.057340252167, 5568.053430916754, 5970.940290597038, 5975.611585246945, 5977.731002104829, 5979.0, 6004.579679422399, 5537.944620553743, 5593.720313984366, 5594.468525490072, 5602.747876345574, 5602.831915042555, 4892.608591312686, 4936.0, 4965.4289756678445, 4978.153713868651, 5030.446650868402, 6280.466160376419, 6285.088662144055, 6289.0252010938375, 6301.6219026858535, 6312.652804095819, 6123.938760612336, 6128.509719222362, 6133.938660613515, 6135.877282454415, 6137.7851775187655, 6006.489448396936, 6012.518998480198, 6140.293866205265, 6309.463695585927, 6325.335839736946, 5905.91141132892, 5937.732802023833, 5981.7607295707685, 6009.218801555945, 6032.638041717335, 6067.0, 6075.483583895241, 6083.726232319645, 6089.786857459968, 6090.969545152246, 5606.607537472501, 5719.742611582572, 5928.525717942468, 5933.0, 5938.495227905676, 5836.503897168788, 5850.5904586678525, 5869.207656966255, 5944.4352786485215, 5972.970135149297, 5875.441833025856, 5886.411358864079, 5889.234399528034, 5891.469767720926, 5894.646321220741, 5735.71321433935, 5978.372270911492, 5981.162637230704, 5995.130706047686, 5999.520038397005, 5571.498565129158, 5739.368669446441, 5771.97114014444, 5777.7977770777825, 5832.970835145967], "value": 5508.339577026814, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.3250862744902, 609.2658346692236, 642.4282388674081, 654.2737561306949, 662.9569078009926, 34683.30633387334, 46372.76813615931, 46884.29673554895, 46905.0, 46942.0, 48357.51642483574, 48688.0, 48695.51304486954, 48715.26927096096, 48783.51216487834, 8370.53962032088, 8402.15978402161, 9269.490178040222, 9401.294902882277, 9416.81166376672, 11241.550337986471, 11462.369569673665, 11472.139589530818, 11474.139439542027, 11477.655670329861, 11324.207305488619, 11389.943050284737, 11390.772184556305, 11399.0, 11419.200655954086, 8617.09520500351, 8770.035296117421, 8791.296696264284, 10889.673309800719, 11214.831777523344, 10724.195685323632, 11112.555497780078, 11126.721831954184, 11142.888571114347, 11168.0, 46292.0, 46484.302735458994, 46629.30056049162, 46653.5334646656, 46740.7662961683, 3858.1704933439446, 3925.509311336083, 3948.5853985331414, 4277.572242775728, 4438.977805110986, 35396.469052964225, 35425.11437214065, 35474.645253547395, 35543.64456355429, 35609.0, 4640.605548528345, 4695.741734204617, 4706.482286948467, 4829.0, 4864.635152363551, 357815.0, 357853.0, 358145.0, 358300.0, 359421.0, 64662.35337646563, 64957.0, 65105.34894651087, 65116.0, 65190.674046629465, 67139.32860671429, 67221.32778672248, 67381.989270161, 67441.0, 67520.66239668771, 17959.102044897703, 18195.545111372056, 18199.181036853373, 18219.0, 18222.27110915575, 12750.426230819636, 12839.614811555668, 12849.164804287691, 13076.54232101891, 13971.161730296011, 19606.901965490368, 19813.900930495256, 19814.801851981294, 19920.90039549793, 19938.501537461678, 5994.970025149846, 6126.387361263838, 6144.361007439355, 6166.506679465632, 6169.784057557964, 1027.1577306608658, 1065.4033741105006, 1071.6624263357019, 1097.3032124600936, 1155.306815910447, 33853.32293354119, 34611.13472163166, 34781.1304717379, 34924.13409596413, 35132.473012904826, 1076.364944682641, 1136.652558216046, 1215.3133479584008, 1217.6590554644713, 1244.2783185752241, 17550.29798808059, 17711.645767084843, 17820.287188512313, 17883.910580447013, 18583.907080464513, 542133.0, 548184.0, 554461.0, 566914.0, 831332.0, 62644.0, 62985.05522417167, 63540.36459635437, 63556.68221658954, 63646.68176659087, 1327.422571181539, 1341.5438750824767, 1351.9121257118256, 1399.1744870526438, 1415.419677932043, 33277.667223328426, 34897.0, 34921.30157396787, 37405.81297093606, 38087.61912380951, 60679.393206067376, 61240.0, 61285.693571533644, 61359.07961380493, 61486.69256653688, 496866.0, 503336.0, 503435.0, 503447.0, 504318.0, 30442.39115217639, 31435.84282078575, 31509.212269692525, 31624.525632115077, 31630.683693162773, 50656.0, 51492.0, 51873.0, 52371.0, 52555.47444525506, 43139.352909705754, 43389.34915976326, 43547.0, 43833.0, 45004.549954500035, 43718.78140609276, 44561.33158002698, 45130.54869451395, 45296.547034529234, 46071.308930366744, 42779.358309626004, 43717.0, 44496.77751611221, 44838.0, 44993.32510012287, 36896.44655330118, 39008.804955975036, 39034.53434733824, 39118.87846358345, 39562.0, 28925.276868078465, 29167.7083229165, 29181.854090729412, 29721.554176686936, 29839.254018649706], "value": 21903.347567216144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.6023956163618, 440.1527060408713, 440.8164079446687, 441.2785096367438, 452.75098695717367, 17290.654186916254, 18779.62440751184, 20457.4885627859, 20789.896050519725, 21034.89482552585, 19281.517962050955, 19940.806511283747, 19977.400677979684, 20168.495787605316, 20505.692414613794, 5941.19793827832, 5972.492338151263, 6180.351063138373, 6188.071789231606, 6190.0, 5992.760289588433, 6013.428724271187, 6056.666883321415, 6078.969605151968, 6081.574289799716, 5853.239078919734, 6028.125921741344, 6068.0291153415465, 6080.331163572004, 6084.300305464884, 5960.105984102376, 5966.045432730764, 5990.101484777297, 5991.071383935497, 6064.363241859607, 5280.973595132, 5401.837944861661, 5409.0, 5481.123020316731, 5528.281323427928, 14097.224652644101, 14138.08102473336, 14148.363323650461, 14376.856231437656, 14424.27878606076, 2294.128231272123, 2354.799842013431, 2416.6012607919674, 2432.391902024494, 3013.6835632258517, 10286.177105831515, 10575.0, 11079.335239885633, 11097.611583594535, 11112.722181945515, 2011.7485314335709, 2066.3904148276297, 2090.5505316356903, 2101.075526768217, 2139.4330502416874, 73013.0, 85580.57209713911, 91208.0, 91818.5409072957, 94440.52779736057, 10087.394756314645, 10461.529231184615, 10539.683809485728, 10606.41664708433, 10712.892871071346, 14404.639884002774, 15223.695526089416, 15344.923275383775, 15400.07599544031, 15908.44320448802, 6377.553571249968, 7911.446198766032, 7941.0, 8139.267465927976, 8140.3312320974055, 7308.342249197598, 7369.77890663281, 7552.962235188898, 7705.075390953009, 7772.883406748903, 4719.740414277179, 4840.031993601294, 5125.846224613268, 5173.094708426011, 5260.92108618371, 2038.8572799903864, 2148.398448434441, 2158.136745301892, 2186.9343919682433, 2242.0, 902.869083982832, 1005.9899401005896, 1009.3943633819649, 1020.3318322586383, 1115.6318414923055, 19846.801531984496, 20090.196392144444, 20251.18909757808, 20351.185952562028, 20476.078576464093, 1017.6641708236265, 1020.3265844542566, 1023.2376879225025, 1040.1730624153815, 1072.2172813845937, 10142.746431339276, 10857.185711071701, 10886.455677216107, 10981.341119532693, 11059.612913548148, 524627.0, 531775.0, 534656.0, 538480.0, 546833.0, 100250.99999999854, 101825.49087254665, 102416.0, 102969.48515257526, 103979.480102599, 995.328153496387, 1016.4307987527009, 1025.8409946458312, 1032.1175395037135, 1033.1631378583372, 16950.576235593715, 17667.0, 17941.730874037163, 19258.0, 19260.903695481993, 45441.09117817691, 45905.77047114743, 46145.53854461547, 46514.30228546507, 47275.52724472711, 59591.702041489516, 60382.698086511045, 60468.39531604628, 60638.39361606327, 61325.38674613197, 8827.426217295855, 9103.089691030844, 9201.953990230273, 9284.396514226553, 9326.207272381653, 10298.588056477956, 13860.722785544434, 13866.376013079234, 14187.077839940372, 14705.55883323502, 11910.106741994558, 12007.699807504881, 12190.329531875832, 12278.877211227773, 12401.210946476624, 11959.701007474883, 12158.0, 12202.511899523919, 12416.56542021061, 12527.56153534622, 12436.813447798471, 12647.747045059232, 12774.744505110031, 12879.162854414433, 12895.613131606067, 7869.645865935932, 8004.199580041949, 8147.470414423044, 8447.239748422671, 9511.143997040299, 8487.8726819099, 8611.827763444571, 8676.349273804617, 8719.727333606614, 9305.302102342215], "value": 9371.613779025709, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.3448112146725, 1447.6236178593563, 1516.2873449478745, 1630.7309293966496, 1812.6465339258841, 8011.599420028997, 8626.74119776407, 9074.455532668037, 9381.0, 9383.953080234607, 9330.44017358959, 9409.576569054392, 9411.964683884768, 9413.52932353383, 9448.244140468763, 2519.1560827122935, 2554.9744502555013, 2557.9232623021244, 2558.3092565007437, 2564.064116597447, 2457.1522824625476, 2545.5545279576095, 2550.681164854393, 2551.8724063796735, 2552.8595927223996, 2516.219971808736, 2523.7980961523035, 2576.2142546523396, 2577.755113264246, 2583.870806459679, 2459.8893049812714, 2466.987665061672, 2489.3278814720106, 2540.390306326487, 2548.0317479357727, 2456.9017239310406, 2468.469279104983, 2477.467344520937, 2490.302715239736, 2537.2895589235045, 9148.2681385489, 9304.0, 9393.107654772853, 9424.575894084783, 9427.858582121273, 5357.571394288448, 5540.695261760601, 5547.306586676666, 5556.361018482886, 5560.277163968699, 3506.6843984041557, 3572.8749493767596, 3590.569131704186, 3611.5305010348748, 3642.25333806569, 1203.9097067719956, 1228.7726770547388, 1269.4668239339499, 1276.5468258768096, 1281.807728840672, 12861.356932153354, 12888.80666789999, 12911.483540658362, 12968.481260749653, 12982.480700771957, 4726.07103041886, 4759.23852183649, 4765.7140571565815, 4847.95152048475, 4965.851024469272, 10030.498475076218, 10045.397276163454, 10068.44623545712, 10070.798584028278, 10202.28583999113, 5491.890162196813, 5536.529395001389, 5549.056660367747, 5554.861128471821, 5556.638818476867, 4347.413099231627, 4609.700369475973, 4697.647676424282, 4732.574068333797, 5152.252923326097, 4105.548389677133, 4184.4351012613515, 4211.284081706117, 4264.722793018444, 4285.6785741068925, 1275.152023904112, 1295.598364507006, 1308.0451270572535, 1308.215070957418, 1308.3262120008203, 1021.8978102189722, 1066.5733706517456, 1070.9892901071046, 1083.1930211992117, 1084.2897901874285, 6297.905531417033, 6429.260635026938, 6609.778552124902, 6647.779418219528, 6714.83212919681, 468.9413823272091, 477.3245857112217, 487.5563237453971, 495.56637941800926, 503.84128999365083, 4348.9565104349185, 4413.691041627119, 4414.646828253732, 4477.619402350771, 4484.977575112103, 11472.885271147348, 11754.76490470203, 11839.822402663967, 11858.525658973544, 11864.22882512634, 11008.779824403468, 11462.0, 11469.483873225558, 11716.0, 11730.530778768923, 8718.389712720049, 8880.200781929529, 8927.732168034969, 8930.687425940061, 8937.150970657776, 6297.842553936005, 6555.70499327541, 6565.409113179837, 6745.123133992746, 6751.122354093936, 10584.788304233718, 10840.024397804236, 10869.29349592274, 10976.890231097586, 11056.889431105586, 9672.129508344282, 10967.0, 10968.23222374458, 11120.221584489333, 11136.220464567403, 7296.746342633295, 8058.637361318872, 8238.093809680811, 8684.088170741981, 8703.521306328214, 9276.953615231881, 9292.210162136294, 9293.070692930653, 9337.85993210116, 9352.625894964125, 7979.16218797018, 8261.917380826355, 8388.679471070434, 8425.0, 8498.91501085006, 8197.631106600336, 8229.218224268685, 8355.164483551596, 8360.665573376997, 8467.78830529217, 7680.078390593165, 7790.9220907790195, 7802.726904558313, 7803.531788092732, 7805.921940780519, 5622.100463925915, 5628.324601047737, 5788.8552786179, 5819.156222347651, 5853.1220316952795, 5856.502197313276, 5927.081302398135, 5948.256467941507, 6003.219581454558, 6159.29168145669], "value": 4864.565334521181, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.6603396603397, 358.4157822748919, 358.7793506993199, 366.47593940664837, 371.0852747976238, 5513.318437876446, 5561.610687251894, 5567.916481252784, 5580.581456390772, 5588.273524441827, 5205.479452054793, 5337.626366154371, 5352.661834541364, 5461.8152738904455, 5529.0, 4325.188627392189, 4333.220020396319, 4336.761478118702, 4344.891377715567, 4346.97826510867, 4330.155619654169, 4340.414044104053, 4343.19650864591, 4348.760818155, 4355.281378572532, 4013.4581831452674, 4106.28140075487, 4251.3622956556455, 4297.871063868089, 4323.459567554056, 4258.8509402171085, 4272.252355837716, 4286.03564198056, 4295.398644189816, 4299.140171965604, 3799.2211596622624, 3827.1962887793597, 3836.865709700147, 3842.8847134585726, 3846.788426636534, 5194.558462530689, 5339.946600533984, 5353.357597088374, 5357.357117145929, 5393.568514518829, 4928.975355123202, 4943.975280123576, 4946.9010619787405, 4947.109520286347, 4948.406191257036, 5730.570207234432, 5733.226014488033, 5735.913961290584, 5744.310682718059, 5752.741126649269, 4077.5524688735663, 4216.852410165629, 4217.789110544491, 4218.451601291843, 4256.382824490432, 5975.731092100866, 5996.121861506458, 5997.241269016301, 6000.729967151445, 6007.909881351783, 4355.716878402894, 4365.454318210223, 4368.0, 4372.650187984954, 4396.868093957187, 4339.783010849508, 4377.978110109493, 4382.298832186835, 4403.251447253911, 4418.293073108352, 4936.802527898915, 4947.960928205045, 4953.578945789576, 4961.7672047578735, 4964.255361695702, 5738.454846789548, 5759.625624334405, 5803.361630220672, 5804.100364443518, 5809.302883653989, 1404.403128670311, 1414.165642271065, 1472.138798802691, 1484.2875419798556, 1496.9326380312912, 958.1568219966385, 995.770972676274, 1005.1857995024054, 1018.7147598672384, 1024.329064462778, 5507.339119305709, 5517.751701173457, 5518.068675963461, 5521.723913804293, 5525.950069486785, 5661.2923384576925, 5874.061559685294, 5880.676562789087, 5890.587658863924, 5909.8227053188475, 5401.6218864679095, 5489.216004798456, 5504.4495550444635, 5507.531859791962, 5513.283273174462, 3115.190050586864, 3122.469989705028, 3124.6719094495206, 3126.8436578171, 3130.4365214261197, 5856.0, 6011.09833524966, 6015.909761353583, 6126.958417069109, 6233.968830155911, 6128.203333566607, 6131.478824299896, 6141.263048434216, 6147.600405973598, 6151.784687535915, 5915.155149152913, 6139.416755408319, 6158.922188616974, 6164.599301045418, 6173.876522469525, 5956.404359564009, 5984.521238301013, 6015.157877897185, 6018.856417280703, 6024.487918526975, 5948.0, 5949.791757288474, 5961.076033214858, 5961.823934264049, 5966.522678185822, 5879.794207202727, 6145.66198859067, 6194.0, 6195.721192546436, 6228.781992630417, 4271.049279416589, 4282.207791558571, 4287.442632457761, 4293.270144075577, 4300.118475712409, 5816.7024025508845, 5960.850978725566, 5997.580169388101, 6020.819375418744, 6034.63792172471, 5824.621399609012, 5838.131797824655, 5842.874062376608, 5844.970775146097, 5855.268091488564, 5800.0, 5828.271466066742, 5841.415858414294, 5841.853953651193, 5844.6785426801935, 5408.782399216302, 5474.315710536183, 5751.683657398883, 5774.249347584787, 5794.942050579609, 5869.295684517885, 5871.563301229941, 5872.236609240942, 5875.911861322169, 5879.824464947997, 5537.889242215214, 5692.971535142297, 5727.31272247333, 5729.3124825019595, 5746.454086861741], "value": 4433.150984196191, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.5799742131511, 829.3282441222607, 852.3394369363742, 877.8463768840453, 924.8589366605735, 16775.328986840526, 18122.909385453087, 18150.455486335413, 18155.092245387743, 18168.54578635535, 16289.348426062943, 16363.100029498373, 16520.83479165208, 16526.917365413155, 16557.751633725504, 710.6233696141054, 727.149235394587, 831.2186544648011, 841.0496139362511, 861.5735211070497, 858.3776761847641, 859.7205908079868, 860.7546849147994, 861.4788053227801, 861.543382007537, 755.037327407557, 904.5658084119626, 906.3881879731188, 906.4923642760042, 906.8141031088611, 766.9041369828772, 885.2475395913486, 902.0573500691826, 915.7939463620633, 918.237862574062, 672.7981605518374, 673.5318953327439, 676.4892506157869, 676.8375589858448, 677.4681874728315, 15829.44596939113, 15856.207189640587, 15916.920415397964, 15921.522354329389, 15947.760783588255, 15374.231288435534, 15676.372945082183, 15732.921335393365, 15740.291686874118, 15986.920065399714, 14197.503087391995, 14251.429942802275, 14262.144271343752, 14414.0, 14712.779308310384, 4703.952960470386, 4705.882352941169, 4748.5251474852585, 4802.615790736732, 4822.228443449031, 80434.19565804326, 82458.17541824565, 82919.5854020726, 85428.0, 88058.5597072017, 11665.183437159318, 11815.822762658567, 11957.342346171044, 11958.40207989597, 12464.750704985849, 21776.020079096477, 22125.446863828533, 22145.0, 22148.114075436803, 22166.445838854157, 8810.339224558184, 8937.329700272505, 9022.593983270768, 9073.364864459556, 9248.722538323862, 4783.617310615143, 4856.368672072678, 4892.8532144035735, 4966.577840883565, 5216.191490319006, 3535.4343305071066, 3672.045268230226, 3689.5756987946193, 3700.3339398907915, 3708.369577171887, 681.4616453002172, 707.4163814852767, 710.5985118408083, 711.0969069281983, 715.6457553511045, 695.8817001109824, 738.3650060947581, 791.0, 791.8495485857669, 794.1224946434222, 10517.0, 10731.0, 10813.18901082422, 10932.234743567873, 11023.669289921316, 604.5375287904757, 737.2406421385981, 745.3738859358165, 809.8461292354434, 814.9022117345957, 4853.854384368475, 4978.8257410990445, 5021.472745361758, 5022.447530771612, 5081.949180508148, 97374.0, 126926.36536817257, 127167.0, 131872.34063829618, 132516.0, 85803.14196858076, 102780.48609756904, 104732.0, 105472.0, 108655.45672271588, 54223.0, 84031.0, 90686.54656726673, 90768.5461572688, 94158.52920735352, 10457.0, 10725.89274107249, 10795.067667976968, 10996.780064398507, 11313.830292545783, 39369.0, 52521.21218181654, 55214.0, 55588.72205638946, 56443.43556564382, 55001.72499137479, 76532.61733691518, 77263.0, 78030.6098469504, 83718.16281837347, 13391.631602853084, 13674.794878077037, 13900.0, 14069.747209863122, 14927.402903883723, 14781.0, 14932.30865466216, 15647.139407332706, 16470.505884823473, 16865.747013795048, 14526.0, 14867.582636399497, 15895.841041589898, 16176.919115404347, 16704.665906682043, 15027.398904043715, 15586.454474093352, 15696.29366678525, 15709.371625134867, 16439.26023328977, 13782.104163229358, 14215.360308785923, 14705.191214483306, 14740.778888316898, 14776.926115369355, 11578.71053223676, 11774.116941229613, 11827.231229970024, 12236.32700201462, 12331.198472099284, 11532.88467115318, 12195.634130976085, 12218.511259549874, 12443.75112497763, 12495.312757798409], "value": 8134.048072471421, "unit": "score"}], "name": "dromaeo_css", "value": 7636.75545419479, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 110.0, 110.0, 111.0, 110.0, 109.0, 110.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 116.0, 152.0, 118.0, 118.0, 120.0, 116.0, 147.0, 119.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 165.0, 162.0, 163.0, 161.0, 161.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 103.0, 77.0, 76.0, 75.0, 75.0, 97.0, 76.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 129.0, 81.0, 82.0, 82.0, 101.0, 81.0, 81.0, 112.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.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, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 49.0, 50.0, 50.0, 49.0, 50.0, 49.0, 49.0, 49.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 62.0, 60.0, 59.0, 60.0, 60.0, 60.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 72.0, 71.0, 73.0, 74.0, 73.0, 72.0, 73.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 118.0, 124.0, 132.0, 132.0, 119.0, 120.0, 158.0, 120.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 152.0, 150.0, 157.0, 152.0, 150.0, 156.0, 152.0, 151.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 63.0, 63.0, 63.0, 67.0, 63.0, 64.0, 62.0, 64.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1454.8999999999999, "alertThreshold": 2.0}]} 17:31:09 INFO - Return code: 0 17:31:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:31:10 INFO - # TBPL SUCCESS # 17:31:10 INFO - Running post-action listener: _resource_record_post_action 17:31:10 INFO - [mozharness: 2016-10-20 00:31:10.035156Z] Finished run-tests step (success) 17:31:10 INFO - Running post-run listener: _resource_record_post_run 17:31:10 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 369737728; Read time: 4; Write time: 339340 17:31:10 INFO - TinderboxPrint: CPU usage
12.9% 17:31:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 17:31:10 INFO - TinderboxPrint: I/O write bytes / time
369,737,728 / 339,340 17:31:10 INFO - TinderboxPrint: CPU idle
8,269.6 (87.1%) 17:31:10 INFO - TinderboxPrint: CPU user
1,182.6 (12.5%) 17:31:10 INFO - TinderboxPrint: Swap in / out
0 / 0 17:31:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 119091200; Read time: 0; Write time: 88128 17:31:10 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 250646528; Read time: 0; Write time: 251212 17:31:10 INFO - Running post-run listener: _upload_blobber_files 17:31:10 INFO - Blob upload gear active. 17:31:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:31:10 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 17:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:31:11 INFO - (blobuploader) - INFO - Open directory for files ... 17:31:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:31:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:31:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:12 INFO - (blobuploader) - INFO - Done attempting. 17:31:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:31:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:31:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:12 INFO - (blobuploader) - INFO - Done attempting. 17:31:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:31:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:31:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:16 INFO - (blobuploader) - INFO - Done attempting. 17:31:16 INFO - (blobuploader) - INFO - Iteration through files over. 17:31:16 INFO - Return code: 0 17:31:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:31:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:31:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e0f6cb6b1feb09c11d3b3c2ad947ff67ebdc50b5d329931bae788294b86cebf08a1bdda0e10215756d69a613912b84ca42858534611ea785fdb5e0be3a125af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1c89d6361ef2559627582fced71d435d35dd0dd0cb45a3fa04e998f4db55eec7e303288a1d007fae040f8854204cc7a4f53a511a0e1aa41175141041a999e64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a49cc83064125d0c673843d37901f9f0f7002e08098584b2887115dab52d08c953d87818f8cc8b9f64f6ebc1225a4d8e7cfa78b4ec00bd6a148e5c2a9630b2cf"} 17:31:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:31:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:31:16 INFO - Contents: 17:31:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e0f6cb6b1feb09c11d3b3c2ad947ff67ebdc50b5d329931bae788294b86cebf08a1bdda0e10215756d69a613912b84ca42858534611ea785fdb5e0be3a125af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1c89d6361ef2559627582fced71d435d35dd0dd0cb45a3fa04e998f4db55eec7e303288a1d007fae040f8854204cc7a4f53a511a0e1aa41175141041a999e64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a49cc83064125d0c673843d37901f9f0f7002e08098584b2887115dab52d08c953d87818f8cc8b9f64f6ebc1225a4d8e7cfa78b4ec00bd6a148e5c2a9630b2cf"} 17:31:16 INFO - Running post-run listener: copy_logs_to_upload_dir 17:31:16 INFO - Copying logs to upload dir... 17:31:16 INFO - mkdir: /builds/slave/test/build/upload/logs 17:31:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.604446 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-19 17:31:16.486280) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 17:31:16.493591) ========= 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=0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e0f6cb6b1feb09c11d3b3c2ad947ff67ebdc50b5d329931bae788294b86cebf08a1bdda0e10215756d69a613912b84ca42858534611ea785fdb5e0be3a125af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1c89d6361ef2559627582fced71d435d35dd0dd0cb45a3fa04e998f4db55eec7e303288a1d007fae040f8854204cc7a4f53a511a0e1aa41175141041a999e64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a49cc83064125d0c673843d37901f9f0f7002e08098584b2887115dab52d08c953d87818f8cc8b9f64f6ebc1225a4d8e7cfa78b4ec00bd6a148e5c2a9630b2cf"} build_url:https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/J4gYWU6LSxC9neGHgFpF1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e0f6cb6b1feb09c11d3b3c2ad947ff67ebdc50b5d329931bae788294b86cebf08a1bdda0e10215756d69a613912b84ca42858534611ea785fdb5e0be3a125af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1c89d6361ef2559627582fced71d435d35dd0dd0cb45a3fa04e998f4db55eec7e303288a1d007fae040f8854204cc7a4f53a511a0e1aa41175141041a999e64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a49cc83064125d0c673843d37901f9f0f7002e08098584b2887115dab52d08c953d87818f8cc8b9f64f6ebc1225a4d8e7cfa78b4ec00bd6a148e5c2a9630b2cf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 17:31:16.522036) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 17:31:16.522377) ========= 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=0e2a256762fed810e2f0f810000001b3-1476922241.458912-363335347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 17:31:16.600957) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 17:31:16.604370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 17:31:16.604662) ========= ========= Total master_lag: 0.18 =========