builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1474970672.37 results: success (0) buildid: 20160927000401 builduid: f3fe23509a2e41a99b4f2b773affd49d revision: cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:32.367611) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:32.368064) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:32.368378) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:32.383575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:32.383925) ========= 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=41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 03:04:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-09-27 03:04:33 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.068809 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:32.577095) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:32.577474) ========= 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=41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013687 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:32.607179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:32.607657) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810 --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 cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810 --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=41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 03:04:33,470 truncating revision to first 12 chars 2016-09-27 03:04:33,470 Setting DEBUG logging. 2016-09-27 03:04:33,470 attempt 1/10 2016-09-27 03:04:33,470 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cbd3fd1a66dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 03:04:33,774 unpacking tar archive at: mozilla-aurora-cbd3fd1a66dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634116 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:33.268421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:33.268800) ========= script_repo_revision: cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:33.269247) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:33.269561) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 03:04:33.285937) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-09-27 03:04:33.286254) ========= /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=41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:04:34 INFO - MultiFileLogger online at 20160927 03:04:34 in /builds/slave/test 03:04:34 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 03:04:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:04:34 INFO - {'append_to_log': False, 03:04:34 INFO - 'base_work_dir': '/builds/slave/test', 03:04:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:04:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:04:34 INFO - 'branch': 'Mozilla-Aurora', 03:04:34 INFO - 'buildbot_json_path': 'buildprops.json', 03:04:34 INFO - 'config_files': ('talos/linux_config.py',), 03:04:34 INFO - 'default_actions': ('clobber', 03:04:34 INFO - 'read-buildbot-config', 03:04:34 INFO - 'download-and-extract', 03:04:34 INFO - 'populate-webroot', 03:04:34 INFO - 'create-virtualenv', 03:04:34 INFO - 'install', 03:04:34 INFO - 'run-tests'), 03:04:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:04:34 INFO - 'download_minidump_stackwalk': True, 03:04:34 INFO - 'download_symbols': 'ondemand', 03:04:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:04:34 INFO - 'tooltool.py': '/tools/tooltool.py', 03:04:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:04:34 INFO - '/tools/misc-python/virtualenv.py')}, 03:04:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:04:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:04:34 INFO - 'installer_path': 'installer.exe', 03:04:34 INFO - 'log_level': 'info', 03:04:34 INFO - 'log_name': 'talos', 03:04:34 INFO - 'log_to_console': True, 03:04:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:04:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:04:34 INFO - 'opt_config_files': (), 03:04:34 INFO - 'pip_index': False, 03:04:34 INFO - 'sps_profile': False, 03:04:34 INFO - 'sps_profile_interval': 0, 03:04:34 INFO - 'suite': 'dromaeojs', 03:04:34 INFO - 'system_bits': '32', 03:04:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:04:34 INFO - 'title': 'talos-linux64-ix-024', 03:04:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:04:34 INFO - 'use_talos_json': True, 03:04:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:04:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:04:34 INFO - 'work_dir': 'build'} 03:04:34 INFO - [mozharness: 2016-09-27 10:04:34.240539Z] Running clobber step. 03:04:34 INFO - Running pre-action listener: _resource_record_pre_action 03:04:34 INFO - Running main action method: clobber 03:04:34 INFO - rmtree: /builds/slave/test/build 03:04:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:04:35 INFO - Running post-action listener: _resource_record_post_action 03:04:35 INFO - [mozharness: 2016-09-27 10:04:35.251581Z] Finished clobber step (success) 03:04:35 INFO - [mozharness: 2016-09-27 10:04:35.251682Z] Running read-buildbot-config step. 03:04:35 INFO - Running pre-action listener: _resource_record_pre_action 03:04:35 INFO - Running main action method: read_buildbot_config 03:04:35 INFO - Using buildbot properties: 03:04:35 INFO - { 03:04:35 INFO - "project": "", 03:04:35 INFO - "product": "firefox", 03:04:35 INFO - "script_repo_revision": "production", 03:04:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:04:35 INFO - "repository": "", 03:04:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:04:35 INFO - "buildid": "20160927000401", 03:04:35 INFO - "pgo_build": "True", 03:04:35 INFO - "basedir": "/builds/slave/test", 03:04:35 INFO - "buildnumber": 792, 03:04:35 INFO - "slavename": "talos-linux64-ix-024", 03:04:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:04:35 INFO - "platform": "ubuntu64_hw", 03:04:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:04:35 INFO - "branch": "mozilla-aurora", 03:04:35 INFO - "repo_path": "releases/mozilla-aurora", 03:04:35 INFO - "revision": "cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810", 03:04:35 INFO - "stage_platform": "linux64-pgo", 03:04:35 INFO - "builduid": "f3fe23509a2e41a99b4f2b773affd49d", 03:04:35 INFO - "slavebuilddir": "test" 03:04:35 INFO - } 03:04:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 03:04:35 INFO - Running post-action listener: _resource_record_post_action 03:04:35 INFO - [mozharness: 2016-09-27 10:04:35.254154Z] Finished read-buildbot-config step (success) 03:04:35 INFO - [mozharness: 2016-09-27 10:04:35.254244Z] Running download-and-extract step. 03:04:35 INFO - Running pre-action listener: _resource_record_pre_action 03:04:35 INFO - Running main action method: download_and_extract 03:04:35 INFO - mkdir: /builds/slave/test/build/tests 03:04: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')]} 03:04:35 INFO - trying https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:04:35 INFO - Downloading https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/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 03:04:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/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 03:04:35 INFO - Downloaded 1361 bytes. 03:04:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:04:35 INFO - Using the following test package requirements: 03:04:35 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:04:35 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:04:35 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:04:35 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:35 INFO - u'jsshell-linux-x86_64.zip'], 03:04:35 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:04:35 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:04:35 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:04:35 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:04:35 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:04:35 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:04:35 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:04:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:04:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:04:35 INFO - Fetch https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:04:36 INFO - Expected file size: 21899987 03:04:40 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 03:04:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:04:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:04:40 INFO - Fetch https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:04:41 INFO - Expected file size: 21899987 03:04:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 03:04:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:04:46 INFO - Fetch https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:04:46 INFO - Expected file size: 14414059 03:04:47 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')]} 03:04:47 INFO - trying https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:04:47 INFO - Downloading https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/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 03:04:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/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 03:04:48 INFO - Downloaded 63977875 bytes. 03:04:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:04:48 INFO - mkdir: /builds/slave/test/properties 03:04:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:04:48 INFO - Writing to file /builds/slave/test/properties/build_url 03:04:48 INFO - Contents: 03:04:48 INFO - build_url:https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:04:48 INFO - Running post-action listener: _resource_record_post_action 03:04:48 INFO - Running post-action listener: set_extra_try_arguments 03:04:48 INFO - [mozharness: 2016-09-27 10:04:48.951961Z] Finished download-and-extract step (success) 03:04:48 INFO - [mozharness: 2016-09-27 10:04:48.952189Z] Running populate-webroot step. 03:04:48 INFO - Running pre-action listener: _resource_record_pre_action 03:04:48 INFO - Running main action method: populate_webroot 03:04:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:04:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:04:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:04:48 INFO - '--tppagecycles', 03:04:48 INFO - '7'], 03:04:48 INFO - 'tests': ['tsvgm']}}, 03:04:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:04:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:04:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:04:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:04:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['damp', 'tps']}, 03:04:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'tests': ['damp', 'tps']}, 03:04:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['dromaeo_dom']}, 03:04:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:04:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['basic_compositor_video']}, 03:04:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:04:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['a11yr', 03:04:48 INFO - 'ts_paint', 03:04:48 INFO - 'tpaint', 03:04:48 INFO - 'sessionrestore', 03:04:48 INFO - 'sessionrestore_no_auto_restore', 03:04:48 INFO - 'tabpaint']}, 03:04:48 INFO - 'other-e10s': {'tests': ['a11yr', 03:04:48 INFO - 'ts_paint', 03:04:48 INFO - 'tpaint', 03:04:48 INFO - 'sessionrestore', 03:04:48 INFO - 'sessionrestore_no_auto_restore', 03:04:48 INFO - 'tabpaint']}, 03:04:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:04:48 INFO - 'ts_paint', 03:04:48 INFO - 'tpaint', 03:04:48 INFO - 'sessionrestore', 03:04:48 INFO - 'sessionrestore_no_auto_restore', 03:04:48 INFO - 'tabpaint']}, 03:04:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:04:48 INFO - 'ts_paint', 03:04:48 INFO - 'tpaint', 03:04:48 INFO - 'sessionrestore', 03:04:48 INFO - 'sessionrestore_no_auto_restore', 03:04:48 INFO - 'tabpaint']}, 03:04:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['a11yr', 03:04:48 INFO - 'ts_paint', 03:04:48 INFO - 'tpaint', 03:04:48 INFO - 'sessionrestore', 03:04:48 INFO - 'sessionrestore_no_auto_restore', 03:04:48 INFO - 'tabpaint']}, 03:04:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['a11yr', 03:04:48 INFO - 'ts_paint', 03:04:48 INFO - 'tpaint', 03:04:48 INFO - 'sessionrestore', 03:04:48 INFO - 'sessionrestore_no_auto_restore', 03:04:48 INFO - 'tabpaint']}, 03:04:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['tsvgx', 03:04:48 INFO - 'tsvgr_opacity', 03:04:48 INFO - 'tart', 03:04:48 INFO - 'tscrollx', 03:04:48 INFO - 'cart']}, 03:04:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:04:48 INFO - 'tsvgr_opacity', 03:04:48 INFO - 'tart', 03:04:48 INFO - 'tscrollx', 03:04:48 INFO - 'cart']}, 03:04:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['tp5o']}, 03:04:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'tests': ['tp5o']}, 03:04:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'talos_options': ['--disable-e10s', 03:04:48 INFO - '--xperf_path', 03:04:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:04:48 INFO - 'tests': ['tp5n']}, 03:04:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'talos_options': ['--xperf_path', 03:04:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:04:48 INFO - 'tests': ['tp5n']}}, 03:04:48 INFO - 'talos.zip': {'path': '', 03:04:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:04:48 INFO - Running post-action listener: _resource_record_post_action 03:04:48 INFO - [mozharness: 2016-09-27 10:04:48.971664Z] Finished populate-webroot step (success) 03:04:48 INFO - [mozharness: 2016-09-27 10:04:48.971753Z] Running create-virtualenv step. 03:04:48 INFO - Running pre-action listener: _resource_record_pre_action 03:04:48 INFO - Running main action method: create_virtualenv 03:04:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:04:48 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 03:04:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:04:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:04:49 INFO - Using real prefix '/usr' 03:04:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:04:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:04:51 INFO - Installing pip.................done. 03:04:51 INFO - Return code: 0 03:04:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:04:51 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')]} 03:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:51 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')]} 03:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:51 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 0x7f973697af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efbf60>, '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 0x1efcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd1d0>, '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': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', '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 03:04:51 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 03:04:51 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 03:04:51 INFO - Using env: {'DISPLAY': ':0', 03:04:51 INFO - 'HOME': '/home/cltbld', 03:04:51 INFO - 'LANG': 'en_US.UTF-8', 03:04:51 INFO - 'LANGUAGE': 'en_US:en', 03:04:51 INFO - 'LOGNAME': 'cltbld', 03:04:51 INFO - 'MAIL': '/var/mail/cltbld', 03:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:51 INFO - 'MOZ_NO_REMOTE': '1', 03:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:51 INFO - 'NO_EM_RESTART': '1', 03:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:51 INFO - 'PWD': '/builds/slave/test', 03:04:51 INFO - 'SHELL': '/bin/bash', 03:04:51 INFO - 'SHLVL': '1', 03:04:51 INFO - 'TERM': 'linux', 03:04:51 INFO - 'TMOUT': '86400', 03:04:51 INFO - 'USER': 'cltbld', 03:04:51 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', 03:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:51 INFO - '_': '/tools/buildbot/bin/python'} 03:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:51 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 03:04:51 INFO - Cleaning up... 03:04:51 INFO - Return code: 0 03:04:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:04:51 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')]} 03:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:51 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')]} 03:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:51 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 0x7f973697af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efbf60>, '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 0x1efcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd1d0>, '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': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', '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 03:04:51 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 03:04:51 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 03:04:51 INFO - Using env: {'DISPLAY': ':0', 03:04:51 INFO - 'HOME': '/home/cltbld', 03:04:51 INFO - 'LANG': 'en_US.UTF-8', 03:04:51 INFO - 'LANGUAGE': 'en_US:en', 03:04:51 INFO - 'LOGNAME': 'cltbld', 03:04:51 INFO - 'MAIL': '/var/mail/cltbld', 03:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:51 INFO - 'MOZ_NO_REMOTE': '1', 03:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:51 INFO - 'NO_EM_RESTART': '1', 03:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:51 INFO - 'PWD': '/builds/slave/test', 03:04:51 INFO - 'SHELL': '/bin/bash', 03:04:51 INFO - 'SHLVL': '1', 03:04:51 INFO - 'TERM': 'linux', 03:04:51 INFO - 'TMOUT': '86400', 03:04:51 INFO - 'USER': 'cltbld', 03:04:51 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', 03:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:51 INFO - '_': '/tools/buildbot/bin/python'} 03:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:51 INFO - Downloading/unpacking psutil>=3.1.1 03:04:51 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 03:04:51 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 03:04:51 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 03:04:51 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 03:04:51 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 03:04:51 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 03:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:04:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:04:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:04:53 INFO - Installing collected packages: psutil 03:04:53 INFO - Running setup.py install for psutil 03:04:54 INFO - building 'psutil._psutil_linux' extension 03:04:54 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 03:04:54 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 03:04:54 INFO - building 'psutil._psutil_posix' extension 03:04:54 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 03:04:54 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 03:04:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:04:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:04:54 INFO - Successfully installed psutil 03:04:54 INFO - Cleaning up... 03:04:54 INFO - Return code: 0 03:04:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f973697af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efbf60>, '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 0x1efcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd1d0>, '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': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', '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 03:04:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:04:54 INFO - Using env: {'DISPLAY': ':0', 03:04:54 INFO - 'HOME': '/home/cltbld', 03:04:54 INFO - 'LANG': 'en_US.UTF-8', 03:04:54 INFO - 'LANGUAGE': 'en_US:en', 03:04:54 INFO - 'LOGNAME': 'cltbld', 03:04:54 INFO - 'MAIL': '/var/mail/cltbld', 03:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:54 INFO - 'MOZ_NO_REMOTE': '1', 03:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:54 INFO - 'NO_EM_RESTART': '1', 03:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:54 INFO - 'PWD': '/builds/slave/test', 03:04:54 INFO - 'SHELL': '/bin/bash', 03:04:54 INFO - 'SHLVL': '1', 03:04:54 INFO - 'TERM': 'linux', 03:04:54 INFO - 'TMOUT': '86400', 03:04:54 INFO - 'USER': 'cltbld', 03:04:54 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', 03:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:54 INFO - '_': '/tools/buildbot/bin/python'} 03:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:04:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:04:56 INFO - Installing collected packages: mozsystemmonitor 03:04:56 INFO - Running setup.py install for mozsystemmonitor 03:04:56 INFO - Successfully installed mozsystemmonitor 03:04:56 INFO - Cleaning up... 03:04:56 INFO - Return code: 0 03:04:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:04:56 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')]} 03:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:56 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')]} 03:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:56 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 0x7f973697af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efbf60>, '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 0x1efcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd1d0>, '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': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', '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 03:04:56 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 03:04:56 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 03:04:56 INFO - Using env: {'DISPLAY': ':0', 03:04:56 INFO - 'HOME': '/home/cltbld', 03:04:56 INFO - 'LANG': 'en_US.UTF-8', 03:04:56 INFO - 'LANGUAGE': 'en_US:en', 03:04:56 INFO - 'LOGNAME': 'cltbld', 03:04:56 INFO - 'MAIL': '/var/mail/cltbld', 03:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:56 INFO - 'MOZ_NO_REMOTE': '1', 03:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:56 INFO - 'NO_EM_RESTART': '1', 03:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:56 INFO - 'PWD': '/builds/slave/test', 03:04:56 INFO - 'SHELL': '/bin/bash', 03:04:56 INFO - 'SHLVL': '1', 03:04:56 INFO - 'TERM': 'linux', 03:04:56 INFO - 'TMOUT': '86400', 03:04:56 INFO - 'USER': 'cltbld', 03:04:56 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', 03:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:56 INFO - '_': '/tools/buildbot/bin/python'} 03:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:57 INFO - Downloading/unpacking jsonschema==2.5.1 03:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:04:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:59 INFO - Downloading functools32-3.2.3-2.tar.gz 03:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:04:59 INFO - warning: no files found matching '*.txt' 03:04:59 INFO - no previously-included directories found matching 'build' 03:04:59 INFO - no previously-included directories found matching 'dist' 03:04:59 INFO - no previously-included directories found matching '.git*' 03:04:59 INFO - Installing collected packages: jsonschema, functools32 03:04:59 INFO - Running setup.py install for functools32 03:04:59 INFO - warning: no files found matching '*.txt' 03:04:59 INFO - no previously-included directories found matching 'build' 03:04:59 INFO - no previously-included directories found matching 'dist' 03:04:59 INFO - no previously-included directories found matching '.git*' 03:04:59 INFO - Successfully installed jsonschema functools32 03:04:59 INFO - Cleaning up... 03:04:59 INFO - Return code: 0 03:04:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f973697af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efbf60>, '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 0x1efcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd1d0>, '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': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', '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 03:04:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:04:59 INFO - Using env: {'DISPLAY': ':0', 03:04:59 INFO - 'HOME': '/home/cltbld', 03:04:59 INFO - 'LANG': 'en_US.UTF-8', 03:04:59 INFO - 'LANGUAGE': 'en_US:en', 03:04:59 INFO - 'LOGNAME': 'cltbld', 03:04:59 INFO - 'MAIL': '/var/mail/cltbld', 03:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:59 INFO - 'MOZ_NO_REMOTE': '1', 03:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:59 INFO - 'NO_EM_RESTART': '1', 03:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:59 INFO - 'PWD': '/builds/slave/test', 03:04:59 INFO - 'SHELL': '/bin/bash', 03:04:59 INFO - 'SHLVL': '1', 03:04:59 INFO - 'TERM': 'linux', 03:04:59 INFO - 'TMOUT': '86400', 03:04:59 INFO - 'USER': 'cltbld', 03:04:59 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', 03:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:59 INFO - '_': '/tools/buildbot/bin/python'} 03:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:04:59 INFO - Cleaning up... 03:04:59 INFO - Return code: 0 03:04:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f973697af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efbf60>, '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 0x1efcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd1d0>, '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': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', '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 03:04:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:04:59 INFO - Using env: {'DISPLAY': ':0', 03:04:59 INFO - 'HOME': '/home/cltbld', 03:04:59 INFO - 'LANG': 'en_US.UTF-8', 03:04:59 INFO - 'LANGUAGE': 'en_US:en', 03:04:59 INFO - 'LOGNAME': 'cltbld', 03:04:59 INFO - 'MAIL': '/var/mail/cltbld', 03:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:59 INFO - 'MOZ_NO_REMOTE': '1', 03:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:59 INFO - 'NO_EM_RESTART': '1', 03:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:59 INFO - 'PWD': '/builds/slave/test', 03:04:59 INFO - 'SHELL': '/bin/bash', 03:04:59 INFO - 'SHLVL': '1', 03:04:59 INFO - 'TERM': 'linux', 03:04:59 INFO - 'TMOUT': '86400', 03:04:59 INFO - 'USER': 'cltbld', 03:04:59 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', 03:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:59 INFO - '_': '/tools/buildbot/bin/python'} 03:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:05:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:05:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:02 INFO - Downloading docopt-0.6.1.tar.gz 03:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:05:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:05:02 INFO - Running setup.py install for blobuploader 03:05:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:05:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:05:02 INFO - Running setup.py install for requests 03:05:02 INFO - Running setup.py install for docopt 03:05:03 INFO - Successfully installed blobuploader requests docopt 03:05:03 INFO - Cleaning up... 03:05:03 INFO - Return code: 0 03:05:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05: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')]} 03:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05: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')]} 03:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:03 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 0x7f973697af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efbf60>, '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 0x1efcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd1d0>, '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': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', '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 03:05:03 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 03:05:03 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 03:05:03 INFO - Using env: {'DISPLAY': ':0', 03:05:03 INFO - 'HOME': '/home/cltbld', 03:05:03 INFO - 'LANG': 'en_US.UTF-8', 03:05:03 INFO - 'LANGUAGE': 'en_US:en', 03:05:03 INFO - 'LOGNAME': 'cltbld', 03:05:03 INFO - 'MAIL': '/var/mail/cltbld', 03:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:03 INFO - 'MOZ_NO_REMOTE': '1', 03:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:03 INFO - 'NO_EM_RESTART': '1', 03:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:03 INFO - 'PWD': '/builds/slave/test', 03:05:03 INFO - 'SHELL': '/bin/bash', 03:05:03 INFO - 'SHLVL': '1', 03:05:03 INFO - 'TERM': 'linux', 03:05:03 INFO - 'TMOUT': '86400', 03:05:03 INFO - 'USER': 'cltbld', 03:05:03 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', 03:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:03 INFO - '_': '/tools/buildbot/bin/python'} 03:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:05:03 INFO - Running setup.py (path:/tmp/pip-s6ZTsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:05:03 INFO - Running setup.py (path:/tmp/pip-gmku8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:05:03 INFO - Running setup.py (path:/tmp/pip-cVI5E2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:05:03 INFO - Running setup.py (path:/tmp/pip-6BJv73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:05:03 INFO - Running setup.py (path:/tmp/pip-dpfG0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:05:03 INFO - Running setup.py (path:/tmp/pip-h0I8R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:05:03 INFO - Running setup.py (path:/tmp/pip-HoqGO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:05:03 INFO - Running setup.py (path:/tmp/pip-opvaw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:05:03 INFO - Running setup.py (path:/tmp/pip-4CHDyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:05:03 INFO - Running setup.py (path:/tmp/pip-EZ96Q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:05:04 INFO - Running setup.py (path:/tmp/pip-uvHudX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:05:04 INFO - Running setup.py (path:/tmp/pip-qXIoGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:05:04 INFO - Running setup.py (path:/tmp/pip-sMnI_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:05:04 INFO - Running setup.py (path:/tmp/pip-NcKEXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:04 INFO - Running setup.py (path:/tmp/pip-XP53Xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:05:04 INFO - Running setup.py (path:/tmp/pip-_I5Sn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:05:04 INFO - Running setup.py (path:/tmp/pip-d_oEcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:05:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:05:04 INFO - Running setup.py install for manifestparser 03:05:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:05:04 INFO - Running setup.py install for mozcrash 03:05:04 INFO - Running setup.py install for mozdebug 03:05:04 INFO - Running setup.py install for mozdevice 03:05:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:05:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:05:04 INFO - Running setup.py install for mozfile 03:05:05 INFO - Running setup.py install for mozhttpd 03:05:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:05:05 INFO - Running setup.py install for mozinfo 03:05:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:05:05 INFO - Running setup.py install for mozInstall 03:05:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:05:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:05:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:05:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:05:05 INFO - Running setup.py install for mozleak 03:05:05 INFO - Running setup.py install for mozlog 03:05:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:05:05 INFO - Running setup.py install for moznetwork 03:05:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:05:05 INFO - Running setup.py install for mozprocess 03:05:05 INFO - Running setup.py install for mozprofile 03:05:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:05:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:05:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:05:05 INFO - Running setup.py install for mozrunner 03:05:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:05:06 INFO - Running setup.py install for mozscreenshot 03:05:06 INFO - Running setup.py install for moztest 03:05:06 INFO - Running setup.py install for mozversion 03:05:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:05:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:05:06 INFO - Cleaning up... 03:05:06 INFO - Return code: 0 03:05:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:06 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 0x7f973697af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efbf60>, '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 0x1efcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd1d0>, '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': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', '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 03:05:06 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 03:05:06 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 03:05:06 INFO - Using env: {'DISPLAY': ':0', 03:05:06 INFO - 'HOME': '/home/cltbld', 03:05:06 INFO - 'LANG': 'en_US.UTF-8', 03:05:06 INFO - 'LANGUAGE': 'en_US:en', 03:05:06 INFO - 'LOGNAME': 'cltbld', 03:05:06 INFO - 'MAIL': '/var/mail/cltbld', 03:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:06 INFO - 'MOZ_NO_REMOTE': '1', 03:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:06 INFO - 'NO_EM_RESTART': '1', 03:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:06 INFO - 'PWD': '/builds/slave/test', 03:05:06 INFO - 'SHELL': '/bin/bash', 03:05:06 INFO - 'SHLVL': '1', 03:05:06 INFO - 'TERM': 'linux', 03:05:06 INFO - 'TMOUT': '86400', 03:05:06 INFO - 'USER': 'cltbld', 03:05:06 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', 03:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:06 INFO - '_': '/tools/buildbot/bin/python'} 03:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:05:06 INFO - Running setup.py (path:/tmp/pip-Olkyjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:05:06 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)) 03:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:05:06 INFO - Running setup.py (path:/tmp/pip-jvJ42d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:05:06 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)) 03:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:05:06 INFO - Running setup.py (path:/tmp/pip-Udyfr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:05:06 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)) 03:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:05:06 INFO - Running setup.py (path:/tmp/pip-rkU3cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:05:06 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)) 03:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:05:06 INFO - Running setup.py (path:/tmp/pip-li3wMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:05:06 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)) 03:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:05:06 INFO - Running setup.py (path:/tmp/pip-ko5NNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:05:06 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)) 03:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:05:06 INFO - Running setup.py (path:/tmp/pip-fJRrzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:05:07 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)) 03:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:05:07 INFO - Running setup.py (path:/tmp/pip-lSw5HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:05:07 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)) 03:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:05:07 INFO - Running setup.py (path:/tmp/pip-qSNWoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:05:07 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)) 03:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:05:07 INFO - Running setup.py (path:/tmp/pip-uox4vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:05:07 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)) 03:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:05:07 INFO - Running setup.py (path:/tmp/pip-K9fzpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:05:07 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)) 03:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:05:07 INFO - Running setup.py (path:/tmp/pip-3WJoZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:05:07 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)) 03:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:05:07 INFO - Running setup.py (path:/tmp/pip-kunXr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:05:07 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)) 03:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:05:07 INFO - Running setup.py (path:/tmp/pip-TMB3Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:05:07 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)) 03:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:07 INFO - Running setup.py (path:/tmp/pip-5N5BcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:07 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)) 03:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:05:07 INFO - Running setup.py (path:/tmp/pip-D9ZvuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:05:07 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)) 03:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:05:07 INFO - Running setup.py (path:/tmp/pip-Kty2ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:05:07 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)) 03:05:07 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)) 03:05:07 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)) 03:05:07 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)) 03:05:07 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)) 03:05:07 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)) 03:05:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:05: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 03:05: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 03:05: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 03:05: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 03:05: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 03:05: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 03:05:09 INFO - Downloading blessings-1.6.tar.gz 03:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:05:09 INFO - Installing collected packages: blessings 03:05:09 INFO - Running setup.py install for blessings 03:05:09 INFO - Successfully installed blessings 03:05:09 INFO - Cleaning up... 03:05:09 INFO - Return code: 0 03:05:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:05:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:05:10 INFO - Reading from file tmpfile_stdout 03:05:10 INFO - Current package versions: 03:05:10 INFO - argparse == 1.2.1 03:05:10 INFO - blessings == 1.6 03:05:10 INFO - blobuploader == 1.2.4 03:05:10 INFO - docopt == 0.6.1 03:05:10 INFO - functools32 == 3.2.3-2 03:05:10 INFO - jsonschema == 2.5.1 03:05:10 INFO - manifestparser == 1.1 03:05:10 INFO - mozInstall == 1.12 03:05:10 INFO - mozcrash == 0.17 03:05:10 INFO - mozdebug == 0.1 03:05:10 INFO - mozdevice == 0.48 03:05:10 INFO - mozfile == 1.2 03:05:10 INFO - mozhttpd == 0.7 03:05:10 INFO - mozinfo == 0.9 03:05:10 INFO - mozleak == 0.1 03:05:10 INFO - mozlog == 3.4 03:05:10 INFO - moznetwork == 0.27 03:05:10 INFO - mozprocess == 0.23 03:05:10 INFO - mozprofile == 0.28 03:05:10 INFO - mozrunner == 6.12 03:05:10 INFO - mozscreenshot == 0.1 03:05:10 INFO - mozsystemmonitor == 0.3 03:05:10 INFO - moztest == 0.7 03:05:10 INFO - mozversion == 1.4 03:05:10 INFO - psutil == 3.1.1 03:05:10 INFO - requests == 1.2.3 03:05:10 INFO - wsgiref == 0.1.2 03:05:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:10 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 0x7f973697af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efbf60>, '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 0x1efcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd1d0>, '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': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', '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 03:05:10 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 03:05:10 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 03:05:10 INFO - Using env: {'DISPLAY': ':0', 03:05:10 INFO - 'HOME': '/home/cltbld', 03:05:10 INFO - 'LANG': 'en_US.UTF-8', 03:05:10 INFO - 'LANGUAGE': 'en_US:en', 03:05:10 INFO - 'LOGNAME': 'cltbld', 03:05:10 INFO - 'MAIL': '/var/mail/cltbld', 03:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:10 INFO - 'MOZ_NO_REMOTE': '1', 03:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:10 INFO - 'NO_EM_RESTART': '1', 03:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:10 INFO - 'PWD': '/builds/slave/test', 03:05:10 INFO - 'SHELL': '/bin/bash', 03:05:10 INFO - 'SHLVL': '1', 03:05:10 INFO - 'TERM': 'linux', 03:05:10 INFO - 'TMOUT': '86400', 03:05:10 INFO - 'USER': 'cltbld', 03:05:10 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', 03:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:10 INFO - '_': '/tools/buildbot/bin/python'} 03:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:10 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)) 03:05:10 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)) 03:05:10 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)) 03:05:10 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)) 03:05:10 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)) 03:05:10 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)) 03:05:10 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)) 03:05:10 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)) 03:05:10 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)) 03:05:10 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)) 03:05:10 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)) 03:05:10 INFO - Cleaning up... 03:05:10 INFO - Return code: 0 03:05:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f973697af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efbf60>, '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 0x1efcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd1d0>, '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': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', '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 03:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:05:10 INFO - Using env: {'DISPLAY': ':0', 03:05:10 INFO - 'HOME': '/home/cltbld', 03:05:10 INFO - 'LANG': 'en_US.UTF-8', 03:05:10 INFO - 'LANGUAGE': 'en_US:en', 03:05:10 INFO - 'LOGNAME': 'cltbld', 03:05:10 INFO - 'MAIL': '/var/mail/cltbld', 03:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:10 INFO - 'MOZ_NO_REMOTE': '1', 03:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:10 INFO - 'NO_EM_RESTART': '1', 03:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:10 INFO - 'PWD': '/builds/slave/test', 03:05:10 INFO - 'SHELL': '/bin/bash', 03:05:10 INFO - 'SHLVL': '1', 03:05:10 INFO - 'TERM': 'linux', 03:05:10 INFO - 'TMOUT': '86400', 03:05:10 INFO - 'USER': 'cltbld', 03:05:10 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', 03:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:10 INFO - '_': '/tools/buildbot/bin/python'} 03:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:05:10 INFO - Cleaning up... 03:05:10 INFO - Return code: 0 03:05:10 INFO - Running post-action listener: _resource_record_post_action 03:05:10 INFO - Running post-action listener: _start_resource_monitoring 03:05:10 INFO - Starting resource monitoring. 03:05:10 INFO - [mozharness: 2016-09-27 10:05:10.647280Z] Finished create-virtualenv step (success) 03:05:10 INFO - [mozharness: 2016-09-27 10:05:10.647731Z] Running install step. 03:05:10 INFO - Running pre-action listener: _resource_record_pre_action 03:05:10 INFO - Running main action method: install 03:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:05:10 INFO - Reading from file tmpfile_stdout 03:05:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:05:10 INFO - Reading from file tmpfile_stdout 03:05:10 INFO - Output received: 03:05:10 INFO - Usage: mozinstall [options] installer 03:05:10 INFO - Options: 03:05:10 INFO - -h, --help show this help message and exit 03:05:10 INFO - -d DEST, --destination=DEST 03:05:10 INFO - Directory to install application into. [default: 03:05:10 INFO - "/builds/slave/test"] 03:05:10 INFO - --app=APP Application being installed. [default: firefox] 03:05:10 INFO - mkdir: /builds/slave/test/build/application 03:05:10 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'] 03:05:10 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 03:05:26 INFO - Reading from file tmpfile_stdout 03:05:26 INFO - Output received: 03:05:26 INFO - /builds/slave/test/build/application/firefox/firefox 03:05:26 INFO - Running post-action listener: _resource_record_post_action 03:05:26 INFO - [mozharness: 2016-09-27 10:05:26.909055Z] Finished install step (success) 03:05:26 INFO - [mozharness: 2016-09-27 10:05:26.909302Z] Running run-tests step. 03:05:26 INFO - Running pre-action listener: _resource_record_pre_action 03:05:26 INFO - Running main action method: run_tests 03:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:05:26 INFO - Python 2.7.3 03:05:26 INFO - Return code: 0 03:05:26 INFO - grabbing minidump binary from tooltool 03:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:26 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 0x1efbf60>, '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 0x1efcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:05:26 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 03:05:26 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 03:05:26 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 03:05:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:05:27 INFO - Return code: 0 03:05:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:05:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:05:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:05:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:05:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:05:27 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/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 03:05:27 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/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 03:05:27 INFO - Using env: {'DISPLAY': ':0', 03:05:27 INFO - 'HOME': '/home/cltbld', 03:05:27 INFO - 'LANG': 'en_US.UTF-8', 03:05:27 INFO - 'LANGUAGE': 'en_US:en', 03:05:27 INFO - 'LOGNAME': 'cltbld', 03:05:27 INFO - 'MAIL': '/var/mail/cltbld', 03:05:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:05:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:27 INFO - 'MOZ_NO_REMOTE': '1', 03:05:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:27 INFO - 'NO_EM_RESTART': '1', 03:05:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:27 INFO - 'PWD': '/builds/slave/test', 03:05:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:05:27 INFO - 'SHELL': '/bin/bash', 03:05:27 INFO - 'SHLVL': '1', 03:05:27 INFO - 'TERM': 'linux', 03:05:27 INFO - 'TMOUT': '86400', 03:05:27 INFO - 'USER': 'cltbld', 03:05:27 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434', 03:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:27 INFO - '_': '/tools/buildbot/bin/python'} 03:05:27 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/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 03:05:27 INFO - mozversion application_buildid: 20160927000401 03:05:27 INFO - mozversion application_changeset: cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810 03:05:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:05:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:05:27 INFO - mozversion application_name: Firefox 03:05:27 INFO - mozversion application_remotingname: firefox-dev 03:05:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:05:27 INFO - mozversion application_vendor: Mozilla 03:05:27 INFO - mozversion application_version: 51.0a2 03:05:27 INFO - mozversion platform_buildid: 20160927000401 03:05:27 INFO - mozversion platform_changeset: cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810 03:05:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:05:27 INFO - mozversion platform_version: 51.0a2 03:05:27 INFO - using testdate: 1474970727 03:05:27 INFO - actual date: 1474970727 03:05:27 INFO - starting webserver on 'localhost:54548' 03:05:27 INFO - SUITE-START | Running 2 tests 03:05:27 INFO - TEST-START | dromaeo_css 03:05:27 INFO - operating with platform_type : linux_ 03:05:27 INFO - Initialising browser for dromaeo_css test... 03:05:27 INFO - TEST-INFO | started process 10679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg27r0l/profile http://localhost:54548/getInfo.html) 03:05:31 INFO - PROCESS | 10679 | __metrics Screen width/height:1600/1200 03:05:31 INFO - PROCESS | 10679 | colorDepth:24 03:05:31 INFO - PROCESS | 10679 | Browser inner width/height: 1024/697 03:05:31 INFO - PROCESS | 10679 | __metrics 03:05:31 INFO - PROCESS | 10679 | 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" 03:05:31 INFO - PROCESS | 10679 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:05:32 INFO - PROCESS | 10679 | console.error: PushService: 03:05:32 INFO - PROCESS | 10679 | stateChangeProcessEnqueue: Error transitioning state 03:05:32 INFO - PROCESS | 10679 | UnknownError 03:05:33 INFO - TEST-INFO | 10679: exit 0 03:05:33 INFO - Browser initialized. 03:05:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:05:33 INFO - TEST-INFO | started process 10771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg27r0l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:44 INFO - PROCESS | 10771 | RSS: Main: 144420864 03:05:44 INFO - PROCESS | 10771 | 03:06:35 INFO - PROCESS | 10771 | 1474970795950 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] 03:08:45 INFO - PROCESS | 10771 | Cycle 1(1): loaded http://localhost:54548/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54548/tests/dromaeo/cssquery-ext.html) 03:08:46 INFO - PROCESS | 10771 | RSS: Main: 246841344 03:08:46 INFO - PROCESS | 10771 | 03:11:48 INFO - PROCESS | 10771 | Cycle 1(1): loaded http://localhost:54548/tests/dromaeo/cssquery-ext.html (next: http://localhost:54548/tests/dromaeo/cssquery-jquery.html) 03:11:49 INFO - PROCESS | 10771 | RSS: Main: 226983936 03:11:49 INFO - PROCESS | 10771 | 03:14:51 INFO - PROCESS | 10771 | Cycle 1(1): loaded http://localhost:54548/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54548/tests/dromaeo/cssquery-mootools.html) 03:14:51 INFO - PROCESS | 10771 | RSS: Main: 176447488 03:14:51 INFO - PROCESS | 10771 | 03:17:53 INFO - PROCESS | 10771 | Cycle 1(1): loaded http://localhost:54548/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54548/tests/dromaeo/cssquery-prototype.html) 03:17:54 INFO - PROCESS | 10771 | RSS: Main: 172752896 03:17:54 INFO - PROCESS | 10771 | 03:20:57 INFO - PROCESS | 10771 | Cycle 1(1): loaded http://localhost:54548/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54548/tests/dromaeo/cssquery-yui.html) 03:20:57 INFO - PROCESS | 10771 | RSS: Main: 176218112 03:20:57 INFO - PROCESS | 10771 | 03:24:00 INFO - PROCESS | 10771 | Cycle 1(1): loaded http://localhost:54548/tests/dromaeo/cssquery-yui.html (next: http://localhost:54548/tests/dromaeo/cssquery-dojo.html) 03:24:00 INFO - PROCESS | 10771 | RSS: Main: 262856704 03:24:00 INFO - PROCESS | 10771 | 03:24:00 INFO - PROCESS | 10771 | __start_tp_report 03:24:00 INFO - PROCESS | 10771 | _x_x_mozilla_page_load 03:24:00 INFO - PROCESS | 10771 | _x_x_mozilla_page_load_details 03:24:00 INFO - PROCESS | 10771 | |i|pagename|runs| 03:24:00 INFO - PROCESS | 10771 | |0;dojo.html;3085.6297244330676;3115.8442077896098;3143.2141964508887;3160.88936887209;3177.4916013437855;5581.246531718222;5654.406287339832;5668.064769313063;5679.460451257134;5687.6303040302355;5564.081926482136;5621.690807005613;5632.26780518532;5651.660900345972;5674.148877668352;5057.317262169597;5087.389513258396;5110.795568177268;5156.664816786897;5182.533571978521;5002.049610573998;5119.744012799364;5163.173892177252;5171.431142574333;5172.250023746555;5005.274235235888;5017.8243761468175;5050.419201791786;5072.543471087602;5118.309028281172;5106.08090543702;5130.435652078287;5214.687118772886;5218.165093585008;5235.6073294502685;4854.951450485485;5089.338386009795;5113.7443127843835;5154.149565321717;5178.378594568639;5440.347158340985;5446.400895901447;5472.26124473195;5486.451354864482;5575.498205161514;5883.6469811811;5885.676287804169;5976.521878249773;5981.820545383645;5982.641041537521;5865.032269675498;6014.96992515039;6015;6026.126211699323;6032.607880487754;5525.060739674265;5535.391106978229;5574.498295153415;5593.74828132735;5608.467195616491;6134.4172303631085;6142.477889379453;6143.170671959318;6144.78493252734;6150.446459818549;5710.229119068956;5911.793087241926;5913.586048976616;5913.733881975321;5917.6745279010065;5852.297724273115;5899.380565040695;5953.3451320354725;5968.283805943314;6045.3652366501765;5975.4024597540765;5980.162777211194;5981.132735753292;5982.581219314607;6010.759569617167;5941.346451890288;5950.047992321294;5997.910031349533;6001.399860013964;6016.157737916695;4513.81944722214;4536.79584418702;4564.406627138451;4569.954300456953;4626.884327891829;4100.425940368351;4108.383742438598;4124.670026397881;4129.339305711072;4147.730397524151;5740.942590574041;5754.367019627837;5757;5757.8560535986935;5763;5547.944520554743;5854.619449735754;5929.792457263975;5931.673757943268;6049.213602231682;5713.22871412354;5719.885602287931;5747.281589801275;5755.165501002331;5782;5111.642185047085;5118.001989612065;5122.1804511278015;5125.384953805493;5165.992631436834;5959.4934430573885;6057.666828324484;6088.786892458654;6225.252969643671;6236.688165591702;5982.46157845796;6028.0355143176885;6054.90917636227;6073.665948372882;6086.847828804315;6098.664573448503;6141.877162456636;6164.198654174928;6164.938350616437;6193.071039344134;5735.11105778605;5749.91375129365;5876.559258055578;5928.762849485972;5951.940480595139;5970.9701451492465;6035.185249991195;6055.424734650202;6092;6120.938790612036;5932.614380065282;5933.406659334032;5947.524198064058;5949.137375080502;5963;5637.88724225505;5916.290045194604;5933.05071188625;5954.225950626391;5954.791582294599;5703.686297253691;5778.133280008033;5823.213866128019;5845.240118784531;5919.082542205965;5906.734196961061;5925.081612350093;5935.584509084495;5940.138679891478;5941.851453713692;5606.691631960118;5674.886502269849;5794.1308803679785;5796.985527532581;5805.593608447368 03:24:00 INFO - PROCESS | 10771 | |1;ext.html;587.0988033368777;623.7442648514109;653.199830207995;654.5614438326322;662.3674390956637;36800.63199368006;40135.79932100339;41020.58979410205;41022.58977410232;43934.56065439345;47658.285125723145;48050;48149.75925120378;48169;48242;8408.201220884006;9174.908250917471;9305.97634260231;9315.208207302387;9342.159205671489;8404.28563572094;8666.393352465298;8667.95984481863;10978.725531861688;11234.157438192127;11381.032612227971;11415;11418.71453213668;11423.714407139805;11453.713657158596;11161.497732602013;11220.102391808636;11220.270682405617;11246.268992515501;11250.324980501115;8295.751127466187;8520.19058189471;8522.190391912758;8697.173768491983;10437.851836298001;42773;46340.76829615864;46397.53602463966;46437.30344044842;46466.303005454945;3789.280036793028;3808.7143464240294;4007.6192761687885;4126.360414135814;4294.291441912081;33878.66121338804;35076.82461587676;35366.11584710377;35522.46716299257;36530.8173459131;4664.183767840648;4705.929411058837;4728.621710263171;4732.810687572493;4813.3983252093485;367991.1600442007;369727.1513642442;369742;370407;371125;64492;64501.677491612245;64583;64674;64722;68458.65770671115;68488.31511684919;68518.65740671265;68550.65724671345;68593;18273.543161421072;19027.904860475886;19115.522111947314;19116.426507204807;19133.8086619132;13776.10455320401;14769.852301476847;14857.70284594302;14892.404303827941;14962.92518537422;16963.74554381685;18877.90561047186;19109.904450477938;19250.518737031685;19349.322773702854;6476.805695829133;6549.967250163814;6725.831854203586;6743.1908171019795;6820.3861652451515;1061.4533515239657;1064.595453727594;1109.8834622364698;1140.520981187903;1142.6971852459105;33669.32661346808;34505.654943450245;34829.825850870584;34833.30333393368;34920.476192857124;1109.8834622364536;1122.2537012886503;1175.189119507537;1187.5724739093919;1202.675277675023;17641.294348226184;17738.65336658354;17930.80091442016;18016.631351697044;18241.087945602667;642508;657652;659014;1045790;1051476;64884.67557662181;64896.67551662211;65855.34144658588;65863.67068164628;65886.67056664686;1355.1394864261265;1386.0851837787013;1413.8939579531577;1454.549089782171;1463.217178809332;32240.35519289648;36119.638803611626;36337.63662363343;36398.8180059098;36431.817840910626;54374;54933.450665492834;54949;54971.175432367745;55076.72461637666;410543;412681.74636507704;412916;413026;414466;30973.225669358446;31692.841535793097;31735.682643173273;31770.04689859308;33036.33927321488;51836.22245666243;52268;52361;52897.4710252908;52982;44857;45048;45841.312380313655;45862.31206531838;46862.531374685816;43904.78047609742;44998.325025125305;45503.54496454993;45930.770346149395;46414.30378544257;43759.562404375545;44350;44772.55227447684;44777.10445791131;45002.77498612486;37794;39822.800885995384;39954.80022599868;40366.59633403629;40442;29775.70224297729;29833.11606245418;29841.25396865096;30332.24169395783;30360.544591830698 03:24:00 INFO - PROCESS | 10771 | |2;jquery.html;389.98830035098956;427.62762762762765;428.824182085345;435.32741913743274;438.3665603203368;16767.916160419198;19976.400707978748;21774.12903483863;21963.341099766993;22050.11799528019;13039.80440293394;16650.834441589093;18480.630387392277;19004.2398304068;19187.32844350448;5484.698341591211;5662.348829884554;5662.631928924607;5670.121131224667;5670.943290567104;4014.5784692607294;4341.739495630257;4379.540148284432;5596.468335508121;6873.759418420356;6949.096617439725;6978.825529361781;6983.4762392820485;6983.615901125436;6989.091418115638;6238;6263.655498947556;6274.309825919146;6277.435030847223;6392.520560957923;5897.941020589782;6073.271207455089;6079.635221886657;6080.817575472743;6083.48290395317;15019.098854068681;15116.470923517623;15141.545753627408;15278.847211527853;15284;2460.5817011108156;2477.529269438819;2531.772140507363;2570.318865500644;3056.7860249782525;10329.225308101923;11373.260738052082;11516.251443656136;11561.76876462466;11588.88411115895;2015.6875684268962;2019.2831544801677;2040.6428874946826;2070.3478404302746;2096.899127957819;78595;87304.56347718285;88872.5556372214;89119.55440222757;90080;10579.418132002813;10853.186011049045;11129.499172537255;11477.426128693533;12072.275663460221;15871;15994.840051599567;16889.15554222284;16904.66190676204;17476.825231747775;8901.554922253861;8942.687005954891;9072.54637268134;9145.77135571616;9163.58763855628;8633.223009929137;8658.350623703122;8663.133686631412;8842.115788421106;8888.24449921751;5035.144025515671;5071.695698258116;5101.285819985205;5146.330976972969;5324.148136298174;2063.585019901335;2064.9690254646193;2071.819063133999;2137.6259154647873;2154.601398741238;937.3110763588757;1002.6941782756184;1015.0864222200079;1037.3983089807894;1061.389700921973;20396.89801550983;20507.897460512602;20649.17403303851;21031.8948405257;21088.472788180112;1016.654337525245;1031.489412740683;1044.4829809244472;1047.8742550893942;1075.3171735947574;10894;11638.556017837946;11765.470553824927;11856.466459009365;11869.109816763777;529577;533452;534897;537071;544613;94320;97731.51134244283;97984.51007744916;98706;100763;1008.505832142245;1058.2645061682058;1058.8517607534952;1072.5924148823397;1085.365061439067;18175.727364089285;18236.270549177883;18636.34772783;18849.324381745428;19300;43868.78065609779;43927.34108988304;44394;44998.77500612476;45583.54416455793;60851.695741521005;61934.38065619466;62764;63068.68465657642;63830;8392.832143356976;8565.443246188977;8759.474431534129;8762.518061506424;8774.298056155365;9364.391314564531;12450.564230251897;12460.563880264148;12490.000799935802;13590.116642418212;11064.22550421495;11203.103751699682;11208;11362.602308919479;11386.259893106922;10917.072048875934;10948.945255273673;11199.384033877888;11312.490937907978;11336;10601.204909631655;11470.139739519402;11638.12714046433;11689;12021.218620789621;8534.103919088406;8739.344549158712;8801.207891289814;8900.154485323885;9052.185303322733;8592.742217733477;10198.847017294598;10945.781084378426;11267.154963377943;11590.94204528972 03:24:00 INFO - PROCESS | 10771 | |3;mootools.html;1405.7399381114487;1502.1888180382591;1525.153539785419;1676.3881183368073;1841.3463220556703;7601.657925393357;8566.657333706653;8774.385792994493;8781.077986811388;9050.637974481013;8755.737327880173;8897.555122243893;8899.733008009754;8903.065178156297;8917.242034427081;2461.876906154694;2485.6147297168877;2487.502499500098;2487.751224877507;2490.850548967068;2429.344077099182;2485.8508489490687;2487.216526794063;2489.253224032792;2491.5888878335145;2448.7428819973825;2456.0421435640114;2479.727230004698;2493.0401795308844;2499.8875050622764;2360.8229382796358;2376.061455724988;2383.9642405363934;2436.780689737914;2443.596806526921;2385.8091352691745;2409.7710717481987;2421.588329983907;2423.430493833948;2432.282476669369;8250.793730156794;8494.617742201615;8727.563621818883;8884.555772211364;8886.644534218623;5302.151655735064;5459.181122831607;5465.262189604392;5470.042742520043;5475.7262136893;3505.8597656093725;3521.559805024372;3541.5041894134843;3549.2546565221332;3567.165297305407;1273.541525050981;1275.8724127587168;1278.8337516122845;1300.2588524541015;1319.4524272426931;12063.155579109378;12095.818562721566;12106.152569320151;12131.454084566127;12182.695432614168;4430.291153415438;4684.718916864999;4717.2216584263215;4816;4823.083614113307;9631.759206019906;9641.662541811003;9643.180329672057;9652;9671.806563868824;5275.393329767049;5275.683458992396;5283.735813209324;5292.285541451932;5292.8147514837565;4438.7114837535455;4567.451905771329;4789.616830653539;4863.221884498464;4959.107360675113;3977.8607748729232;4036.1725846201457;4124.4019617155345;4135.58644135584;4155.792210389468;1280.8783165599252;1282.3011458755002;1283.36473445645;1298.9415476303589;1318.4264844792547;840.0423517190408;888.9777755556163;899.5187574647663;929.953502324881;947.36999895069;6018.067199584071;6022.698865056817;6044.727987240584;6118.694065296718;6194.5973511721595;990.65327135502;1013.1489548779061;1024.6721049264313;1041.5261056219401;1043.2384359417667;4070.287699652549;4182.958170418317;4214.852480163241;4323.437953066082;4343.630791382705;10852.348859068481;10970.177236707279;11106.833397499044;11107.38909359993;11121.388323642277;10995.890041099487;11000.944995275133;11006.834897476385;11025.6141035065;11026.173037022256;7611.124720657084;7917.208279172152;7919.960400197962;8248.381371397048;8378.41351105429;6113.358097399887;6140.1710769047395;6179.69101544912;6200.782972595937;6383.39357761012;9982.201423885926;9989.450580218157;10114.443705596263;10140.492975351055;10147.79704405893;10320;10465.215108867018;10496.422696751752;10501.9474902625;10506.317089389166;7234.74678386254;7393.704251829867;7467.066616672916;7705.075390953121;7847.921520784719;7986.920130798618;8297.377696672653;8299.585020749058;8302.626381812954;8308.210719981593;7383;7530.736424225126;7592.468527203264;7626.54240745557;7742.729004484816;7180.497365184387;7323.8535229296185;7324.194338622854;7503.7748867534065;7573.2048134947245;6794.776940150623;6802.557833740791;6836.179658441019;6836.623985680835;6849.04113424131;5014.7994080236385;5155.5360017597095;5176.896462070813;5192.480751924777;5239.87784947097;5153.098207813543;5221.895562088661;5225.346831646044;5290.391604965324;5401 03:24:00 INFO - PROCESS | 10771 | |4;prototype.html;338.12088569718736;339.6382852262341;346.7780620402942;347.47184279894543;348.032469734139;5527.170924361343;5560.332760068787;5575.69333686647;5590.329160500745;5616.35411927628;5482.780688772455;5491.533219676322;5519.475649813261;5521.282233309674;5522.972385138079;3911.706622003347;4143.52904718825;4215.220184265905;4216.948011111839;4238.788060596973;4299.591538803808;4306.720063195882;4312.568743125678;4313.913721725564;4316.784160791964;4291.399204111427;4293.22721910056;4293.248681480744;4294.806733696991;4297.806598703066;4041.605646052107;4153.816162393703;4328.329108988096;4337.566243375684;4351.173277077345;3792.7534710243744;3797.2785170817733;3805.6194380561724;3831.808409579538;3848.5381754189675;5393.433689462589;5397.54120899724;5398.24424580559;5441.863953401196;5463.972680136613;4797;4928.359313289249;4961.8511444656715;4963.6277279204205;5011.348524691767;5734.082546792535;5742;5747.741351639186;5748.741306641211;5793.507551858097;4245.346658338538;4258.318669012943;4274.850380236708;4279.186954478639;4285.485741711014;5831.9416805831825;5931.703414829284;5938.8218353449465;6078.331383547807;6080.908786368163;4196.286631272691;4205.558416366299;4221.860097773584;4227.154569086134;4232.746035237896;4268;4272.957270427318;4276.700630955803;4298.495526565677;4314.640888120232;4756.904861902743;4935.555799978019;4936.876578085505;4937.382827146606;4986.8753281168265;5728.283964504437;5736.282964629421;5759.164921086419;5803.506701930299;5818.4472475115645;1478.113132120719;1508.6530098077503;1510.1392206442222;1510.6676531163127;1513.7426637471656;934.8364036293622;987.0918754745651;987.3434166279487;988.980220395588;1003.6888564545014;4994.500549944976;5002.774875130628;5005.724685142352;5006.524380183877;5078.568321692624;5179.818706345335;5209.973950130301;5234.97382513085;5253.264542963988;5272.261883336336;4990.8770526631215;5025.447200807908;5040.420351659606;5225.346831646044;5729.942700572941;3142.308692087737;3182.840857957093;3183.7293830024246;3190.760692948038;3203.7917535360593;6037.615142018965;6196.628202307876;6200.658963756947;6225.252969643671;6237.064440333987;5841.4450627190345;6048.5765996380715;6050.27567143362;6081.787137450168;6086.786962456293;5971.954303305346;6033.698315084316;6078;6090.908636370369;6128.908066379008;5948.821535353946;5959.4934430573885;5980.312264089685;5997.100434934795;6017.849553761191;5728.627639203439;5919.644821310735;5924.200232968667;5950.19672344228;5954.225950626565;6183.89747485857;6188.319284878569;6205;6211.596246243979;6227.937720622917;4156.750594964312;4321.351797230441;4401.987542865095;4405.656274836206;4447.6219521341045;5892.410758924073;5963.493103086286;5969.462748352669;5972.626295951868;6012.969935150296;5832.795852145155;5864.208331875313;5877.089051197071;5914.792982245601;5945.464908158287;5663.546916246608;5726.854629074119;5744.1044455330475;5786.797462088806;5808.361080281081;5733.598648094593;5738.655680659173;5753.165790960204;5754.4175351778595;5756.453136951983;5655.971720141373;5773.393793651606;5835.328937172279;5871.794487192928;5892.322382926019;5688.317401911797;5708.628939118944;5716.885662286648;5718.25662663851;5721.57088218377 03:24:00 INFO - PROCESS | 10771 | |5;yui.html;719.1549928833623;765.7702689193244;801.5671537369814;828.1180542722001;834.3492076180579;15707.450239241629;16865.156742162904;17020.319187232497;17055.31778728851;17056.061916594583;13736.038477306567;13812.516561920334;13830.792538111911;13910.652233694163;13962.162270263765;734;752.8080339513443;859.7119964811795;879.226280872831;895.5298468304127;870.6734974384606;890.8307421589909;891.3582220801013;891.545311890937;891.79488717595;938.7653086728318;941.2893265584474;941.7551436626492;942.4863449420083;942.8868535775682;763.9923600764005;784.6233807772244;881.0484676549376;932.6782260120282;934.7709811096291;659.6833519910422;660.4452260101538;663.9103720997651;664.3024823934849;664.4219529009744;15376.461823836113;15418.614534636723;15422.151781652005;15451.922740386339;15455.768163477556;15263.313150908236;15321.923390382977;15638.374465021385;15642.68714625701;15799.289031993472;13628.318584070757;14090.436382544685;14328.92835535826;14543.022025200264;14612.19632920189;4576.130535198302;4577.29051996941;4612.100640375128;4663.463701674317;4763.64272679547;87931.56034219851;88103.99999999936;89239;89638.55180724054;89667;11678.70803229926;11794.52821887115;12016.63950081499;12022.278663280056;12365.07261955357;23163.589880793166;24136.396590085038;24192.274231772724;24193.51612967766;24211.152609658577;8582.399232053696;8718.215360617574;9129.360944733939;9235.630574777068;9487.762805929908;5007.899842003212;5021.874453138627;5095.439501654815;5131.5638170755155;5209;3660.670539651444;3765.3787125124595;3789.3936970084656;3794.7912864792147;3801.657850793442;655.2955572759303;664.9168853893264;667.1293961380348;676.2426082787309;684.698732557673;637.7735903754101;693.9236683964759;699.3775539769609;724.6630316902665;736.2894806511742;9548.761280967892;9753.414795112174;10084.546195421224;10148.746281342877;10551.47242637865;626.295417655138;671.8689855478135;702.9191642961023;708.4615692074061;742.9888551671729;4342.174986752507;4395.560443955579;4428.357888106271;4513.842015529441;4596.705976016294;120183.79816201726;124211.3789431047;130402;133068.3346583261;133345;64430.677846611405;65524;67182.32817671761;99347.50326248322;109319;59931;60492;75183;90972.54513727389;91515;7977.920220797718;8021.157778433414;8309.916900831156;8377.95811020941;8449.788755281168;40997.1800563993;50419.747901260256;56650.716746416;57571.71214143903;58246.70876645589;47279.763601181774;80735.59632201801;81901.59049204715;84561.57719211365;87126;11964.64106076819;12216.816747748968;12285;12417.44121514516;12565.685857853627;12656.810147847973;12671.493140274286;12924.418401171783;13049.478020879058;13558.525451609541;12451.190672606252;12721.300328482022;13014.414351354022;13043.413046412745;13050.738985220432;12024.27854328708;12292.692682683004;12365.134440589072;13300.401481933142;13602.727945441233;12850.742985140057;12921.870781292067;12927.676808079874;12940.8058879115;13350;11676;11738.76522469563;11849.348285844362;11915.582954596548;12416.317102559085;12187.51249949992;12859.614211573667;12974.156679815782;13026.934865325613;13211 03:24:00 INFO - PROCESS | 10771 | __end_tp_report 03:24:00 INFO - PROCESS | 10771 | __start_cc_report 03:24:00 INFO - PROCESS | 10771 | _x_x_mozilla_cycle_collect,888 03:24:00 INFO - PROCESS | 10771 | __end_cc_report 03:24:00 INFO - PROCESS | 10771 | __startTimestamp1474971840376__endTimestamp 03:24:00 INFO - PROCESS | 10771 | 03:24:00 INFO - PROCESS | 10771 | ------- Summary: start ------- 03:24:00 INFO - PROCESS | 10771 | Number of tests: 6 03:24:00 INFO - PROCESS | 10771 | 03:24:00 INFO - PROCESS | 10771 | [#0] dojo.html Cycles:165 Average:5563.05 Median:5778.13 stddev:639.91 (11.1%) stddev-sans-first:611.65 03:24:00 INFO - PROCESS | 10771 | Values: 3085.6 3115.8 3143.2 3160.9 3177.5 5581.2 5654.4 5668.1 5679.5 5687.6 5564.1 5621.7 5632.3 5651.7 5674.1 5057.3 5087.4 5110.8 5156.7 5182.5 5002.0 5119.7 5163.2 5171.4 5172.3 5005.3 5017.8 5050.4 5072.5 5118.3 5106.1 5130.4 5214.7 5218.2 5235.6 4855.0 5089.3 5113.7 5154.1 5178.4 5440.3 5446.4 5472.3 5486.5 5575.5 5883.6 5885.7 5976.5 5981.8 5982.6 5865.0 6015.0 6015.0 6026.1 6032.6 5525.1 5535.4 5574.5 5593.7 5608.5 6134.4 6142.5 6143.2 6144.8 6150.4 5710.2 5911.8 5913.6 5913.7 5917.7 5852.3 5899.4 5953.3 5968.3 6045.4 5975.4 5980.2 5981.1 5982.6 6010.8 5941.3 5950.0 5997.9 6001.4 6016.2 4513.8 4536.8 4564.4 4570.0 4626.9 4100.4 4108.4 4124.7 4129.3 4147.7 5740.9 5754.4 5757.0 5757.9 5763.0 5547.9 5854.6 5929.8 5931.7 6049.2 5713.2 5719.9 5747.3 5755.2 5782.0 5111.6 5118.0 5122.2 5125.4 5166.0 5959.5 6057.7 6088.8 6225.3 6236.7 5982.5 6028.0 6054.9 6073.7 6086.8 6098.7 6141.9 6164.2 6164.9 6193.1 5735.1 5749.9 5876.6 5928.8 5951.9 5971.0 6035.2 6055.4 6092.0 6120.9 5932.6 5933.4 5947.5 5949.1 5963.0 5637.9 5916.3 5933.1 5954.2 5954.8 5703.7 5778.1 5823.2 5845.2 5919.1 5906.7 5925.1 5935.6 5940.1 5941.9 5606.7 5674.9 5794.1 5797.0 5805.6 03:24:00 INFO - PROCESS | 10771 | 03:24:00 INFO - PROCESS | 10771 | [#1] ext.html Cycles:180 Average:69907.36 Median:41021.59 stddev:155628.18 (379.4%) stddev-sans-first:155977.73 03:24:00 INFO - PROCESS | 10771 | Values: 587.1 623.7 653.2 654.6 662.4 36800.6 40135.8 41020.6 41022.6 43934.6 47658.3 48050.0 48149.8 48169.0 48242.0 8408.2 9174.9 9306.0 9315.2 9342.2 8404.3 8666.4 8668.0 10978.7 11234.2 11381.0 11415.0 11418.7 11423.7 11453.7 11161.5 11220.1 11220.3 11246.3 11250.3 8295.8 8520.2 8522.2 8697.2 10437.9 42773.0 46340.8 46397.5 46437.3 46466.3 3789.3 3808.7 4007.6 4126.4 4294.3 33878.7 35076.8 35366.1 35522.5 36530.8 4664.2 4705.9 4728.6 4732.8 4813.4 367991.2 369727.2 369742.0 370407.0 371125.0 64492.0 64501.7 64583.0 64674.0 64722.0 68458.7 68488.3 68518.7 68550.7 68593.0 18273.5 19027.9 19115.5 19116.4 19133.8 13776.1 14769.9 14857.7 14892.4 14962.9 16963.7 18877.9 19109.9 19250.5 19349.3 6476.8 6550.0 6725.8 6743.2 6820.4 1061.5 1064.6 1109.9 1140.5 1142.7 33669.3 34505.7 34829.8 34833.3 34920.5 1109.9 1122.3 1175.2 1187.6 1202.7 17641.3 17738.7 17930.8 18016.6 18241.1 642508.0 657652.0 659014.0 1045790.0 1051476.0 64884.7 64896.7 65855.3 65863.7 65886.7 1355.1 1386.1 1413.9 1454.5 1463.2 32240.4 36119.6 36337.6 36398.8 36431.8 54374.0 54933.5 54949.0 54971.2 55076.7 410543.0 412681.7 412916.0 413026.0 414466.0 30973.2 31692.8 31735.7 31770.0 33036.3 51836.2 52268.0 52361.0 52897.5 52982.0 44857.0 45048.0 45841.3 45862.3 46862.5 43904.8 44998.3 45503.5 45930.8 46414.3 43759.6 44350.0 44772.6 44777.1 45002.8 37794.0 39822.8 39954.8 40366.6 40442.0 29775.7 29833.1 29841.3 30332.2 30360.5 03:24:00 INFO - PROCESS | 10771 | 03:24:00 INFO - PROCESS | 10771 | [#2] jquery.html Cycles:180 Average:30773.02 Median:21868.74 stddev:88399.74 (404.2%) stddev-sans-first:88618.29 03:24:00 INFO - PROCESS | 10771 | Values: 390.0 427.6 428.8 435.3 438.4 16767.9 19976.4 21774.1 21963.3 22050.1 13039.8 16650.8 18480.6 19004.2 19187.3 5484.7 5662.3 5662.6 5670.1 5670.9 4014.6 4341.7 4379.5 5596.5 6873.8 6949.1 6978.8 6983.5 6983.6 6989.1 6238.0 6263.7 6274.3 6277.4 6392.5 5897.9 6073.3 6079.6 6080.8 6083.5 15019.1 15116.5 15141.5 15278.8 15284.0 2460.6 2477.5 2531.8 2570.3 3056.8 10329.2 11373.3 11516.3 11561.8 11588.9 2015.7 2019.3 2040.6 2070.3 2096.9 78595.0 87304.6 88872.6 89119.6 90080.0 10579.4 10853.2 11129.5 11477.4 12072.3 15871.0 15994.8 16889.2 16904.7 17476.8 8901.6 8942.7 9072.5 9145.8 9163.6 8633.2 8658.4 8663.1 8842.1 8888.2 5035.1 5071.7 5101.3 5146.3 5324.1 2063.6 2065.0 2071.8 2137.6 2154.6 937.3 1002.7 1015.1 1037.4 1061.4 20396.9 20507.9 20649.2 21031.9 21088.5 1016.7 1031.5 1044.5 1047.9 1075.3 10894.0 11638.6 11765.5 11856.5 11869.1 529577.0 533452.0 534897.0 537071.0 544613.0 94320.0 97731.5 97984.5 98706.0 100763.0 1008.5 1058.3 1058.9 1072.6 1085.4 18175.7 18236.3 18636.3 18849.3 19300.0 43868.8 43927.3 44394.0 44998.8 45583.5 60851.7 61934.4 62764.0 63068.7 63830.0 8392.8 8565.4 8759.5 8762.5 8774.3 9364.4 12450.6 12460.6 12490.0 13590.1 11064.2 11203.1 11208.0 11362.6 11386.3 10917.1 10948.9 11199.4 11312.5 11336.0 10601.2 11470.1 11638.1 11689.0 12021.2 8534.1 8739.3 8801.2 8900.2 9052.2 8592.7 10198.8 10945.8 11267.2 11590.9 03:24:00 INFO - PROCESS | 10771 | 03:24:00 INFO - PROCESS | 10771 | [#3] mootools.html Cycles:180 Average:5805.88 Median:4911.16 stddev:3219.73 (65.6%) stddev-sans-first:3211.78 03:24:00 INFO - PROCESS | 10771 | Values: 1405.7 1502.2 1525.2 1676.4 1841.3 7601.7 8566.7 8774.4 8781.1 9050.6 8755.7 8897.6 8899.7 8903.1 8917.2 2461.9 2485.6 2487.5 2487.8 2490.9 2429.3 2485.9 2487.2 2489.3 2491.6 2448.7 2456.0 2479.7 2493.0 2499.9 2360.8 2376.1 2384.0 2436.8 2443.6 2385.8 2409.8 2421.6 2423.4 2432.3 8250.8 8494.6 8727.6 8884.6 8886.6 5302.2 5459.2 5465.3 5470.0 5475.7 3505.9 3521.6 3541.5 3549.3 3567.2 1273.5 1275.9 1278.8 1300.3 1319.5 12063.2 12095.8 12106.2 12131.5 12182.7 4430.3 4684.7 4717.2 4816.0 4823.1 9631.8 9641.7 9643.2 9652.0 9671.8 5275.4 5275.7 5283.7 5292.3 5292.8 4438.7 4567.5 4789.6 4863.2 4959.1 3977.9 4036.2 4124.4 4135.6 4155.8 1280.9 1282.3 1283.4 1298.9 1318.4 840.0 889.0 899.5 930.0 947.4 6018.1 6022.7 6044.7 6118.7 6194.6 990.7 1013.1 1024.7 1041.5 1043.2 4070.3 4183.0 4214.9 4323.4 4343.6 10852.3 10970.2 11106.8 11107.4 11121.4 10995.9 11000.9 11006.8 11025.6 11026.2 7611.1 7917.2 7920.0 8248.4 8378.4 6113.4 6140.2 6179.7 6200.8 6383.4 9982.2 9989.5 10114.4 10140.5 10147.8 10320.0 10465.2 10496.4 10501.9 10506.3 7234.7 7393.7 7467.1 7705.1 7847.9 7986.9 8297.4 8299.6 8302.6 8308.2 7383.0 7530.7 7592.5 7626.5 7742.7 7180.5 7323.9 7324.2 7503.8 7573.2 6794.8 6802.6 6836.2 6836.6 6849.0 5014.8 5155.5 5176.9 5192.5 5239.9 5153.1 5221.9 5225.3 5290.4 5401.0 03:24:00 INFO - PROCESS | 10771 | 03:24:00 INFO - PROCESS | 10771 | [#4] prototype.html Cycles:180 Average:4845.09 Median:5487.16 stddev:1419.93 (25.9%) stddev-sans-first:1383.03 03:24:00 INFO - PROCESS | 10771 | Values: 338.1 339.6 346.8 347.5 348.0 5527.2 5560.3 5575.7 5590.3 5616.4 5482.8 5491.5 5519.5 5521.3 5523.0 3911.7 4143.5 4215.2 4216.9 4238.8 4299.6 4306.7 4312.6 4313.9 4316.8 4291.4 4293.2 4293.2 4294.8 4297.8 4041.6 4153.8 4328.3 4337.6 4351.2 3792.8 3797.3 3805.6 3831.8 3848.5 5393.4 5397.5 5398.2 5441.9 5464.0 4797.0 4928.4 4961.9 4963.6 5011.3 5734.1 5742.0 5747.7 5748.7 5793.5 4245.3 4258.3 4274.9 4279.2 4285.5 5831.9 5931.7 5938.8 6078.3 6080.9 4196.3 4205.6 4221.9 4227.2 4232.7 4268.0 4273.0 4276.7 4298.5 4314.6 4756.9 4935.6 4936.9 4937.4 4986.9 5728.3 5736.3 5759.2 5803.5 5818.4 1478.1 1508.7 1510.1 1510.7 1513.7 934.8 987.1 987.3 989.0 1003.7 4994.5 5002.8 5005.7 5006.5 5078.6 5179.8 5210.0 5235.0 5253.3 5272.3 4990.9 5025.4 5040.4 5225.3 5729.9 3142.3 3182.8 3183.7 3190.8 3203.8 6037.6 6196.6 6200.7 6225.3 6237.1 5841.4 6048.6 6050.3 6081.8 6086.8 5972.0 6033.7 6078.0 6090.9 6128.9 5948.8 5959.5 5980.3 5997.1 6017.8 5728.6 5919.6 5924.2 5950.2 5954.2 6183.9 6188.3 6205.0 6211.6 6227.9 4156.8 4321.4 4402.0 4405.7 4447.6 5892.4 5963.5 5969.5 5972.6 6013.0 5832.8 5864.2 5877.1 5914.8 5945.5 5663.5 5726.9 5744.1 5786.8 5808.4 5733.6 5738.7 5753.2 5754.4 5756.5 5656.0 5773.4 5835.3 5871.8 5892.3 5688.3 5708.6 5716.9 5718.3 5721.6 03:24:00 INFO - PROCESS | 10771 | 03:24:00 INFO - PROCESS | 10771 | [#5] yui.html Cycles:180 Average:20989.81 Median:4587.00 stddev:30630.10 (667.8%) stddev-sans-first:30678.21 03:24:00 INFO - PROCESS | 10771 | Values: 719.2 765.8 801.6 828.1 834.3 15707.5 16865.2 17020.3 17055.3 17056.1 13736.0 13812.5 13830.8 13910.7 13962.2 734.0 752.8 859.7 879.2 895.5 870.7 890.8 891.4 891.5 891.8 938.8 941.3 941.8 942.5 942.9 764.0 784.6 881.0 932.7 934.8 659.7 660.4 663.9 664.3 664.4 15376.5 15418.6 15422.2 15451.9 15455.8 15263.3 15321.9 15638.4 15642.7 15799.3 13628.3 14090.4 14328.9 14543.0 14612.2 4576.1 4577.3 4612.1 4663.5 4763.6 87931.6 88104.0 89239.0 89638.6 89667.0 11678.7 11794.5 12016.6 12022.3 12365.1 23163.6 24136.4 24192.3 24193.5 24211.2 8582.4 8718.2 9129.4 9235.6 9487.8 5007.9 5021.9 5095.4 5131.6 5209.0 3660.7 3765.4 3789.4 3794.8 3801.7 655.3 664.9 667.1 676.2 684.7 637.8 693.9 699.4 724.7 736.3 9548.8 9753.4 10084.5 10148.7 10551.5 626.3 671.9 702.9 708.5 743.0 4342.2 4395.6 4428.4 4513.8 4596.7 120183.8 124211.4 130402.0 133068.3 133345.0 64430.7 65524.0 67182.3 99347.5 109319.0 59931.0 60492.0 75183.0 90972.5 91515.0 7977.9 8021.2 8309.9 8378.0 8449.8 40997.2 50419.7 56650.7 57571.7 58246.7 47279.8 80735.6 81901.6 84561.6 87126.0 11964.6 12216.8 12285.0 12417.4 12565.7 12656.8 12671.5 12924.4 13049.5 13558.5 12451.2 12721.3 13014.4 13043.4 13050.7 12024.3 12292.7 12365.1 13300.4 13602.7 12850.7 12921.9 12927.7 12940.8 13350.0 11676.0 11738.8 11849.3 11915.6 12416.3 12187.5 12859.6 12974.2 13026.9 13211.0 03:24:00 INFO - PROCESS | 10771 | -------- Summary: end -------- 03:24:00 INFO - PROCESS | 10771 | 03:24:01 INFO - TEST-INFO | 10771: exit 0 03:24:01 INFO - TEST-OK | dromaeo_css | took 1113933ms 03:24:01 INFO - TEST-START | kraken 03:24:01 INFO - operating with platform_type : linux_ 03:24:01 INFO - Initialising browser for kraken test... 03:24:01 INFO - TEST-INFO | started process 11091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqQ7dGt/profile http://localhost:54548/getInfo.html) 03:24:05 INFO - PROCESS | 11091 | __metrics Screen width/height:1600/1200 03:24:05 INFO - PROCESS | 11091 | colorDepth:24 03:24:05 INFO - PROCESS | 11091 | Browser inner width/height: 1024/697 03:24:05 INFO - PROCESS | 11091 | __metrics 03:24:05 INFO - PROCESS | 11091 | 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" 03:24:05 INFO - PROCESS | 11091 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:24:06 INFO - PROCESS | 11091 | console.error: PushService: 03:24:06 INFO - PROCESS | 11091 | stateChangeProcessEnqueue: Error transitioning state 03:24:06 INFO - PROCESS | 11091 | UnknownError 03:24:06 INFO - TEST-INFO | 11091: exit 0 03:24:06 INFO - Browser initialized. 03:24:06 INFO - Running cycle 1/1 for kraken test... 03:24:06 INFO - TEST-INFO | started process 11185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqQ7dGt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:18 INFO - PROCESS | 11185 | RSS: Main: 144089088 03:24:18 INFO - PROCESS | 11185 | 03:24:21 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54548/tests/kraken/driver.html?testName=audio-beat-detection) 03:24:22 INFO - PROCESS | 11185 | RSS: Main: 186200064 03:24:22 INFO - PROCESS | 11185 | 03:24:24 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54548/tests/kraken/driver.html?testName=audio-dft) 03:24:25 INFO - PROCESS | 11185 | RSS: Main: 174739456 03:24:25 INFO - PROCESS | 11185 | 03:24:27 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54548/tests/kraken/driver.html?testName=audio-fft) 03:24:28 INFO - PROCESS | 11185 | RSS: Main: 266543104 03:24:28 INFO - PROCESS | 11185 | 03:24:30 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54548/tests/kraken/driver.html?testName=audio-oscillator) 03:24:31 INFO - PROCESS | 11185 | RSS: Main: 172576768 03:24:31 INFO - PROCESS | 11185 | 03:24:33 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54548/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:24:33 INFO - PROCESS | 11185 | RSS: Main: 173785088 03:24:33 INFO - PROCESS | 11185 | 03:24:36 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54548/tests/kraken/driver.html?testName=imaging-darkroom) 03:24:37 INFO - PROCESS | 11185 | RSS: Main: 210296832 03:24:37 INFO - PROCESS | 11185 | 03:24:40 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54548/tests/kraken/driver.html?testName=imaging-desaturate) 03:24:41 INFO - PROCESS | 11185 | RSS: Main: 209735680 03:24:41 INFO - PROCESS | 11185 | 03:24:44 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54548/tests/kraken/driver.html?testName=json-parse-financial) 03:24:44 INFO - PROCESS | 11185 | RSS: Main: 209149952 03:24:44 INFO - PROCESS | 11185 | 03:24:46 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54548/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:24:46 INFO - PROCESS | 11185 | RSS: Main: 170876928 03:24:46 INFO - PROCESS | 11185 | 03:24:48 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54548/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:24:49 INFO - PROCESS | 11185 | RSS: Main: 179036160 03:24:49 INFO - PROCESS | 11185 | 03:24:51 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54548/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:24:51 INFO - PROCESS | 11185 | RSS: Main: 183803904 03:24:51 INFO - PROCESS | 11185 | 03:24:54 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:24:54 INFO - PROCESS | 11185 | RSS: Main: 183668736 03:24:54 INFO - PROCESS | 11185 | 03:24:57 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:24:58 INFO - PROCESS | 11185 | RSS: Main: 181968896 03:24:58 INFO - PROCESS | 11185 | 03:24:59 INFO - PROCESS | 11185 | Cycle 1(1): loaded http://localhost:54548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54548/tests/kraken/driver.html?testName=ai-astar) 03:25:00 INFO - PROCESS | 11185 | RSS: Main: 233660416 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | __start_tp_report 03:25:00 INFO - PROCESS | 11185 | _x_x_mozilla_page_load 03:25:00 INFO - PROCESS | 11185 | _x_x_mozilla_page_load_details 03:25:00 INFO - PROCESS | 11185 | |i|pagename|runs| 03:25:00 INFO - PROCESS | 11185 | |0;ai-astar;111;112;112;112;112;112;112;112;111;112 03:25:00 INFO - PROCESS | 11185 | |1;audio-beat-detection;147;124;117;150;121;116;118;121;156;116 03:25:00 INFO - PROCESS | 11185 | |2;audio-dft;160;161;161;161;161;160;162;163;162;163 03:25:00 INFO - PROCESS | 11185 | |3;audio-fft;75;76;75;119;76;75;75;76;97;74 03:25:00 INFO - PROCESS | 11185 | |4;audio-oscillator;82;81;112;82;81;82;99;82;82;107 03:25:00 INFO - PROCESS | 11185 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;117;116 03:25:00 INFO - PROCESS | 11185 | |6;imaging-darkroom;146;146;145;145;147;146;146;146;146;146 03:25:00 INFO - PROCESS | 11185 | |7;imaging-desaturate;94;95;95;95;95;94;95;95;95;95 03:25:00 INFO - PROCESS | 11185 | |8;json-parse-financial;52;50;51;51;50;53;51;51;50;49 03:25:00 INFO - PROCESS | 11185 | |9;json-stringify-tinderbox;59;58;59;58;59;59;59;59;59;60 03:25:00 INFO - PROCESS | 11185 | |10;stanford-crypto-aes;73;74;74;81;72;73;78;79;80;81 03:25:00 INFO - PROCESS | 11185 | |11;stanford-crypto-ccm;122;122;116;127;117;115;118;119;155;137 03:25:00 INFO - PROCESS | 11185 | |12;stanford-crypto-pbkdf2;153;154;150;155;150;151;153;155;150;156 03:25:00 INFO - PROCESS | 11185 | |13;stanford-crypto-sha256-iterative;64;62;61;61;61;61;63;61;60;60 03:25:00 INFO - PROCESS | 11185 | __end_tp_report 03:25:00 INFO - PROCESS | 11185 | __start_cc_report 03:25:00 INFO - PROCESS | 11185 | _x_x_mozilla_cycle_collect,1620 03:25:00 INFO - PROCESS | 11185 | __end_cc_report 03:25:00 INFO - PROCESS | 11185 | __startTimestamp1474971900015__endTimestamp 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | ------- Summary: start ------- 03:25:00 INFO - PROCESS | 11185 | Number of tests: 14 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:25:00 INFO - PROCESS | 11185 | Values: 111.0 112.0 112.0 112.0 112.0 112.0 112.0 112.0 111.0 112.0 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:122.50 stddev:15.81 (12.9%) stddev-sans-first:15.30 03:25:00 INFO - PROCESS | 11185 | Values: 147.0 124.0 117.0 150.0 121.0 116.0 118.0 121.0 156.0 116.0 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 03:25:00 INFO - PROCESS | 11185 | Values: 160.0 161.0 161.0 161.0 161.0 160.0 162.0 163.0 162.0 163.0 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:14.76 (19.6%) stddev-sans-first:15.45 03:25:00 INFO - PROCESS | 11185 | Values: 75.0 76.0 75.0 119.0 76.0 75.0 75.0 76.0 97.0 74.0 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:82.00 stddev:12.14 (14.8%) stddev-sans-first:12.61 03:25:00 INFO - PROCESS | 11185 | Values: 82.0 81.0 112.0 82.0 81.0 82.0 99.0 82.0 82.0 107.0 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:25:00 INFO - PROCESS | 11185 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:25:00 INFO - PROCESS | 11185 | Values: 146.0 146.0 145.0 145.0 147.0 146.0 146.0 146.0 146.0 146.0 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:25:00 INFO - PROCESS | 11185 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:1.14 (2.2%) stddev-sans-first:1.12 03:25:00 INFO - PROCESS | 11185 | Values: 52.0 50.0 51.0 51.0 50.0 53.0 51.0 51.0 50.0 49.0 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 03:25:00 INFO - PROCESS | 11185 | Values: 59.0 58.0 59.0 58.0 59.0 59.0 59.0 59.0 59.0 60.0 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:78.50 stddev:3.63 (4.6%) stddev-sans-first:3.62 03:25:00 INFO - PROCESS | 11185 | Values: 73.0 74.0 74.0 81.0 72.0 73.0 78.0 79.0 80.0 81.0 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:122.00 stddev:12.45 (10.2%) stddev-sans-first:13.17 03:25:00 INFO - PROCESS | 11185 | Values: 122.0 122.0 116.0 127.0 117.0 115.0 118.0 119.0 155.0 137.0 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.70 Median:153.50 stddev:2.31 (1.5%) stddev-sans-first:2.45 03:25:00 INFO - PROCESS | 11185 | Values: 153.0 154.0 150.0 155.0 150.0 151.0 153.0 155.0 150.0 156.0 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - PROCESS | 11185 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.00 stddev:1.26 (2.1%) stddev-sans-first:0.93 03:25:00 INFO - PROCESS | 11185 | Values: 64.0 62.0 61.0 61.0 61.0 61.0 63.0 61.0 60.0 60.0 03:25:00 INFO - PROCESS | 11185 | -------- Summary: end -------- 03:25:00 INFO - PROCESS | 11185 | 03:25:00 INFO - TEST-INFO | 11185: exit 0 03:25:01 INFO - TEST-OK | kraken | took 59840ms 03:25:01 INFO - SUITE-END | took 1173s 03:25:01 INFO - Completed test suite (00:19:33) 03:25:01 INFO - javascript benchmark 03:25:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3085.6297244330676, 3115.8442077896098, 3143.2141964508887, 3160.88936887209, 3177.4916013437855, 5581.246531718222, 5654.406287339832, 5668.064769313063, 5679.460451257134, 5687.6303040302355, 5564.081926482136, 5621.690807005613, 5632.26780518532, 5651.660900345972, 5674.148877668352, 5057.317262169597, 5087.389513258396, 5110.795568177268, 5156.664816786897, 5182.533571978521, 5002.049610573998, 5119.744012799364, 5163.173892177252, 5171.431142574333, 5172.250023746555, 5005.274235235888, 5017.8243761468175, 5050.419201791786, 5072.543471087602, 5118.309028281172, 5106.08090543702, 5130.435652078287, 5214.687118772886, 5218.165093585008, 5235.6073294502685, 4854.951450485485, 5089.338386009795, 5113.7443127843835, 5154.149565321717, 5178.378594568639, 5440.347158340985, 5446.400895901447, 5472.26124473195, 5486.451354864482, 5575.498205161514, 5883.6469811811, 5885.676287804169, 5976.521878249773, 5981.820545383645, 5982.641041537521, 5865.032269675498, 6014.96992515039, 6015.0, 6026.126211699323, 6032.607880487754, 5525.060739674265, 5535.391106978229, 5574.498295153415, 5593.74828132735, 5608.467195616491, 6134.4172303631085, 6142.477889379453, 6143.170671959318, 6144.78493252734, 6150.446459818549, 5710.229119068956, 5911.793087241926, 5913.586048976616, 5913.733881975321, 5917.6745279010065, 5852.297724273115, 5899.380565040695, 5953.3451320354725, 5968.283805943314, 6045.3652366501765, 5975.4024597540765, 5980.162777211194, 5981.132735753292, 5982.581219314607, 6010.759569617167, 5941.346451890288, 5950.047992321294, 5997.910031349533, 6001.399860013964, 6016.157737916695, 4513.81944722214, 4536.79584418702, 4564.406627138451, 4569.954300456953, 4626.884327891829, 4100.425940368351, 4108.383742438598, 4124.670026397881, 4129.339305711072, 4147.730397524151, 5740.942590574041, 5754.367019627837, 5757.0, 5757.8560535986935, 5763.0, 5547.944520554743, 5854.619449735754, 5929.792457263975, 5931.673757943268, 6049.213602231682, 5713.22871412354, 5719.885602287931, 5747.281589801275, 5755.165501002331, 5782.0, 5111.642185047085, 5118.001989612065, 5122.1804511278015, 5125.384953805493, 5165.992631436834, 5959.4934430573885, 6057.666828324484, 6088.786892458654, 6225.252969643671, 6236.688165591702, 5982.46157845796, 6028.0355143176885, 6054.90917636227, 6073.665948372882, 6086.847828804315, 6098.664573448503, 6141.877162456636, 6164.198654174928, 6164.938350616437, 6193.071039344134, 5735.11105778605, 5749.91375129365, 5876.559258055578, 5928.762849485972, 5951.940480595139, 5970.9701451492465, 6035.185249991195, 6055.424734650202, 6092.0, 6120.938790612036, 5932.614380065282, 5933.406659334032, 5947.524198064058, 5949.137375080502, 5963.0, 5637.88724225505, 5916.290045194604, 5933.05071188625, 5954.225950626391, 5954.791582294599, 5703.686297253691, 5778.133280008033, 5823.213866128019, 5845.240118784531, 5919.082542205965, 5906.734196961061, 5925.081612350093, 5935.584509084495, 5940.138679891478, 5941.851453713692, 5606.691631960118, 5674.886502269849, 5794.1308803679785, 5796.985527532581, 5805.593608447368], "value": 5518.619575855703, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.0988033368777, 623.7442648514109, 653.199830207995, 654.5614438326322, 662.3674390956637, 36800.63199368006, 40135.79932100339, 41020.58979410205, 41022.58977410232, 43934.56065439345, 47658.285125723145, 48050.0, 48149.75925120378, 48169.0, 48242.0, 8408.201220884006, 9174.908250917471, 9305.97634260231, 9315.208207302387, 9342.159205671489, 8404.28563572094, 8666.393352465298, 8667.95984481863, 10978.725531861688, 11234.157438192127, 11381.032612227971, 11415.0, 11418.71453213668, 11423.714407139805, 11453.713657158596, 11161.497732602013, 11220.102391808636, 11220.270682405617, 11246.268992515501, 11250.324980501115, 8295.751127466187, 8520.19058189471, 8522.190391912758, 8697.173768491983, 10437.851836298001, 42773.0, 46340.76829615864, 46397.53602463966, 46437.30344044842, 46466.303005454945, 3789.280036793028, 3808.7143464240294, 4007.6192761687885, 4126.360414135814, 4294.291441912081, 33878.66121338804, 35076.82461587676, 35366.11584710377, 35522.46716299257, 36530.8173459131, 4664.183767840648, 4705.929411058837, 4728.621710263171, 4732.810687572493, 4813.3983252093485, 367991.1600442007, 369727.1513642442, 369742.0, 370407.0, 371125.0, 64492.0, 64501.677491612245, 64583.0, 64674.0, 64722.0, 68458.65770671115, 68488.31511684919, 68518.65740671265, 68550.65724671345, 68593.0, 18273.543161421072, 19027.904860475886, 19115.522111947314, 19116.426507204807, 19133.8086619132, 13776.10455320401, 14769.852301476847, 14857.70284594302, 14892.404303827941, 14962.92518537422, 16963.74554381685, 18877.90561047186, 19109.904450477938, 19250.518737031685, 19349.322773702854, 6476.805695829133, 6549.967250163814, 6725.831854203586, 6743.1908171019795, 6820.3861652451515, 1061.4533515239657, 1064.595453727594, 1109.8834622364698, 1140.520981187903, 1142.6971852459105, 33669.32661346808, 34505.654943450245, 34829.825850870584, 34833.30333393368, 34920.476192857124, 1109.8834622364536, 1122.2537012886503, 1175.189119507537, 1187.5724739093919, 1202.675277675023, 17641.294348226184, 17738.65336658354, 17930.80091442016, 18016.631351697044, 18241.087945602667, 642508.0, 657652.0, 659014.0, 1045790.0, 1051476.0, 64884.67557662181, 64896.67551662211, 65855.34144658588, 65863.67068164628, 65886.67056664686, 1355.1394864261265, 1386.0851837787013, 1413.8939579531577, 1454.549089782171, 1463.217178809332, 32240.35519289648, 36119.638803611626, 36337.63662363343, 36398.8180059098, 36431.817840910626, 54374.0, 54933.450665492834, 54949.0, 54971.175432367745, 55076.72461637666, 410543.0, 412681.74636507704, 412916.0, 413026.0, 414466.0, 30973.225669358446, 31692.841535793097, 31735.682643173273, 31770.04689859308, 33036.33927321488, 51836.22245666243, 52268.0, 52361.0, 52897.4710252908, 52982.0, 44857.0, 45048.0, 45841.312380313655, 45862.31206531838, 46862.531374685816, 43904.78047609742, 44998.325025125305, 45503.54496454993, 45930.770346149395, 46414.30378544257, 43759.562404375545, 44350.0, 44772.55227447684, 44777.10445791131, 45002.77498612486, 37794.0, 39822.800885995384, 39954.80022599868, 40366.59633403629, 40442.0, 29775.70224297729, 29833.11606245418, 29841.25396865096, 30332.24169395783, 30360.544591830698], "value": 21926.669276355926, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.98830035098956, 427.62762762762765, 428.824182085345, 435.32741913743274, 438.3665603203368, 16767.916160419198, 19976.400707978748, 21774.12903483863, 21963.341099766993, 22050.11799528019, 13039.80440293394, 16650.834441589093, 18480.630387392277, 19004.2398304068, 19187.32844350448, 5484.698341591211, 5662.348829884554, 5662.631928924607, 5670.121131224667, 5670.943290567104, 4014.5784692607294, 4341.739495630257, 4379.540148284432, 5596.468335508121, 6873.759418420356, 6949.096617439725, 6978.825529361781, 6983.4762392820485, 6983.615901125436, 6989.091418115638, 6238.0, 6263.655498947556, 6274.309825919146, 6277.435030847223, 6392.520560957923, 5897.941020589782, 6073.271207455089, 6079.635221886657, 6080.817575472743, 6083.48290395317, 15019.098854068681, 15116.470923517623, 15141.545753627408, 15278.847211527853, 15284.0, 2460.5817011108156, 2477.529269438819, 2531.772140507363, 2570.318865500644, 3056.7860249782525, 10329.225308101923, 11373.260738052082, 11516.251443656136, 11561.76876462466, 11588.88411115895, 2015.6875684268962, 2019.2831544801677, 2040.6428874946826, 2070.3478404302746, 2096.899127957819, 78595.0, 87304.56347718285, 88872.5556372214, 89119.55440222757, 90080.0, 10579.418132002813, 10853.186011049045, 11129.499172537255, 11477.426128693533, 12072.275663460221, 15871.0, 15994.840051599567, 16889.15554222284, 16904.66190676204, 17476.825231747775, 8901.554922253861, 8942.687005954891, 9072.54637268134, 9145.77135571616, 9163.58763855628, 8633.223009929137, 8658.350623703122, 8663.133686631412, 8842.115788421106, 8888.24449921751, 5035.144025515671, 5071.695698258116, 5101.285819985205, 5146.330976972969, 5324.148136298174, 2063.585019901335, 2064.9690254646193, 2071.819063133999, 2137.6259154647873, 2154.601398741238, 937.3110763588757, 1002.6941782756184, 1015.0864222200079, 1037.3983089807894, 1061.389700921973, 20396.89801550983, 20507.897460512602, 20649.17403303851, 21031.8948405257, 21088.472788180112, 1016.654337525245, 1031.489412740683, 1044.4829809244472, 1047.8742550893942, 1075.3171735947574, 10894.0, 11638.556017837946, 11765.470553824927, 11856.466459009365, 11869.109816763777, 529577.0, 533452.0, 534897.0, 537071.0, 544613.0, 94320.0, 97731.51134244283, 97984.51007744916, 98706.0, 100763.0, 1008.505832142245, 1058.2645061682058, 1058.8517607534952, 1072.5924148823397, 1085.365061439067, 18175.727364089285, 18236.270549177883, 18636.34772783, 18849.324381745428, 19300.0, 43868.78065609779, 43927.34108988304, 44394.0, 44998.77500612476, 45583.54416455793, 60851.695741521005, 61934.38065619466, 62764.0, 63068.68465657642, 63830.0, 8392.832143356976, 8565.443246188977, 8759.474431534129, 8762.518061506424, 8774.298056155365, 9364.391314564531, 12450.564230251897, 12460.563880264148, 12490.000799935802, 13590.116642418212, 11064.22550421495, 11203.103751699682, 11208.0, 11362.602308919479, 11386.259893106922, 10917.072048875934, 10948.945255273673, 11199.384033877888, 11312.490937907978, 11336.0, 10601.204909631655, 11470.139739519402, 11638.12714046433, 11689.0, 12021.218620789621, 8534.103919088406, 8739.344549158712, 8801.207891289814, 8900.154485323885, 9052.185303322733, 8592.742217733477, 10198.847017294598, 10945.781084378426, 11267.154963377943, 11590.94204528972], "value": 9479.813498247613, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.7399381114487, 1502.1888180382591, 1525.153539785419, 1676.3881183368073, 1841.3463220556703, 7601.657925393357, 8566.657333706653, 8774.385792994493, 8781.077986811388, 9050.637974481013, 8755.737327880173, 8897.555122243893, 8899.733008009754, 8903.065178156297, 8917.242034427081, 2461.876906154694, 2485.6147297168877, 2487.502499500098, 2487.751224877507, 2490.850548967068, 2429.344077099182, 2485.8508489490687, 2487.216526794063, 2489.253224032792, 2491.5888878335145, 2448.7428819973825, 2456.0421435640114, 2479.727230004698, 2493.0401795308844, 2499.8875050622764, 2360.8229382796358, 2376.061455724988, 2383.9642405363934, 2436.780689737914, 2443.596806526921, 2385.8091352691745, 2409.7710717481987, 2421.588329983907, 2423.430493833948, 2432.282476669369, 8250.793730156794, 8494.617742201615, 8727.563621818883, 8884.555772211364, 8886.644534218623, 5302.151655735064, 5459.181122831607, 5465.262189604392, 5470.042742520043, 5475.7262136893, 3505.8597656093725, 3521.559805024372, 3541.5041894134843, 3549.2546565221332, 3567.165297305407, 1273.541525050981, 1275.8724127587168, 1278.8337516122845, 1300.2588524541015, 1319.4524272426931, 12063.155579109378, 12095.818562721566, 12106.152569320151, 12131.454084566127, 12182.695432614168, 4430.291153415438, 4684.718916864999, 4717.2216584263215, 4816.0, 4823.083614113307, 9631.759206019906, 9641.662541811003, 9643.180329672057, 9652.0, 9671.806563868824, 5275.393329767049, 5275.683458992396, 5283.735813209324, 5292.285541451932, 5292.8147514837565, 4438.7114837535455, 4567.451905771329, 4789.616830653539, 4863.221884498464, 4959.107360675113, 3977.8607748729232, 4036.1725846201457, 4124.4019617155345, 4135.58644135584, 4155.792210389468, 1280.8783165599252, 1282.3011458755002, 1283.36473445645, 1298.9415476303589, 1318.4264844792547, 840.0423517190408, 888.9777755556163, 899.5187574647663, 929.953502324881, 947.36999895069, 6018.067199584071, 6022.698865056817, 6044.727987240584, 6118.694065296718, 6194.5973511721595, 990.65327135502, 1013.1489548779061, 1024.6721049264313, 1041.5261056219401, 1043.2384359417667, 4070.287699652549, 4182.958170418317, 4214.852480163241, 4323.437953066082, 4343.630791382705, 10852.348859068481, 10970.177236707279, 11106.833397499044, 11107.38909359993, 11121.388323642277, 10995.890041099487, 11000.944995275133, 11006.834897476385, 11025.6141035065, 11026.173037022256, 7611.124720657084, 7917.208279172152, 7919.960400197962, 8248.381371397048, 8378.41351105429, 6113.358097399887, 6140.1710769047395, 6179.69101544912, 6200.782972595937, 6383.39357761012, 9982.201423885926, 9989.450580218157, 10114.443705596263, 10140.492975351055, 10147.79704405893, 10320.0, 10465.215108867018, 10496.422696751752, 10501.9474902625, 10506.317089389166, 7234.74678386254, 7393.704251829867, 7467.066616672916, 7705.075390953121, 7847.921520784719, 7986.920130798618, 8297.377696672653, 8299.585020749058, 8302.626381812954, 8308.210719981593, 7383.0, 7530.736424225126, 7592.468527203264, 7626.54240745557, 7742.729004484816, 7180.497365184387, 7323.8535229296185, 7324.194338622854, 7503.7748867534065, 7573.2048134947245, 6794.776940150623, 6802.557833740791, 6836.179658441019, 6836.623985680835, 6849.04113424131, 5014.7994080236385, 5155.5360017597095, 5176.896462070813, 5192.480751924777, 5239.87784947097, 5153.098207813543, 5221.895562088661, 5225.346831646044, 5290.391604965324, 5401.0], "value": 4702.7361224441565, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.12088569718736, 339.6382852262341, 346.7780620402942, 347.47184279894543, 348.032469734139, 5527.170924361343, 5560.332760068787, 5575.69333686647, 5590.329160500745, 5616.35411927628, 5482.780688772455, 5491.533219676322, 5519.475649813261, 5521.282233309674, 5522.972385138079, 3911.706622003347, 4143.52904718825, 4215.220184265905, 4216.948011111839, 4238.788060596973, 4299.591538803808, 4306.720063195882, 4312.568743125678, 4313.913721725564, 4316.784160791964, 4291.399204111427, 4293.22721910056, 4293.248681480744, 4294.806733696991, 4297.806598703066, 4041.605646052107, 4153.816162393703, 4328.329108988096, 4337.566243375684, 4351.173277077345, 3792.7534710243744, 3797.2785170817733, 3805.6194380561724, 3831.808409579538, 3848.5381754189675, 5393.433689462589, 5397.54120899724, 5398.24424580559, 5441.863953401196, 5463.972680136613, 4797.0, 4928.359313289249, 4961.8511444656715, 4963.6277279204205, 5011.348524691767, 5734.082546792535, 5742.0, 5747.741351639186, 5748.741306641211, 5793.507551858097, 4245.346658338538, 4258.318669012943, 4274.850380236708, 4279.186954478639, 4285.485741711014, 5831.9416805831825, 5931.703414829284, 5938.8218353449465, 6078.331383547807, 6080.908786368163, 4196.286631272691, 4205.558416366299, 4221.860097773584, 4227.154569086134, 4232.746035237896, 4268.0, 4272.957270427318, 4276.700630955803, 4298.495526565677, 4314.640888120232, 4756.904861902743, 4935.555799978019, 4936.876578085505, 4937.382827146606, 4986.8753281168265, 5728.283964504437, 5736.282964629421, 5759.164921086419, 5803.506701930299, 5818.4472475115645, 1478.113132120719, 1508.6530098077503, 1510.1392206442222, 1510.6676531163127, 1513.7426637471656, 934.8364036293622, 987.0918754745651, 987.3434166279487, 988.980220395588, 1003.6888564545014, 4994.500549944976, 5002.774875130628, 5005.724685142352, 5006.524380183877, 5078.568321692624, 5179.818706345335, 5209.973950130301, 5234.97382513085, 5253.264542963988, 5272.261883336336, 4990.8770526631215, 5025.447200807908, 5040.420351659606, 5225.346831646044, 5729.942700572941, 3142.308692087737, 3182.840857957093, 3183.7293830024246, 3190.760692948038, 3203.7917535360593, 6037.615142018965, 6196.628202307876, 6200.658963756947, 6225.252969643671, 6237.064440333987, 5841.4450627190345, 6048.5765996380715, 6050.27567143362, 6081.787137450168, 6086.786962456293, 5971.954303305346, 6033.698315084316, 6078.0, 6090.908636370369, 6128.908066379008, 5948.821535353946, 5959.4934430573885, 5980.312264089685, 5997.100434934795, 6017.849553761191, 5728.627639203439, 5919.644821310735, 5924.200232968667, 5950.19672344228, 5954.225950626565, 6183.89747485857, 6188.319284878569, 6205.0, 6211.596246243979, 6227.937720622917, 4156.750594964312, 4321.351797230441, 4401.987542865095, 4405.656274836206, 4447.6219521341045, 5892.410758924073, 5963.493103086286, 5969.462748352669, 5972.626295951868, 6012.969935150296, 5832.795852145155, 5864.208331875313, 5877.089051197071, 5914.792982245601, 5945.464908158287, 5663.546916246608, 5726.854629074119, 5744.1044455330475, 5786.797462088806, 5808.361080281081, 5733.598648094593, 5738.655680659173, 5753.165790960204, 5754.4175351778595, 5756.453136951983, 5655.971720141373, 5773.393793651606, 5835.328937172279, 5871.794487192928, 5892.322382926019, 5688.317401911797, 5708.628939118944, 5716.885662286648, 5718.25662663851, 5721.57088218377], "value": 4394.2856635113085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.1549928833623, 765.7702689193244, 801.5671537369814, 828.1180542722001, 834.3492076180579, 15707.450239241629, 16865.156742162904, 17020.319187232497, 17055.31778728851, 17056.061916594583, 13736.038477306567, 13812.516561920334, 13830.792538111911, 13910.652233694163, 13962.162270263765, 734.0, 752.8080339513443, 859.7119964811795, 879.226280872831, 895.5298468304127, 870.6734974384606, 890.8307421589909, 891.3582220801013, 891.545311890937, 891.79488717595, 938.7653086728318, 941.2893265584474, 941.7551436626492, 942.4863449420083, 942.8868535775682, 763.9923600764005, 784.6233807772244, 881.0484676549376, 932.6782260120282, 934.7709811096291, 659.6833519910422, 660.4452260101538, 663.9103720997651, 664.3024823934849, 664.4219529009744, 15376.461823836113, 15418.614534636723, 15422.151781652005, 15451.922740386339, 15455.768163477556, 15263.313150908236, 15321.923390382977, 15638.374465021385, 15642.68714625701, 15799.289031993472, 13628.318584070757, 14090.436382544685, 14328.92835535826, 14543.022025200264, 14612.19632920189, 4576.130535198302, 4577.29051996941, 4612.100640375128, 4663.463701674317, 4763.64272679547, 87931.56034219851, 88103.99999999936, 89239.0, 89638.55180724054, 89667.0, 11678.70803229926, 11794.52821887115, 12016.63950081499, 12022.278663280056, 12365.07261955357, 23163.589880793166, 24136.396590085038, 24192.274231772724, 24193.51612967766, 24211.152609658577, 8582.399232053696, 8718.215360617574, 9129.360944733939, 9235.630574777068, 9487.762805929908, 5007.899842003212, 5021.874453138627, 5095.439501654815, 5131.5638170755155, 5209.0, 3660.670539651444, 3765.3787125124595, 3789.3936970084656, 3794.7912864792147, 3801.657850793442, 655.2955572759303, 664.9168853893264, 667.1293961380348, 676.2426082787309, 684.698732557673, 637.7735903754101, 693.9236683964759, 699.3775539769609, 724.6630316902665, 736.2894806511742, 9548.761280967892, 9753.414795112174, 10084.546195421224, 10148.746281342877, 10551.47242637865, 626.295417655138, 671.8689855478135, 702.9191642961023, 708.4615692074061, 742.9888551671729, 4342.174986752507, 4395.560443955579, 4428.357888106271, 4513.842015529441, 4596.705976016294, 120183.79816201726, 124211.3789431047, 130402.0, 133068.3346583261, 133345.0, 64430.677846611405, 65524.0, 67182.32817671761, 99347.50326248322, 109319.0, 59931.0, 60492.0, 75183.0, 90972.54513727389, 91515.0, 7977.920220797718, 8021.157778433414, 8309.916900831156, 8377.95811020941, 8449.788755281168, 40997.1800563993, 50419.747901260256, 56650.716746416, 57571.71214143903, 58246.70876645589, 47279.763601181774, 80735.59632201801, 81901.59049204715, 84561.57719211365, 87126.0, 11964.64106076819, 12216.816747748968, 12285.0, 12417.44121514516, 12565.685857853627, 12656.810147847973, 12671.493140274286, 12924.418401171783, 13049.478020879058, 13558.525451609541, 12451.190672606252, 12721.300328482022, 13014.414351354022, 13043.413046412745, 13050.738985220432, 12024.27854328708, 12292.692682683004, 12365.134440589072, 13300.401481933142, 13602.727945441233, 12850.742985140057, 12921.870781292067, 12927.676808079874, 12940.8058879115, 13350.0, 11676.0, 11738.76522469563, 11849.348285844362, 11915.582954596548, 12416.317102559085, 12187.51249949992, 12859.614211573667, 12974.156679815782, 13026.934865325613, 13211.0], "value": 7740.20667807014, "unit": "score"}], "name": "dromaeo_css", "value": 7538.299397746004, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 117.0, 150.0, 121.0, 116.0, 118.0, 121.0, 156.0, 116.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 161.0, 160.0, 162.0, 163.0, 162.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 119.0, 76.0, 75.0, 75.0, 76.0, 97.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 112.0, 82.0, 81.0, 82.0, 99.0, 82.0, 82.0, 107.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 51.0, 50.0, 53.0, 51.0, 51.0, 50.0, 49.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 81.0, 72.0, 73.0, 78.0, 79.0, 80.0, 81.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 116.0, 127.0, 117.0, 115.0, 118.0, 119.0, 155.0, 137.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 150.0, 155.0, 150.0, 151.0, 153.0, 155.0, 150.0, 156.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 61.0, 61.0, 61.0, 61.0, 63.0, 61.0, 60.0, 60.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1455.1, "alertThreshold": 2.0}]} 03:25:01 INFO - Return code: 0 03:25:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:25:01 INFO - # TBPL SUCCESS # 03:25:01 INFO - Running post-action listener: _resource_record_post_action 03:25:01 INFO - [mozharness: 2016-09-27 10:25:01.301827Z] Finished run-tests step (success) 03:25:01 INFO - Running post-run listener: _resource_record_post_run 03:25:01 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 1994752; Write bytes: 357130240; Read time: 56; Write time: 194724 03:25:01 INFO - TinderboxPrint: CPU usage
12.9% 03:25:01 INFO - TinderboxPrint: I/O read bytes / time
1,994,752 / 56 03:25:01 INFO - TinderboxPrint: I/O write bytes / time
357,130,240 / 194,724 03:25:01 INFO - TinderboxPrint: CPU idle
8,268.4 (87.1%) 03:25:01 INFO - TinderboxPrint: CPU user
1,185.7 (12.5%) 03:25:01 INFO - TinderboxPrint: Swap in / out
0 / 0 03:25:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107307008; Read time: 0; Write time: 52536 03:25:01 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249823232; Read time: 20; Write time: 142188 03:25:01 INFO - Running post-run listener: _upload_blobber_files 03:25:01 INFO - Blob upload gear active. 03:25:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:25:01 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 03:25:01 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'] 03:25:01 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 03:25:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:25:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:25:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:25:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:06 INFO - (blobuploader) - INFO - Done attempting. 03:25:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:25:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:25:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:06 INFO - (blobuploader) - INFO - Done attempting. 03:25:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:25:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:25:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:07 INFO - (blobuploader) - INFO - Done attempting. 03:25:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:25:07 INFO - Return code: 0 03:25:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:25:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:25:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2fcdab66609e1c4b7f5d2c8a57bfa7313baa263cf5e6e31f6218a81bdb9ba5f5a3c05f1fd97ad39fb64f83e76ff2f90263615c1a3faeb6e0ad2121eabf4ac03b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0472938ca8ad2f65cae6968c7115d6475aab7bec90d7d2efade11edc838f6dbb49b015f8f71a0e75734d3ec70ff9c3c8975c0df7128beb485d0167a5277201f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a63949752eaa8e302d7380f36e3cdd015cd0863dd5d097f638ace1ffa950e87e8561d2f4c22d752ce4cd92afdf7aa50ef1d236d51c1c6e3d032abf960133b635"} 03:25:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:25:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:25:07 INFO - Contents: 03:25:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2fcdab66609e1c4b7f5d2c8a57bfa7313baa263cf5e6e31f6218a81bdb9ba5f5a3c05f1fd97ad39fb64f83e76ff2f90263615c1a3faeb6e0ad2121eabf4ac03b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0472938ca8ad2f65cae6968c7115d6475aab7bec90d7d2efade11edc838f6dbb49b015f8f71a0e75734d3ec70ff9c3c8975c0df7128beb485d0167a5277201f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a63949752eaa8e302d7380f36e3cdd015cd0863dd5d097f638ace1ffa950e87e8561d2f4c22d752ce4cd92afdf7aa50ef1d236d51c1c6e3d032abf960133b635"} 03:25:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:25:07 INFO - Copying logs to upload dir... 03:25:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:25:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.515010 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-09-27 03:25:06.829069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 03:25:06.833061) ========= 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=41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434 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/2fcdab66609e1c4b7f5d2c8a57bfa7313baa263cf5e6e31f6218a81bdb9ba5f5a3c05f1fd97ad39fb64f83e76ff2f90263615c1a3faeb6e0ad2121eabf4ac03b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0472938ca8ad2f65cae6968c7115d6475aab7bec90d7d2efade11edc838f6dbb49b015f8f71a0e75734d3ec70ff9c3c8975c0df7128beb485d0167a5277201f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a63949752eaa8e302d7380f36e3cdd015cd0863dd5d097f638ace1ffa950e87e8561d2f4c22d752ce4cd92afdf7aa50ef1d236d51c1c6e3d032abf960133b635"} build_url:https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/YkD-Kd_QTuikkP7SeQkMAw/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/2fcdab66609e1c4b7f5d2c8a57bfa7313baa263cf5e6e31f6218a81bdb9ba5f5a3c05f1fd97ad39fb64f83e76ff2f90263615c1a3faeb6e0ad2121eabf4ac03b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0472938ca8ad2f65cae6968c7115d6475aab7bec90d7d2efade11edc838f6dbb49b015f8f71a0e75734d3ec70ff9c3c8975c0df7128beb485d0167a5277201f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a63949752eaa8e302d7380f36e3cdd015cd0863dd5d097f638ace1ffa950e87e8561d2f4c22d752ce4cd92afdf7aa50ef1d236d51c1c6e3d032abf960133b635"}' ========= master_lag: 0.19 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 03:25:07.030098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:25:07.030472) ========= 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=41a7e32711b8e08598a63237000001d6-1474970550.628655-1875155434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:25:07.111756) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 03:25:07.112131) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 03:25:07.112458) ========= ========= Total master_lag: 0.46 =========